builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-026 starttime: 1483653601.94 results: success (0) buildid: 20170105122013 builduid: e19f4f90c178470ca462574bc9f76c8e revision: dbbbc4ab2f1bd1e37ebbc45cdedf291074717da0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-05 14:00:01.940427) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-05 14:00:01.941277) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-05 14:00:01.941758) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-05 14:00:02.009531) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-05 14:00:02.010189) ========= 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=41bf3e9aed84707956354da8000001c5-1483653505.14609-773529423 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-01-05 14:00:02-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 235M=0s 2017-01-05 14:00:02 (235 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.115559 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-05 14:00:02.153839) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-05 14:00:02.154315) ========= 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=41bf3e9aed84707956354da8000001c5-1483653505.14609-773529423 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017190 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-05 14:00:02.217364) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-05 14:00:02.218052) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev dbbbc4ab2f1bd1e37ebbc45cdedf291074717da0 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev dbbbc4ab2f1bd1e37ebbc45cdedf291074717da0 --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=41bf3e9aed84707956354da8000001c5-1483653505.14609-773529423 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-01-05 14:00:02,454 truncating revision to first 12 chars 2017-01-05 14:00:02,454 Setting DEBUG logging. 2017-01-05 14:00:02,454 attempt 1/10 2017-01-05 14:00:02,454 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/dbbbc4ab2f1b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-05 14:00:02,770 unpacking tar archive at: mozilla-aurora-dbbbc4ab2f1b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.626833 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-05 14:00:02.868943) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-05 14:00:02.872405) ========= script_repo_revision: dbbbc4ab2f1bd1e37ebbc45cdedf291074717da0 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-05 14:00:02.872886) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-05 14:00:02.873506) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-05 14:00:02.884410) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2017-01-05 14:00:02.884829) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=41bf3e9aed84707956354da8000001c5-1483653505.14609-773529423 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:00:03 INFO - MultiFileLogger online at 20170105 14:00:03 in /builds/slave/test 14:00:03 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 14:00:03 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:00:03 INFO - {'append_to_log': False, 14:00:03 INFO - 'base_work_dir': '/builds/slave/test', 14:00:03 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 14:00:03 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:00:03 INFO - 'branch': 'Mozilla-Aurora', 14:00:03 INFO - 'buildbot_json_path': 'buildprops.json', 14:00:03 INFO - 'config_files': ('talos/linux_config.py',), 14:00:03 INFO - 'default_actions': ('clobber', 14:00:03 INFO - 'read-buildbot-config', 14:00:03 INFO - 'download-and-extract', 14:00:03 INFO - 'populate-webroot', 14:00:03 INFO - 'create-virtualenv', 14:00:03 INFO - 'install', 14:00:03 INFO - 'run-tests'), 14:00:03 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:00:03 INFO - 'download_minidump_stackwalk': True, 14:00:03 INFO - 'download_symbols': 'ondemand', 14:00:03 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:00:03 INFO - 'tooltool.py': '/tools/tooltool.py', 14:00:03 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:00:03 INFO - '/tools/misc-python/virtualenv.py')}, 14:00:03 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:00:03 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:00:03 INFO - 'installer_path': 'installer.exe', 14:00:03 INFO - 'log_level': 'info', 14:00:03 INFO - 'log_name': 'talos', 14:00:03 INFO - 'log_to_console': True, 14:00:03 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:00:03 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:00:03 INFO - 'opt_config_files': (), 14:00:03 INFO - 'pip_index': False, 14:00:03 INFO - 'sps_profile': False, 14:00:03 INFO - 'sps_profile_interval': 0, 14:00:03 INFO - 'suite': 'dromaeojs', 14:00:03 INFO - 'system_bits': '32', 14:00:03 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:00:03 INFO - 'title': 'talos-linux64-ix-026', 14:00:03 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:00:03 INFO - 'use_talos_json': True, 14:00:03 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:00:03 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:00:03 INFO - 'work_dir': 'build'} 14:00:03 INFO - [mozharness: 2017-01-05 22:00:03.204752Z] Running clobber step. 14:00:03 INFO - Running pre-action listener: _resource_record_pre_action 14:00:03 INFO - Running main action method: clobber 14:00:03 INFO - rmtree: /builds/slave/test/build 14:00:03 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:00:03 INFO - Running post-action listener: _resource_record_post_action 14:00:03 INFO - [mozharness: 2017-01-05 22:00:03.659986Z] Finished clobber step (success) 14:00:03 INFO - [mozharness: 2017-01-05 22:00:03.660085Z] Running read-buildbot-config step. 14:00:03 INFO - Running pre-action listener: _resource_record_pre_action 14:00:03 INFO - Running main action method: read_buildbot_config 14:00:03 INFO - Using buildbot properties: 14:00:03 INFO - { 14:00:03 INFO - "project": "", 14:00:03 INFO - "product": "firefox", 14:00:03 INFO - "script_repo_revision": "production", 14:00:03 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 14:00:03 INFO - "repository": "", 14:00:03 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 14:00:03 INFO - "buildid": "20170105122013", 14:00:03 INFO - "pgo_build": "True", 14:00:03 INFO - "basedir": "/builds/slave/test", 14:00:03 INFO - "buildnumber": 713, 14:00:03 INFO - "slavename": "talos-linux64-ix-026", 14:00:03 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 14:00:03 INFO - "platform": "ubuntu64_hw", 14:00:03 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 14:00:03 INFO - "branch": "mozilla-aurora", 14:00:03 INFO - "repo_path": "releases/mozilla-aurora", 14:00:03 INFO - "revision": "dbbbc4ab2f1bd1e37ebbc45cdedf291074717da0", 14:00:03 INFO - "stage_platform": "linux64-pgo", 14:00:03 INFO - "builduid": "e19f4f90c178470ca462574bc9f76c8e", 14:00:03 INFO - "slavebuilddir": "test" 14:00:03 INFO - } 14:00:03 INFO - Found installer url https://queue.taskcluster.net/v1/task/EBrDfoGWS0qFeW7wMB7nrw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2. 14:00:03 INFO - Running post-action listener: _resource_record_post_action 14:00:03 INFO - [mozharness: 2017-01-05 22:00:03.662554Z] Finished read-buildbot-config step (success) 14:00:03 INFO - [mozharness: 2017-01-05 22:00:03.662642Z] Running download-and-extract step. 14:00:03 INFO - Running pre-action listener: _resource_record_pre_action 14:00:03 INFO - Running main action method: download_and_extract 14:00:03 INFO - mkdir: /builds/slave/test/build/tests 14:00:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:00:03 INFO - trying https://queue.taskcluster.net/v1/task/EBrDfoGWS0qFeW7wMB7nrw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 14:00:03 INFO - Downloading https://queue.taskcluster.net/v1/task/EBrDfoGWS0qFeW7wMB7nrw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 14:00:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EBrDfoGWS0qFeW7wMB7nrw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 14:00:04 INFO - Downloaded 1361 bytes. 14:00:04 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 14:00:04 INFO - Using the following test package requirements: 14:00:04 INFO - {u'common': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 14:00:04 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 14:00:04 INFO - u'firefox-52.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 14:00:04 INFO - u'gtest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 14:00:04 INFO - u'firefox-52.0a2.en-US.linux-x86_64.gtest.tests.zip'], 14:00:04 INFO - u'jittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 14:00:04 INFO - u'jsshell-linux-x86_64.zip'], 14:00:04 INFO - u'mochitest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 14:00:04 INFO - u'firefox-52.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 14:00:04 INFO - u'mozbase': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 14:00:04 INFO - u'reftest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 14:00:04 INFO - u'firefox-52.0a2.en-US.linux-x86_64.reftest.tests.zip'], 14:00:04 INFO - u'talos': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 14:00:04 INFO - u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'], 14:00:04 INFO - u'web-platform': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 14:00:04 INFO - u'firefox-52.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 14:00:04 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 14:00:04 INFO - u'firefox-52.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 14:00:04 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:00:04 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EBrDfoGWS0qFeW7wMB7nrw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 14:00:04 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EBrDfoGWS0qFeW7wMB7nrw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:00:04 INFO - Fetch https://queue.taskcluster.net/v1/task/EBrDfoGWS0qFeW7wMB7nrw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 14:00:04 INFO - Http code: 200 14:00:04 INFO - via: 1.1 9baadab4e4d95afe7af7bcba342b29c6.cloudfront.net (CloudFront) 14:00:04 INFO - x-amz-cf-id: r7c-W8wfBD6Ql5dQ2GRBuC47zl0nxFxAwYalxmPTsrRvcsD4y3EEnw== 14:00:04 INFO - x-amz-version-id: 2bZSpRq6wAagHSdk4sAhNFl_G682fUua 14:00:05 INFO - Expected file size: 21942371 14:00:05 INFO - Obtained file size: 21942371 14:00:09 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 14:00:09 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EBrDfoGWS0qFeW7wMB7nrw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 14:00:09 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EBrDfoGWS0qFeW7wMB7nrw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:00:09 INFO - Fetch https://queue.taskcluster.net/v1/task/EBrDfoGWS0qFeW7wMB7nrw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 14:00:09 INFO - Http code: 200 14:00:09 INFO - via: 1.1 d8f42fc9558e3e49ebfdf8834baeb756.cloudfront.net (CloudFront) 14:00:09 INFO - x-amz-cf-id: T5XKdRiEW2ztnmhrIQALZSLWKiwPeKTxzis-wxXPcu7ixKIPAHyrvg== 14:00:09 INFO - x-amz-version-id: 2bZSpRq6wAagHSdk4sAhNFl_G682fUua 14:00:09 INFO - Expected file size: 21942371 14:00:09 INFO - Obtained file size: 21942371 14:00:14 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EBrDfoGWS0qFeW7wMB7nrw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip 14:00:14 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EBrDfoGWS0qFeW7wMB7nrw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 14:00:14 INFO - Fetch https://queue.taskcluster.net/v1/task/EBrDfoGWS0qFeW7wMB7nrw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip into memory 14:00:14 INFO - Http code: 200 14:00:14 INFO - via: 1.1 49c80a47c1441dd194a8337982f1cd7e.cloudfront.net (CloudFront) 14:00:14 INFO - x-amz-cf-id: sgqVTKBDD6X939JRdIXVCgHTCpZmuCROYhcrqf8FuebWUuFVAZUMhA== 14:00:14 INFO - x-amz-version-id: .Ntc4bbk2AWtWXy4SKMk6XFC9B__NQzM 14:00:15 INFO - Expected file size: 14409038 14:00:15 INFO - Obtained file size: 14409038 14:00:15 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')]} 14:00:15 INFO - trying https://queue.taskcluster.net/v1/task/EBrDfoGWS0qFeW7wMB7nrw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 14:00:15 INFO - Downloading https://queue.taskcluster.net/v1/task/EBrDfoGWS0qFeW7wMB7nrw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 14:00:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EBrDfoGWS0qFeW7wMB7nrw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 14:00:16 INFO - Downloaded 64077306 bytes. 14:00:16 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/EBrDfoGWS0qFeW7wMB7nrw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 14:00:16 INFO - mkdir: /builds/slave/test/properties 14:00:16 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:00:16 INFO - Writing to file /builds/slave/test/properties/build_url 14:00:16 INFO - Contents: 14:00:16 INFO - build_url:https://queue.taskcluster.net/v1/task/EBrDfoGWS0qFeW7wMB7nrw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 14:00:17 INFO - Running post-action listener: _resource_record_post_action 14:00:17 INFO - Running post-action listener: set_extra_try_arguments 14:00:17 INFO - [mozharness: 2017-01-05 22:00:17.126022Z] Finished download-and-extract step (success) 14:00:17 INFO - [mozharness: 2017-01-05 22:00:17.126318Z] Running populate-webroot step. 14:00:17 INFO - Running pre-action listener: _resource_record_pre_action 14:00:17 INFO - Running main action method: populate_webroot 14:00:17 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:00:17 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:00:17 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:00:17 INFO - '--tppagecycles', 14:00:17 INFO - '7'], 14:00:17 INFO - 'tests': ['tsvgm']}}, 14:00:17 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:00:17 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:00:17 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:00:17 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:00:17 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:00:17 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:00:17 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:00:17 INFO - 'talos_options': ['--disable-e10s'], 14:00:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:00:17 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:00:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:00:17 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:00:17 INFO - 'talos_options': ['--disable-e10s'], 14:00:17 INFO - 'tests': ['damp', 'tps']}, 14:00:17 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:00:17 INFO - 'tests': ['damp', 'tps']}, 14:00:17 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:00:17 INFO - 'tests': ['dromaeo_dom']}, 14:00:17 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:00:17 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:00:17 INFO - 'tests': ['basic_compositor_video']}, 14:00:17 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 14:00:17 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:00:17 INFO - 'tests': ['a11yr', 14:00:17 INFO - 'ts_paint', 14:00:17 INFO - 'tpaint', 14:00:17 INFO - 'sessionrestore', 14:00:17 INFO - 'sessionrestore_no_auto_restore', 14:00:17 INFO - 'tabpaint']}, 14:00:17 INFO - 'other-e10s': {'tests': ['a11yr', 14:00:17 INFO - 'ts_paint', 14:00:17 INFO - 'tpaint', 14:00:17 INFO - 'sessionrestore', 14:00:17 INFO - 'sessionrestore_no_auto_restore', 14:00:17 INFO - 'tabpaint']}, 14:00:17 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:00:17 INFO - 'ts_paint', 14:00:17 INFO - 'tpaint', 14:00:17 INFO - 'sessionrestore', 14:00:17 INFO - 'sessionrestore_no_auto_restore', 14:00:17 INFO - 'tabpaint']}, 14:00:17 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:00:17 INFO - 'ts_paint', 14:00:17 INFO - 'tpaint', 14:00:17 INFO - 'sessionrestore', 14:00:17 INFO - 'sessionrestore_no_auto_restore', 14:00:17 INFO - 'tabpaint']}, 14:00:17 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:00:17 INFO - 'tests': ['a11yr', 14:00:17 INFO - 'ts_paint', 14:00:17 INFO - 'tpaint', 14:00:17 INFO - 'sessionrestore', 14:00:17 INFO - 'sessionrestore_no_auto_restore', 14:00:17 INFO - 'tabpaint']}, 14:00:17 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:00:17 INFO - 'tests': ['a11yr', 14:00:17 INFO - 'ts_paint', 14:00:17 INFO - 'tpaint', 14:00:17 INFO - 'sessionrestore', 14:00:17 INFO - 'sessionrestore_no_auto_restore', 14:00:17 INFO - 'tabpaint']}, 14:00:17 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:00:17 INFO - 'tests': ['tsvgx', 14:00:17 INFO - 'tsvgr_opacity', 14:00:17 INFO - 'tart', 14:00:17 INFO - 'tscrollx', 14:00:17 INFO - 'cart']}, 14:00:17 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:00:17 INFO - 'tsvgr_opacity', 14:00:17 INFO - 'tart', 14:00:17 INFO - 'tscrollx', 14:00:17 INFO - 'cart']}, 14:00:17 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:00:17 INFO - 'talos_options': ['--disable-e10s'], 14:00:17 INFO - 'tests': ['tp5o']}, 14:00:17 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:00:17 INFO - 'tests': ['tp5o']}, 14:00:17 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:00:17 INFO - 'talos_options': ['--disable-e10s', 14:00:17 INFO - '--xperf_path', 14:00:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:00:17 INFO - 'tests': ['tp5n']}, 14:00:17 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:00:17 INFO - 'talos_options': ['--xperf_path', 14:00:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:00:17 INFO - 'tests': ['tp5n']}}, 14:00:17 INFO - 'talos.zip': {'path': '', 14:00:17 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:00:17 INFO - Running post-action listener: _resource_record_post_action 14:00:17 INFO - [mozharness: 2017-01-05 22:00:17.145012Z] Finished populate-webroot step (success) 14:00:17 INFO - [mozharness: 2017-01-05 22:00:17.145104Z] Running create-virtualenv step. 14:00:17 INFO - Running pre-action listener: _resource_record_pre_action 14:00:17 INFO - Running main action method: create_virtualenv 14:00:17 INFO - Creating virtualenv /builds/slave/test/build/venv 14:00:17 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 14:00:17 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:00:17 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:00:17 INFO - Using real prefix '/usr' 14:00:17 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:00:17 INFO - Installing distribute.............................................................................................................................................................................................done. 14:00:19 INFO - Installing pip.................done. 14:00:19 INFO - Return code: 0 14:00:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 14:00:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 14:00:19 INFO - Reading from file tmpfile_stdout 14:00:19 INFO - Output received: 14:00:19 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 14:00:19 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:00:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:00:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:00:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:00:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:00:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:00:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:00:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5b04186f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ab48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b81ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b7ef60>, '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 0x1b7fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b801d0>, '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': '41bf3e9aed84707956354da8000001c5-1483653505.14609-773529423', '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 14:00:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 14:00:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 14:00:19 INFO - Using env: {'DISPLAY': ':0', 14:00:19 INFO - 'HOME': '/home/cltbld', 14:00:19 INFO - 'LANG': 'en_US.UTF-8', 14:00:19 INFO - 'LANGUAGE': 'en_US:en', 14:00:19 INFO - 'LOGNAME': 'cltbld', 14:00:19 INFO - 'MAIL': '/var/mail/cltbld', 14:00:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:00:19 INFO - 'MOZ_NO_REMOTE': '1', 14:00:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:00:19 INFO - 'NO_EM_RESTART': '1', 14:00:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:00:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:00:19 INFO - 'PWD': '/builds/slave/test', 14:00:19 INFO - 'SHELL': '/bin/bash', 14:00:19 INFO - 'SHLVL': '1', 14:00:19 INFO - 'TERM': 'linux', 14:00:19 INFO - 'TMOUT': '86400', 14:00:19 INFO - 'USER': 'cltbld', 14:00:19 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1483653505.14609-773529423', 14:00:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:00:19 INFO - '_': '/tools/buildbot/bin/python'} 14:00:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:00:20 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 14:00:20 INFO - Cleaning up... 14:00:20 INFO - Return code: 0 14:00:20 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:00:20 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')]} 14:00:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:00:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:00:20 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')]} 14:00:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:00:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:00:20 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 0x7f5b04186f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ab48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b81ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b7ef60>, '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 0x1b7fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b801d0>, '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': '41bf3e9aed84707956354da8000001c5-1483653505.14609-773529423', '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 14:00:20 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 14:00:20 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 14:00:20 INFO - Using env: {'DISPLAY': ':0', 14:00:20 INFO - 'HOME': '/home/cltbld', 14:00:20 INFO - 'LANG': 'en_US.UTF-8', 14:00:20 INFO - 'LANGUAGE': 'en_US:en', 14:00:20 INFO - 'LOGNAME': 'cltbld', 14:00:20 INFO - 'MAIL': '/var/mail/cltbld', 14:00:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:00:20 INFO - 'MOZ_NO_REMOTE': '1', 14:00:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:00:20 INFO - 'NO_EM_RESTART': '1', 14:00:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:00:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:00:20 INFO - 'PWD': '/builds/slave/test', 14:00:20 INFO - 'SHELL': '/bin/bash', 14:00:20 INFO - 'SHLVL': '1', 14:00:20 INFO - 'TERM': 'linux', 14:00:20 INFO - 'TMOUT': '86400', 14:00:20 INFO - 'USER': 'cltbld', 14:00:20 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1483653505.14609-773529423', 14:00:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:00:20 INFO - '_': '/tools/buildbot/bin/python'} 14:00:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:00:20 INFO - Downloading/unpacking psutil>=3.1.1 14:00:20 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 14:00:20 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 14:00:20 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 14:00:20 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 14:00:20 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 14:00:20 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 14:00:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:00:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:00:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:00:22 INFO - Installing collected packages: psutil 14:00:22 INFO - Running setup.py install for psutil 14:00:22 INFO - building 'psutil._psutil_linux' extension 14:00:22 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 14:00:22 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 14:00:22 INFO - building 'psutil._psutil_posix' extension 14:00:22 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 14:00:22 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 14:00:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:00:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:00:22 INFO - Successfully installed psutil 14:00:22 INFO - Cleaning up... 14:00:23 INFO - Return code: 0 14:00:23 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:00:23 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')]} 14:00:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:00:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:00:23 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')]} 14:00:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:00:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:00:23 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 0x7f5b04186f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ab48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b81ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b7ef60>, '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 0x1b7fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b801d0>, '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': '41bf3e9aed84707956354da8000001c5-1483653505.14609-773529423', '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 14:00:23 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 14:00:23 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 14:00:23 INFO - Using env: {'DISPLAY': ':0', 14:00:23 INFO - 'HOME': '/home/cltbld', 14:00:23 INFO - 'LANG': 'en_US.UTF-8', 14:00:23 INFO - 'LANGUAGE': 'en_US:en', 14:00:23 INFO - 'LOGNAME': 'cltbld', 14:00:23 INFO - 'MAIL': '/var/mail/cltbld', 14:00:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:00:23 INFO - 'MOZ_NO_REMOTE': '1', 14:00:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:00:23 INFO - 'NO_EM_RESTART': '1', 14:00:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:00:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:00:23 INFO - 'PWD': '/builds/slave/test', 14:00:23 INFO - 'SHELL': '/bin/bash', 14:00:23 INFO - 'SHLVL': '1', 14:00:23 INFO - 'TERM': 'linux', 14:00:23 INFO - 'TMOUT': '86400', 14:00:23 INFO - 'USER': 'cltbld', 14:00:23 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1483653505.14609-773529423', 14:00:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:00:23 INFO - '_': '/tools/buildbot/bin/python'} 14:00:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:00:23 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:00:23 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 14:00:23 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 14:00:23 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 14:00:23 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 14:00:23 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 14:00:23 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 14:00:25 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:00:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:00:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:00:25 INFO - Installing collected packages: mozsystemmonitor 14:00:25 INFO - Running setup.py install for mozsystemmonitor 14:00:25 INFO - Successfully installed mozsystemmonitor 14:00:25 INFO - Cleaning up... 14:00:25 INFO - Return code: 0 14:00:25 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:00:25 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')]} 14:00:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:00:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:00:25 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')]} 14:00:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:00:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:00:25 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 0x7f5b04186f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ab48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b81ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b7ef60>, '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 0x1b7fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b801d0>, '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': '41bf3e9aed84707956354da8000001c5-1483653505.14609-773529423', '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 14:00:25 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 14:00:25 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 14:00:25 INFO - Using env: {'DISPLAY': ':0', 14:00:25 INFO - 'HOME': '/home/cltbld', 14:00:25 INFO - 'LANG': 'en_US.UTF-8', 14:00:25 INFO - 'LANGUAGE': 'en_US:en', 14:00:25 INFO - 'LOGNAME': 'cltbld', 14:00:25 INFO - 'MAIL': '/var/mail/cltbld', 14:00:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:00:25 INFO - 'MOZ_NO_REMOTE': '1', 14:00:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:00:25 INFO - 'NO_EM_RESTART': '1', 14:00:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:00:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:00:25 INFO - 'PWD': '/builds/slave/test', 14:00:25 INFO - 'SHELL': '/bin/bash', 14:00:25 INFO - 'SHLVL': '1', 14:00:25 INFO - 'TERM': 'linux', 14:00:25 INFO - 'TMOUT': '86400', 14:00:25 INFO - 'USER': 'cltbld', 14:00:25 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1483653505.14609-773529423', 14:00:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:00:25 INFO - '_': '/tools/buildbot/bin/python'} 14:00:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:00:25 INFO - Downloading/unpacking jsonschema==2.5.1 14:00:25 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 14:00:25 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 14:00:25 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 14:00:25 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 14:00:25 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 14:00:25 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 14:00:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:00:27 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:00: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 14:00: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 14:00: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 14:00: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 14:00: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 14:00: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 14:00:27 INFO - Downloading functools32-3.2.3-2.tar.gz 14:00:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:00:27 INFO - warning: no files found matching '*.txt' 14:00:27 INFO - no previously-included directories found matching 'build' 14:00:27 INFO - no previously-included directories found matching 'dist' 14:00:27 INFO - no previously-included directories found matching '.git*' 14:00:27 INFO - Installing collected packages: jsonschema, functools32 14:00:28 INFO - Running setup.py install for functools32 14:00:28 INFO - warning: no files found matching '*.txt' 14:00:28 INFO - no previously-included directories found matching 'build' 14:00:28 INFO - no previously-included directories found matching 'dist' 14:00:28 INFO - no previously-included directories found matching '.git*' 14:00:28 INFO - Successfully installed jsonschema functools32 14:00:28 INFO - Cleaning up... 14:00:28 INFO - Return code: 0 14:00:28 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14:00:28 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')]} 14:00:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:00:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:00:28 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')]} 14:00:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:00:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:00:28 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 0x7f5b04186f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ab48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b81ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b7ef60>, '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 0x1b7fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b801d0>, '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': '41bf3e9aed84707956354da8000001c5-1483653505.14609-773529423', '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 14:00:28 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 14:00:28 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 14:00:28 INFO - Using env: {'DISPLAY': ':0', 14:00:28 INFO - 'HOME': '/home/cltbld', 14:00:28 INFO - 'LANG': 'en_US.UTF-8', 14:00:28 INFO - 'LANGUAGE': 'en_US:en', 14:00:28 INFO - 'LOGNAME': 'cltbld', 14:00:28 INFO - 'MAIL': '/var/mail/cltbld', 14:00:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:00:28 INFO - 'MOZ_NO_REMOTE': '1', 14:00:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:00:28 INFO - 'NO_EM_RESTART': '1', 14:00:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:00:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:00:28 INFO - 'PWD': '/builds/slave/test', 14:00:28 INFO - 'SHELL': '/bin/bash', 14:00:28 INFO - 'SHLVL': '1', 14:00:28 INFO - 'TERM': 'linux', 14:00:28 INFO - 'TMOUT': '86400', 14:00:28 INFO - 'USER': 'cltbld', 14:00:28 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1483653505.14609-773529423', 14:00:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:00:28 INFO - '_': '/tools/buildbot/bin/python'} 14:00:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:00:28 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:00:28 INFO - Cleaning up... 14:00:28 INFO - Return code: 0 14:00:28 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:00:28 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')]} 14:00:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:00:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:00:28 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')]} 14:00:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:00:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:00:28 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 0x7f5b04186f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ab48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b81ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b7ef60>, '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 0x1b7fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b801d0>, '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': '41bf3e9aed84707956354da8000001c5-1483653505.14609-773529423', '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 14:00:28 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 14:00:28 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 14:00:28 INFO - Using env: {'DISPLAY': ':0', 14:00:28 INFO - 'HOME': '/home/cltbld', 14:00:28 INFO - 'LANG': 'en_US.UTF-8', 14:00:28 INFO - 'LANGUAGE': 'en_US:en', 14:00:28 INFO - 'LOGNAME': 'cltbld', 14:00:28 INFO - 'MAIL': '/var/mail/cltbld', 14:00:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:00:28 INFO - 'MOZ_NO_REMOTE': '1', 14:00:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:00:28 INFO - 'NO_EM_RESTART': '1', 14:00:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:00:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:00:28 INFO - 'PWD': '/builds/slave/test', 14:00:28 INFO - 'SHELL': '/bin/bash', 14:00:28 INFO - 'SHLVL': '1', 14:00:28 INFO - 'TERM': 'linux', 14:00:28 INFO - 'TMOUT': '86400', 14:00:28 INFO - 'USER': 'cltbld', 14:00:28 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1483653505.14609-773529423', 14:00:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:00:28 INFO - '_': '/tools/buildbot/bin/python'} 14:00:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:00:28 INFO - Downloading/unpacking blobuploader==1.2.4 14:00:28 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 14:00:28 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 14:00:28 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 14:00:28 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 14:00:28 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 14:00:28 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 14:00:30 INFO - Downloading blobuploader-1.2.4.tar.gz 14:00:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:00:30 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:00: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 14:00: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 14:00: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 14:00: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 14:00: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 14:00: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 14:00:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:00:31 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:00:31 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 14:00:31 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 14:00:31 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 14:00:31 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 14:00:31 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 14:00:31 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 14:00:31 INFO - Downloading docopt-0.6.1.tar.gz 14:00:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:00:31 INFO - Installing collected packages: blobuploader, requests, docopt 14:00:31 INFO - Running setup.py install for blobuploader 14:00:31 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:00:31 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:00:31 INFO - Running setup.py install for requests 14:00:31 INFO - Running setup.py install for docopt 14:00:31 INFO - Successfully installed blobuploader requests docopt 14:00:31 INFO - Cleaning up... 14:00:32 INFO - Return code: 0 14:00:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:00:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:00:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:00:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:00:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:00:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:00:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:00:32 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 0x7f5b04186f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ab48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b81ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b7ef60>, '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 0x1b7fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b801d0>, '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': '41bf3e9aed84707956354da8000001c5-1483653505.14609-773529423', '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 14:00:32 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 14:00:32 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 14:00:32 INFO - Using env: {'DISPLAY': ':0', 14:00:32 INFO - 'HOME': '/home/cltbld', 14:00:32 INFO - 'LANG': 'en_US.UTF-8', 14:00:32 INFO - 'LANGUAGE': 'en_US:en', 14:00:32 INFO - 'LOGNAME': 'cltbld', 14:00:32 INFO - 'MAIL': '/var/mail/cltbld', 14:00:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:00:32 INFO - 'MOZ_NO_REMOTE': '1', 14:00:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:00:32 INFO - 'NO_EM_RESTART': '1', 14:00:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:00:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:00:32 INFO - 'PWD': '/builds/slave/test', 14:00:32 INFO - 'SHELL': '/bin/bash', 14:00:32 INFO - 'SHLVL': '1', 14:00:32 INFO - 'TERM': 'linux', 14:00:32 INFO - 'TMOUT': '86400', 14:00:32 INFO - 'USER': 'cltbld', 14:00:32 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1483653505.14609-773529423', 14:00:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:00:32 INFO - '_': '/tools/buildbot/bin/python'} 14:00:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:00:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:00:32 INFO - Running setup.py (path:/tmp/pip-eSD1Md-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:00:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:00:32 INFO - Running setup.py (path:/tmp/pip-LLSa0o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:00:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:00:32 INFO - Running setup.py (path:/tmp/pip-lox_Gf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:00:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:00:32 INFO - Running setup.py (path:/tmp/pip-zxZpJe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:00:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:00:32 INFO - Running setup.py (path:/tmp/pip-kfBdDa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:00:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:00:32 INFO - Running setup.py (path:/tmp/pip-8jOcXB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:00:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:00:32 INFO - Running setup.py (path:/tmp/pip-PuK98Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:00:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:00:32 INFO - Running setup.py (path:/tmp/pip-5q3rC0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:00:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:00:32 INFO - Running setup.py (path:/tmp/pip-XSLR2l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:00:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:00:32 INFO - Running setup.py (path:/tmp/pip-FIds35-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:00:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:00:33 INFO - Running setup.py (path:/tmp/pip-O3QIwr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:00:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:00:33 INFO - Running setup.py (path:/tmp/pip-aoNv3g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:00:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:00:33 INFO - Running setup.py (path:/tmp/pip-iPsOpE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:00:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:00:33 INFO - Running setup.py (path:/tmp/pip-B4PQnU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:00:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:00:33 INFO - Running setup.py (path:/tmp/pip-CPdh0X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:00:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:00:33 INFO - Running setup.py (path:/tmp/pip-84ON3P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:00:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:00:33 INFO - Running setup.py (path:/tmp/pip-DmwIte-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:00:33 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:00:33 INFO - Running setup.py install for manifestparser 14:00:33 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:00:33 INFO - Running setup.py install for mozcrash 14:00:33 INFO - Running setup.py install for mozdebug 14:00:33 INFO - Running setup.py install for mozdevice 14:00:33 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:00:33 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:00:33 INFO - Running setup.py install for mozfile 14:00:34 INFO - Running setup.py install for mozhttpd 14:00:34 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:00:34 INFO - Running setup.py install for mozinfo 14:00:34 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:00:34 INFO - Running setup.py install for mozInstall 14:00:34 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:00:34 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:00:34 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:00:34 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:00:34 INFO - Running setup.py install for mozleak 14:00:34 INFO - Running setup.py install for mozlog 14:00:34 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:00:34 INFO - Running setup.py install for moznetwork 14:00:34 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:00:34 INFO - Running setup.py install for mozprocess 14:00:34 INFO - Running setup.py install for mozprofile 14:00:34 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:00:34 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:00:34 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:00:34 INFO - Running setup.py install for mozrunner 14:00:34 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:00:35 INFO - Running setup.py install for mozscreenshot 14:00:35 INFO - Running setup.py install for moztest 14:00:35 INFO - Running setup.py install for mozversion 14:00:35 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:00:35 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:00:35 INFO - Cleaning up... 14:00:35 INFO - Return code: 0 14:00:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:00: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')]} 14:00:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:00:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:00: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')]} 14:00:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:00:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:00:35 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 0x7f5b04186f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ab48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b81ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b7ef60>, '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 0x1b7fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b801d0>, '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': '41bf3e9aed84707956354da8000001c5-1483653505.14609-773529423', '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 14:00:35 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 14:00:35 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 14:00:35 INFO - Using env: {'DISPLAY': ':0', 14:00:35 INFO - 'HOME': '/home/cltbld', 14:00:35 INFO - 'LANG': 'en_US.UTF-8', 14:00:35 INFO - 'LANGUAGE': 'en_US:en', 14:00:35 INFO - 'LOGNAME': 'cltbld', 14:00:35 INFO - 'MAIL': '/var/mail/cltbld', 14:00:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:00:35 INFO - 'MOZ_NO_REMOTE': '1', 14:00:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:00:35 INFO - 'NO_EM_RESTART': '1', 14:00:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:00:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:00:35 INFO - 'PWD': '/builds/slave/test', 14:00:35 INFO - 'SHELL': '/bin/bash', 14:00:35 INFO - 'SHLVL': '1', 14:00:35 INFO - 'TERM': 'linux', 14:00:35 INFO - 'TMOUT': '86400', 14:00:35 INFO - 'USER': 'cltbld', 14:00:35 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1483653505.14609-773529423', 14:00:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:00:35 INFO - '_': '/tools/buildbot/bin/python'} 14:00:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:00:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:00:35 INFO - Running setup.py (path:/tmp/pip-z4CEsW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:00:35 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)) 14:00:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:00:35 INFO - Running setup.py (path:/tmp/pip-5xr0gt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:00:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 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)) 14:00:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:00:35 INFO - Running setup.py (path:/tmp/pip-7ZW5Al-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:00:35 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)) 14:00:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:00:35 INFO - Running setup.py (path:/tmp/pip-1zMFco-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:00:35 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)) 14:00:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:00:35 INFO - Running setup.py (path:/tmp/pip-_FER9i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:00:35 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)) 14:00:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:00:35 INFO - Running setup.py (path:/tmp/pip-WHP7ZR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:00:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 14:00:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:00:35 INFO - Running setup.py (path:/tmp/pip-k6pVK6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:00:36 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)) 14:00:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:00:36 INFO - Running setup.py (path:/tmp/pip-Exsp6V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:00:36 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)) 14:00:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:00:36 INFO - Running setup.py (path:/tmp/pip-PWkoIh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:00:36 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)) 14:00:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:00:36 INFO - Running setup.py (path:/tmp/pip-mmulax-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:00:36 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)) 14:00:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:00:36 INFO - Running setup.py (path:/tmp/pip-dV7YFc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:00:36 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)) 14:00:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:00:36 INFO - Running setup.py (path:/tmp/pip-aZciew-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:00:36 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)) 14:00:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:00:36 INFO - Running setup.py (path:/tmp/pip-xT2GMl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:00:36 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)) 14:00:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:00:36 INFO - Running setup.py (path:/tmp/pip-329cTK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:00:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 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)) 14:00:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:00:36 INFO - Running setup.py (path:/tmp/pip-TFSnnp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:00:36 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)) 14:00:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:00:36 INFO - Running setup.py (path:/tmp/pip-JmZSKh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:00:36 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 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)) 14:00:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:00:36 INFO - Running setup.py (path:/tmp/pip-GcNm1Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:00:36 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)) 14:00:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:00:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:00:36 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)) 14:00:36 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)) 14:00:36 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)) 14:00:36 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:00: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 14:00: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 14:00: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 14:00: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 14:00: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 14:00: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 14:00:38 INFO - Downloading blessings-1.6.tar.gz 14:00:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:00:39 INFO - Installing collected packages: blessings 14:00:39 INFO - Running setup.py install for blessings 14:00:39 INFO - Successfully installed blessings 14:00:39 INFO - Cleaning up... 14:00:39 INFO - Return code: 0 14:00:39 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:00:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:00:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:00:39 INFO - Reading from file tmpfile_stdout 14:00:39 INFO - Current package versions: 14:00:39 INFO - argparse == 1.2.1 14:00:39 INFO - blessings == 1.6 14:00:39 INFO - blobuploader == 1.2.4 14:00:39 INFO - docopt == 0.6.1 14:00:39 INFO - functools32 == 3.2.3-2 14:00:39 INFO - jsonschema == 2.5.1 14:00:39 INFO - manifestparser == 1.1 14:00:39 INFO - mozInstall == 1.12 14:00:39 INFO - mozcrash == 1.0 14:00:39 INFO - mozdebug == 0.1 14:00:39 INFO - mozdevice == 0.48 14:00:39 INFO - mozfile == 1.2 14:00:39 INFO - mozhttpd == 0.7 14:00:39 INFO - mozinfo == 0.9 14:00:39 INFO - mozleak == 0.1 14:00:39 INFO - mozlog == 3.4 14:00:39 INFO - moznetwork == 0.27 14:00:39 INFO - mozprocess == 0.23 14:00:39 INFO - mozprofile == 0.28 14:00:39 INFO - mozrunner == 6.13 14:00:39 INFO - mozscreenshot == 0.1 14:00:39 INFO - mozsystemmonitor == 0.3 14:00:39 INFO - moztest == 0.8 14:00:39 INFO - mozversion == 1.4 14:00:39 INFO - psutil == 3.1.1 14:00:39 INFO - requests == 1.2.3 14:00:39 INFO - wsgiref == 0.1.2 14:00:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:00:39 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')]} 14:00:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:00:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:00:39 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')]} 14:00:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:00:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:00:39 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 0x7f5b04186f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ab48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b81ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b7ef60>, '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 0x1b7fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b801d0>, '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': '41bf3e9aed84707956354da8000001c5-1483653505.14609-773529423', '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 14:00:39 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 14:00:39 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 14:00:39 INFO - Using env: {'DISPLAY': ':0', 14:00:39 INFO - 'HOME': '/home/cltbld', 14:00:39 INFO - 'LANG': 'en_US.UTF-8', 14:00:39 INFO - 'LANGUAGE': 'en_US:en', 14:00:39 INFO - 'LOGNAME': 'cltbld', 14:00:39 INFO - 'MAIL': '/var/mail/cltbld', 14:00:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:00:39 INFO - 'MOZ_NO_REMOTE': '1', 14:00:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:00:39 INFO - 'NO_EM_RESTART': '1', 14:00:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:00:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:00:39 INFO - 'PWD': '/builds/slave/test', 14:00:39 INFO - 'SHELL': '/bin/bash', 14:00:39 INFO - 'SHLVL': '1', 14:00:39 INFO - 'TERM': 'linux', 14:00:39 INFO - 'TMOUT': '86400', 14:00:39 INFO - 'USER': 'cltbld', 14:00:39 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1483653505.14609-773529423', 14:00:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:00:39 INFO - '_': '/tools/buildbot/bin/python'} 14:00:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:00:39 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)) 14:00:39 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)) 14:00:39 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)) 14:00:39 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)) 14:00:39 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)) 14:00:39 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)) 14:00:39 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)) 14:00:39 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)) 14:00:39 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)) 14:00:39 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)) 14:00:39 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)) 14:00:39 INFO - Cleaning up... 14:00:39 INFO - Return code: 0 14:00:39 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:00:39 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')]} 14:00:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:00:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:00:39 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')]} 14:00:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:00:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:00:39 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 0x7f5b04186f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ab48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b81ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b7ef60>, '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 0x1b7fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b801d0>, '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': '41bf3e9aed84707956354da8000001c5-1483653505.14609-773529423', '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 14:00:39 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 14:00:39 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 14:00:39 INFO - Using env: {'DISPLAY': ':0', 14:00:39 INFO - 'HOME': '/home/cltbld', 14:00:39 INFO - 'LANG': 'en_US.UTF-8', 14:00:39 INFO - 'LANGUAGE': 'en_US:en', 14:00:39 INFO - 'LOGNAME': 'cltbld', 14:00:39 INFO - 'MAIL': '/var/mail/cltbld', 14:00:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:00:39 INFO - 'MOZ_NO_REMOTE': '1', 14:00:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:00:39 INFO - 'NO_EM_RESTART': '1', 14:00:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:00:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:00:39 INFO - 'PWD': '/builds/slave/test', 14:00:39 INFO - 'SHELL': '/bin/bash', 14:00:39 INFO - 'SHLVL': '1', 14:00:39 INFO - 'TERM': 'linux', 14:00:39 INFO - 'TMOUT': '86400', 14:00:39 INFO - 'USER': 'cltbld', 14:00:39 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1483653505.14609-773529423', 14:00:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:00:39 INFO - '_': '/tools/buildbot/bin/python'} 14:00:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:00:39 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:00:39 INFO - Cleaning up... 14:00:39 INFO - Return code: 0 14:00:39 INFO - Running post-action listener: _resource_record_post_action 14:00:39 INFO - Running post-action listener: _start_resource_monitoring 14:00:39 INFO - Starting resource monitoring. 14:00:39 INFO - [mozharness: 2017-01-05 22:00:39.954827Z] Finished create-virtualenv step (success) 14:00:39 INFO - [mozharness: 2017-01-05 22:00:39.955330Z] Running install step. 14:00:39 INFO - Running pre-action listener: _resource_record_pre_action 14:00:39 INFO - Running main action method: install 14:00:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:00:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:00:40 INFO - Reading from file tmpfile_stdout 14:00:40 INFO - Detecting whether we're running mozinstall >=1.0... 14:00:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:00:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:00:40 INFO - Reading from file tmpfile_stdout 14:00:40 INFO - Output received: 14:00:40 INFO - Usage: mozinstall [options] installer 14:00:40 INFO - Options: 14:00:40 INFO - -h, --help show this help message and exit 14:00:40 INFO - -d DEST, --destination=DEST 14:00:40 INFO - Directory to install application into. [default: 14:00:40 INFO - "/builds/slave/test"] 14:00:40 INFO - --app=APP Application being installed. [default: firefox] 14:00:40 INFO - mkdir: /builds/slave/test/build/application 14:00:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 14:00:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 14:00:56 INFO - Reading from file tmpfile_stdout 14:00:56 INFO - Output received: 14:00:56 INFO - /builds/slave/test/build/application/firefox/firefox 14:00:56 INFO - Running post-action listener: _resource_record_post_action 14:00:56 INFO - [mozharness: 2017-01-05 22:00:56.212486Z] Finished install step (success) 14:00:56 INFO - [mozharness: 2017-01-05 22:00:56.212731Z] Running run-tests step. 14:00:56 INFO - Running pre-action listener: _resource_record_pre_action 14:00:56 INFO - Running main action method: run_tests 14:00:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:00:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:00:56 INFO - Python 2.7.3 14:00:56 INFO - Return code: 0 14:00:56 INFO - grabbing minidump binary from tooltool 14:00:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:00:56 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b7ef60>, '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 0x1b7fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b801d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:00:56 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 14:00:56 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 14:00:56 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 14:00:56 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:00:56 INFO - Return code: 0 14:00:56 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:00:56 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:00:56 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:00:56 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:00:56 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:00:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EBrDfoGWS0qFeW7wMB7nrw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--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 14:00:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/EBrDfoGWS0qFeW7wMB7nrw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-026 --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 14:00:56 INFO - Using env: {'DISPLAY': ':0', 14:00:56 INFO - 'HOME': '/home/cltbld', 14:00:56 INFO - 'LANG': 'en_US.UTF-8', 14:00:56 INFO - 'LANGUAGE': 'en_US:en', 14:00:56 INFO - 'LOGNAME': 'cltbld', 14:00:56 INFO - 'MAIL': '/var/mail/cltbld', 14:00:56 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:00:56 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:00:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:00:56 INFO - 'MOZ_NO_REMOTE': '1', 14:00:56 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:00:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:00:56 INFO - 'NO_EM_RESTART': '1', 14:00:56 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:00:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:00:56 INFO - 'PWD': '/builds/slave/test', 14:00:56 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:00:56 INFO - 'SHELL': '/bin/bash', 14:00:56 INFO - 'SHLVL': '1', 14:00:56 INFO - 'TERM': 'linux', 14:00:56 INFO - 'TMOUT': '86400', 14:00:56 INFO - 'USER': 'cltbld', 14:00:56 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1483653505.14609-773529423', 14:00:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:00:56 INFO - '_': '/tools/buildbot/bin/python'} 14:00:56 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EBrDfoGWS0qFeW7wMB7nrw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--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 14:00:56 INFO - mozversion application_buildid: 20170105122013 14:00:56 INFO - mozversion application_changeset: dbbbc4ab2f1bd1e37ebbc45cdedf291074717da0 14:00:56 INFO - mozversion application_display_name: FirefoxDeveloperEdition 14:00:56 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:00:56 INFO - mozversion application_name: Firefox 14:00:56 INFO - mozversion application_remotingname: firefox-dev 14:00:56 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 14:00:56 INFO - mozversion application_vendor: Mozilla 14:00:56 INFO - mozversion application_version: 52.0a2 14:00:56 INFO - mozversion platform_buildid: 20170105122013 14:00:56 INFO - mozversion platform_changeset: dbbbc4ab2f1bd1e37ebbc45cdedf291074717da0 14:00:56 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 14:00:56 INFO - mozversion platform_version: 52.0a2 14:00:56 INFO - using testdate: 1483653656 14:00:56 INFO - actual date: 1483653656 14:00:56 INFO - starting webserver on 'localhost:46761' 14:00:56 INFO - SUITE-START | Running 2 tests 14:00:56 INFO - TEST-START | dromaeo_css 14:00:56 INFO - operating with platform_type : linux_ 14:00:56 INFO - Initialising browser for dromaeo_css test... 14:00:56 INFO - TEST-INFO | started process 1916 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAJhs2S/profile http://localhost:46761/getInfo.html) 14:01:00 INFO - PROCESS | 1916 | __metrics Screen width/height:1600/1200 14:01:00 INFO - PROCESS | 1916 | colorDepth:24 14:01:00 INFO - PROCESS | 1916 | Browser inner width/height: 1024/697 14:01:00 INFO - PROCESS | 1916 | __metrics 14:01:01 INFO - PROCESS | 1916 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 14:01:01 INFO - PROCESS | 1916 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:01:01 INFO - PROCESS | 1916 | console.error: PushService: 14:01:01 INFO - PROCESS | 1916 | stateChangeProcessEnqueue: Error transitioning state 14:01:01 INFO - PROCESS | 1916 | UnknownError 14:01:02 INFO - TEST-INFO | 1916: exit 0 14:01:02 INFO - Browser initialized. 14:01:02 INFO - Running cycle 1/1 for dromaeo_css test... 14:01:02 INFO - TEST-INFO | started process 2008 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAJhs2S/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:01:14 INFO - PROCESS | 2008 | RSS: Main: 144490496 14:01:14 INFO - PROCESS | 2008 | 14:04:16 INFO - PROCESS | 2008 | Cycle 1(1): loaded http://localhost:46761/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46761/tests/dromaeo/cssquery-ext.html) 14:04:17 INFO - PROCESS | 2008 | RSS: Main: 250601472 14:04:17 INFO - PROCESS | 2008 | 14:07:19 INFO - PROCESS | 2008 | Cycle 1(1): loaded http://localhost:46761/tests/dromaeo/cssquery-ext.html (next: http://localhost:46761/tests/dromaeo/cssquery-jquery.html) 14:07:20 INFO - PROCESS | 2008 | RSS: Main: 225488896 14:07:20 INFO - PROCESS | 2008 | 14:10:22 INFO - PROCESS | 2008 | Cycle 1(1): loaded http://localhost:46761/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46761/tests/dromaeo/cssquery-mootools.html) 14:10:23 INFO - PROCESS | 2008 | RSS: Main: 174387200 14:10:23 INFO - PROCESS | 2008 | 14:13:25 INFO - PROCESS | 2008 | Cycle 1(1): loaded http://localhost:46761/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46761/tests/dromaeo/cssquery-prototype.html) 14:13:25 INFO - PROCESS | 2008 | RSS: Main: 214069248 14:13:25 INFO - PROCESS | 2008 | 14:16:28 INFO - PROCESS | 2008 | Cycle 1(1): loaded http://localhost:46761/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46761/tests/dromaeo/cssquery-yui.html) 14:16:29 INFO - PROCESS | 2008 | RSS: Main: 175456256 14:16:29 INFO - PROCESS | 2008 | 14:19:31 INFO - PROCESS | 2008 | Cycle 1(1): loaded http://localhost:46761/tests/dromaeo/cssquery-yui.html (next: http://localhost:46761/tests/dromaeo/cssquery-dojo.html) 14:19:32 INFO - PROCESS | 2008 | RSS: Main: 265822208 14:19:32 INFO - PROCESS | 2008 | 14:19:32 INFO - PROCESS | 2008 | __start_tp_report 14:19:32 INFO - PROCESS | 2008 | _x_x_mozilla_page_load 14:19:32 INFO - PROCESS | 2008 | _x_x_mozilla_page_load_details 14:19:32 INFO - PROCESS | 2008 | |i|pagename|runs| 14:19:32 INFO - PROCESS | 2008 | |0;dojo.html;3197.6642452542483;3239.465488194448;3242.059802657231;3264.9347013059723;3278.967210327896;5498.120300751875;5528.640638358504;5542.473465020827;5544.306961629796;5558.638688485245;5534.889302213964;5586.972065139679;5587.217789509472;5594.216809646653;5608.355039170497;5003.924941125895;5022.146235140017;5062.063518249117;5088.491150884919;5101.20931255656;4944.4313903900975;5052.4947505249365;5106.4382917879;5107.744612769366;5114.667546609458;4939.60483161348;4940.061388336205;4954.430240522332;4991.226359914201;4992.67547609406;4976.2286845539;5013.824516141954;5014.498550144993;5065.8733531662;5076.213186956028;4755.0489902019735;4958.231474121517;4978.278149668277;5016.924746128811;5027.145385284474;5361.678299302015;5371.435999220064;5385.407605163429;5446.564274858041;5514.420985796473;5856.531477481792;5883.323417806964;5896.204012458349;5899.528037756969;5906.881862362771;5704.942950570524;5953.7320820562745;5954.523638108984;5964.343922168601;5977.342492325841;5390.865228369283;5521.834344969658;5559.054960656698;5564.916526252109;5580.19087232349;6030.427109424598;6052.515798736091;6054.697265136726;6056.939430605637;6061.878762424815;5552.805651802168;5818.127280907897;5820.3888591698105;5824.592278540546;5871.089981052944;5651.0675738503505;5852.385499522489;5922.940770592325;5944.940550594525;6013.458788709037;5942.910856337158;5968.1644569760265;5972.25346831646;5981;6015.639061656227;5941.792037278675;5973.37279585646;5980.850478738066;5984.491318237999;5992.250968628921;4445.2887537993765;4493.460784705856;4533.410656614619;4577.519360467103;4584.33527138563;4087.141700242923;4103.733257338264;4103.97948010258;4132.8140233689555;4135.669146468275;5718.828435146952;5725.370209276976;5726.885462290731;5728.656280623176;5730.111832665943;5716.428357164334;5774.422557744192;5782.132680098019;5845.210896528914;6013.849653758691;5568.582356323211;5571.1086226204425;5580.135079062752;5593.356763972195;5607.635503692247;5054.595632349403;5089.643724939293;5089.898202036013;5091.541761241432;5128.461511541309;5858.677772722541;5976.491998180029;6097.115918191837;6101.084837274444;6142.600730952474;5903.321118071477;6000.129981152796;6007.48936340416;6010.398960103955;6044.758209671564;6228.28374736893;6255.624662520263;6264.404881536247;6268.686565671789;6268.9969604863;5676.205331253545;5750.741216645345;5776.133579963039;5888.411158884077;5921.733521991435;5943.375945525658;6001.3998600141385;6011.248593925759;6034.607750496204;6043.486303664238;5782.2194003808945;5805.245318108618;5838.678872662044;5843.795467158629;5848.561357898089;5637.49262566371;5732.455416735404;5862.237909071793;5869.882602347844;5874.618149820248;5676.631018983753;5744.684042377709;5762.078067509178;5807.477327040587;5810.680412577349;5838.854028649148;5861.208736820475;5865.736041878211;5870.55970802183;5872.207252020922;5560.277163968658;5623.184638227516;5625.015622266169;5724.398938111605;5732.340780810094 14:19:32 INFO - PROCESS | 2008 | |1;ext.html;587.265917602996;642.075411407573;654.1071437487831;658.8945768677013;672.3377473188905;34668.82665586672;37154.62845371546;37226.813865930664;45171.54828451723;46684.29973550399;46942.29586556196;47561.52438475614;47574.28638570424;47604.76197619007;47620.52379476204;8766.824663506726;8888.644454221823;8912.287017038621;8930.86603700945;8931.64273429062;8234.382421318425;8457.238848503634;8459.238668519833;8680.609372578218;8728.956355218215;10539.789204215911;10844.186685998582;10845.891541084606;11113.666590002313;11127.109831213484;10639.734006649818;10731.678049658523;10732.624358147428;10736.624218152405;10742.78514429707;10598.576056957712;10674.412907290096;10680.359178449318;10682.305650132717;10687.091597214247;43330.56669433297;43342.56657433449;43592.12815743667;43637;43668.344974825406;3624.2207925295925;3661.743677942545;3673.651003154696;3801;3808.2383523295453;31605.562579013862;31964.200894977577;32427;32549.83725081383;33017.834910825535;4354.433923589913;4384.298512238059;4423.137488189805;4428.71213371133;4498.640108791322;369311.9999999973;370057;370531;370989;371090;37944.62055379466;61161.08258376128;61400.692996535625;61527.38472615306;61683;39000.60999390027;41408.1718365631;41515.7924210377;41575.37636935448;41687.791561042606;16642.08468534218;16923.661526769396;16931.492055238363;16944.830551694573;16948.661026779642;13998.44006239739;14254.714905702036;14255.50105746294;14255.501057463147;14271.857281427261;9008.729738107868;9203.723888283363;9219.76950576241;9476.857847132298;9560.952195238979;3626.165981824195;3672.2839046386234;3700.615604295743;3707.7589956652732;3737.794421306854;941.2187884056217;1012.2661070723814;1057.931234469757;1181.9822702659467;1197.868234494205;33701.831490842385;34088.65911340904;34147.97556073322;34348.82825585856;34653.30693386118;1015.6952914125733;1031.159604922001;1079.643717573199;1105.7677887643686;1157.5543415784985;15849.68300634004;18213.90893045526;18302.542436439195;18676.740291842776;18703.345382911804;574796;578012;578133;580369;581141;54259.45740542623;55099;58960.70519647374;59261.11108333379;60146.69926650339;1400.733860566489;1441.0705095213739;1441.1569231999188;1441.4090223008516;1462.0277515452317;32971.505427419084;35104.29791404209;35330;35400.191857488084;35659.46510802288;53147.46852531425;53459.198112027574;53525.197122042424;53601.731991339795;53726.462735372144;476432;480334;480442;480586;480612;30295;31292;31306.373872522876;31336.686633133377;31434.685653143177;49296;49370.50629493659;49430.50569494259;49437.50562494473;49616.503834961186;36474.8176259117;36527.45208821923;36619.267614647026;36723.08192295214;37235.06912327214;36295.27409451849;36391;36581.45127823138;36620.81689591535;36866;43261.617211869554;44287.11425771531;44522;44969;45323.09353812971;31178.77528291019;32052.67947320497;33927.830360849024;34398.656013440544;35145.29709405747;29741;29983.400331993675;30022.24944376408;30542.541861871647;30581.23546911256 14:19:32 INFO - PROCESS | 2008 | |2;jquery.html;390.07886160658785;426.7951383335999;427.02911123963753;434.5285365378564;438.8639521748257;15580.844191558095;19529;20165.697514537274;20180.293689720864;21140.57718845622;20835.479113022182;20873;20914.37256882292;20956.790432095673;21146.365609031753;5716.314042314928;5803.274590676166;5817.8836423271505;5822.301323841145;5825.941740582603;5792.82621521355;5858.3848695886745;5866.589338746289;5866.677332746697;5878.382769809173;5605.7197140143035;5694.971525142369;5745.310562732478;5754.7410366533395;5756.050251708463;5600.4959553640365;5744.16709577111;5770.134479828017;5781.82654520365;5785.566082543805;5207.036698210805;5249.816256431045;5256.632035757499;5259.789608415659;5261.421243663194;24060.87969560141;24211.152609658755;24436.511269774684;24479.26562203137;24524.14165504199;2498.8750562471805;2539.377852426149;2598.2075466982565;2619.6594442722326;3086.5833112529745;10640.0955918747;11003.449827508673;11145;11158.609448669258;11168.553257869675;1933.584279379926;1980.772211195702;2013.476496111007;2014.2748610500355;2037.9184832606677;67598;80665.19334806636;81956.18043819605;88470;93764.99999999932;8973.865392018994;9408.200302974186;9465.90534094664;9527.190188833889;11763.823542646867;12789.232646041268;12889.677758055936;12897;12898.548550800677;12925.095243333064;8041.276285134366;8044.839103217902;8077.232662897015;8119.715809946623;8235.670573177125;8254.339652827759;8455.196756308142;8459.703910363107;8561.229489345864;8779.12208779117;3894.162755007687;3916.823742931575;3952.446657467957;4007.0984028593334;4043.1711499142607;1909.3221906223368;1913.3781521005728;1976.337926794511;1985.2356842615698;2082.854200206001;874.4971641306147;946.4983558713893;981.1464026297167;984.773502094508;1052.5053224984244;20183.293584724463;20198;20749.066292016894;20762.58474830495;21068;913.6436789652041;1007.4106647611229;1027.768752030787;1034.4879284754095;1046.931949423285;10410.895891041144;11089.83365249522;11155.163362747826;11493.54025838957;11609.36148511823;442091;442712;443424;470977;510619;55528.44471555233;56283;89202.55398722965;91255;92407;1032.994835025835;1099.0987390340003;1101.515333253366;1104.5747387255965;1107.1198397274186;17723.847949883217;18418.723719143956;18439.90780046091;18483.722744159117;18570.164342604887;40901.1819763609;41797.73716967222;44094.33858492189;44399;46306.53693463157;60400.697996509734;60768.696156518934;60827;61570;62345.68827155835;7265.4550908681;7719.652615632423;7748.418868584991;7790.415718821225;7944;11817.881821181678;12232.143749937419;12741.681457963625;12774.872251277367;12971.221726696429;11113.777724445305;11450.656480305604;11674.824877626672;11732.296062236293;11797.29216247028;10791;10897.455127243447;11120.165987550805;11235.606753763579;11483.311001339613;11086.833697494705;11376.43117844088;11507.597234097102;11785.764284714429;12107.091968102251;7590.430717696085;7669.9616501917135;7767.572783496736;7843.137254901842;8118.83762324762;11396.48715807774;11661.416929153338;11681.299122052704;11697.766044679229;11753.412329383325 14:19:32 INFO - PROCESS | 2008 | |3;mootools.html;1335.9332033398339;1491.992904789267;1505.638646724786;1652.9669406611868;1772.3530911217401;7252.347288744012;8099.554524501157;8354.624041918121;8360.289375403097;8480.279176270009;8330.91669083309;8397;8398.874016889737;8404.957975210116;8417.368697347692;2371.4427109629223;2388.128333158393;2398.364433425144;2399.7360290368047;2400.9759902401015;2375.239923224569;2435.4033261850873;2436.671049408325;2436.890339934698;2438.500107477963;2056.321413933398;2080.5006798368436;2080.8023237792386;2190.11300423328;2209.9116035358566;2331.4870728439714;2341.988290058556;2354.176038386551;2364.042562762084;2367.4554852383962;2360.480694247263;2386.773256540626;2388.868612226327;2390.8565486070715;2393.9760602393926;8040.276375126266;8279.337652987746;8329.08380078191;8489;8581.270591999624;5093.770780314895;5257.395399529065;5265.552428043621;5267.789288428458;5285.154375299972;3383.813890236036;3395.151212196951;3471.5178647267326;3477.0264325988765;3558.733095017884;1170.3270619393882;1174.618249069056;1191.8033524468453;1218.8049912014035;1229.538922903911;11430.428478576121;11560.884391156065;11586.652400428;11596.072314214927;11620.941895290554;4702.262812331624;4770.141374552614;4784.210605250164;4815.061063092663;4862.95137048625;9842.212622990144;9867.457289848984;9880.950595246977;9906.157976571927;9923.553440095213;5331.360236771612;5340.866478338073;5343;5343.679379237258;5346.4118946915805;4128.318827393507;4275.315949448135;4339.761313127745;4880.975595122072;4913.533214344631;4079.224947260011;4087.379259935145;4186.099988502426;4220.409142720022;4240.915181696349;1339.4709089909431;1353.1204716934071;1354.607163922471;1355.620426280643;1370.5545697648304;811.3711873298123;822.4900561651814;946.1531928923575;951.3007939164709;980.2452111873818;5681.914771278434;5756;5813.970930145322;5870.090136028923;6094.847628809315;493.9654224204271;495.35603715170856;498.72071639881784;502.7084291111147;504.11276153969277;3980.7412518186807;4076.510818701775;4090.202410529918;4141.316682747313;4190.769507677107;9936.751581210528;10210.846837297446;10315.1747860171;10326.432046237529;10333.948330258301;9986.101250887456;10266.230032747573;10295.227857910537;10299.794004120025;10501;7903.24919132693;8060.798480038046;8064.596770161468;8070.798230044295;8084.83830323402;5430.456954304538;5609.074502707171;5639.887202256014;5640;5654.604177707521;9530.380525265835;9597.520123993912;9710.126088652056;9780.266480013885;9788.314817962675;8424.157584241771;8703.390762646808;9467.242620590474;9679.564419601276;9726.027397260217;6712.160979877515;6770.763023294358;6776.45788336922;7470.365018973448;7628.313451789144;8167.0607880092175;8180.9590952044855;8195.679165631984;8219.917800822155;8287.709930152416;7127.928720712726;7149.928500715135;7255.238199988925;7263;7308.817279568053;6955.304469553004;7106.182788979334;7182.784516464514;7363.2268611797135;7383.446241531799;6639.502037347122;6677.232118306457;6735.528513004238;6746.8650626988165;6754.459643228628;5039.798408063783;5088.618353623567;5167.689938603696;5183.896322073613;5304.787808487617;4990.8752281193265;5004.274380214922;5022.874428139179;5027.64806463544;5202.401723801811 14:19:32 INFO - PROCESS | 2008 | |4;prototype.html;328.7573859345152;338.0770496544434;346.5339118885102;346.9514268002479;349.1028057891219;5256.369235691713;5315.601329900259;5320.834103708297;5399.676019438836;5403.162509810981;5125.8462246132585;5237.607179461536;5272.604554658396;5301.3373328333955;5341.4925582069645;4196.412502249687;4220.810063547147;4223.915521689564;4233.618974292313;4252.38340440636;4192.706510544263;4226.197022565702;4235.7246778959425;4251.5535868733805;4264.893377665568;4188.602082802144;4207.747535147885;4208.137331846964;4216.430781844458;4219.43037689911;4193.748375097504;4201.6008479194425;4202.2646036943715;4205.158968206356;4235.618794308496;3574.5531808523933;3684.2631473705364;3685.7235707322056;3703.4444833274956;3790.4080286279827;5167.199084141964;5179.8446046618665;5187.3775146982225;5205.401378841444;5224.843254702365;4724.055188962221;4786.21027530457;4793.71237725734;4800.375716334181;4800.855974320776;5442.530516760453;5618.213450116987;5626.240457538262;5630.605857589971;5671;4053.3312003519386;4074.164796216798;4084.7737982799445;4085.9795701021303;4104.589541045902;5880.852978675524;5893.3222679391565;5893.381194974551;5899.970500147515;5912.733926973254;3992.181602771425;4122.484689413824;4160.355144952538;4167.416561681367;4191.434156388909;4208.789560521962;4213.620774130343;4220.324748040299;4229.111886503869;4236.6187043166265;4786.8085276588545;4802.975985120122;4832.95167048332;4842.201036828954;4857.319975203474;5357.499900027999;5608.439156084441;5694.373618901917;5708.743106560131;5736.196932429463;1315.9932651521594;1349.6828245362333;1374.29223949666;1404.6207523968471;1404.9438022479192;960.644561512245;980.6616717232544;982.5480279071564;985.8274801909637;986.127277359542;5292.623917781405;5302.28419163408;5305.4164041955355;5311.548518375981;5319.547838433777;5553.972230138905;5559.527440167631;5559.833205003856;5561.63849349791;5566.6381685191145;5150.97424512875;5226.980516269379;5294.8941021180135;5317.229001794718;5322.361316642027;2919.562065690121;2931.1646180838784;2939.911802645924;2940.853067303753;2952.320966177791;5662.405447428043;5673.361886722694;5709.714514274269;5720.513756330675;5723.399043100415;5418.539424148913;5562.888742225133;5572.832815015556;5598.081343059793;5598.216249725042;5690.288713910679;5690.5447564194765;5700.038473261044;5707.429257074259;5717.771289148387;5332.9733351333;5448.56411487088;5472.945270547243;5497.752601132878;5520.889582208413;5383.5423988961375;5398.811041613525;5424.511793938565;5469.562435005269;5472.932778108231;5696.601237913306;5730.109064008951;5742.454466825645;5742.626729262584;5743.798967036134;3918.3534716772556;3997.760134391946;4024.7786371749835;4038.8586399475876;4042.6563742081075;5442.945570544244;5483.506484416422;5497.697626630414;5528.364238112507;5537.2524709163745;5401.783928642967;5546.889062218814;5607.80372686954;5619.129034999582;5624.3250809903075;5553.916691249554;5593.384727680033;5597.048501754793;5634.88730225385;5649.774009039593;5363.463653634605;5533.418991005887;5547.5007249347755;5584.246126772996;5621.634593751557;5643.548516118783;5670;5689.776698009948;5693.146028095819;5697.857553561194;5485.518909894386;5558.499735023867;5565.248691426606;5637.49262566371;5638.7462564185535 14:19:32 INFO - PROCESS | 2008 | |5;yui.html;755.3315315945387;827.3381294964028;833.9916600833992;864.6627815152095;877.14478383576;15385.692286154284;15499.38002479901;15799.447019354326;15841.12873791941;15844.683106337867;14328.498502552387;14454.132752034886;14455.710885782304;14469.5659130226;14474.710505789904;725.9637018149072;734.4858598980708;840.4075127035455;842.2882664148784;849.5794581682076;853.8164294676643;853.9573021348939;855.5038077914794;856.1737922904396;856.6830272799042;899.6086702284528;900.0234745301356;900.0549423105746;900.3562452846213;901.0583939782942;755.588204428585;775.7052320118347;885.7741275974586;891.4695756025154;902.4044130873657;624.9781257656006;625.871696302257;625.9123722678829;664.5713514782938;665.4543274514899;14814.185219812905;15149.166795826226;15177.16525591092;15185.772213416698;15190.696186076217;13978.720425591533;13991.65020874476;14378;14868.256587170597;15778.921105394515;13232.206067635876;13305.467781288833;13438.395272212774;13447.394867230998;13796.379162937592;4574.725516469022;4666.113438446684;4673.532646735333;4796;4810.06203790261;67898.66050669715;68976.65511672459;69821.30178698199;70862.64568677124;71419.64290178516;11823.704407389883;11925.522979080914;11933.582324618597;12075.939620301842;12257.325847078497;20979.685304720442;21257.468563285733;21385;21416.250431234832;21425.250116245857;8471.110533394029;8503.489790612583;8581.871271930926;8806;8926.375153739305;4636.211843986531;4667.369905062841;4841.370621819141;4854.150523658345;4938.481459446778;3442.8278586070596;3514.172630232265;3523.6652518010746;3576.088097535164;3576.9821150894077;647.0423772816258;651.1177354684429;657.9967100164564;660.0066899316498;662.8773676869795;705.7953193573807;727.930846569575;732.2787054751066;733.8935854301096;758.7761610324967;9103.726888193365;9289.674861379819;9310.487923164155;9368;9400.717978460658;621.1180124223613;639.3542522052667;731.9414446844239;735.1263405390888;739.2959228977259;4366.628836548865;4566.337881007302;4576.26779715244;4579.885502862388;4713.599344055725;82884.58557707294;83315.5834220825;84564.57717711494;86726;88738.55630721805;51291.7435412828;54617.180742288896;66265.33734662688;70571;72262.63868680623;45174.77412612916;46107.30839037417;48836.511634883194;68393.65803170952;72053.639731801;9476.810463790824;9578.425294482353;9787.36382135159;9797.06927841854;9894.307398482326;44432;45692;45767.313490297005;46742.76628616835;47364;62662.686686566274;62724.372756271856;62990.685046576305;64838.35161648512;65413.018804717016;12807.679808004874;13125.343732813511;13165;13232.470701171846;13242;13344.132631378929;14234.217118058607;14486.637834054232;14606.196659183846;15027.624309392353;10707.196960227859;10853.45732713377;11091.667249982513;12642.24146551173;12828.935855320664;12401.441935113122;12964.675883102998;13368.732625347244;13410.195388276734;13428.865711343153;12371.257724536557;12584.41004690272;12853.97168226521;12958.870411295766;12997.610071697864;11245.437728113398;11266.211365204357;11343.376114313793;11505.252158609663;11871.940640296743;10810.729731756453;10872.238943273895;10908.290961087503;10922.781544368909;10960.28758130719 14:19:32 INFO - PROCESS | 2008 | __end_tp_report 14:19:32 INFO - PROCESS | 2008 | __start_cc_report 14:19:32 INFO - PROCESS | 2008 | _x_x_mozilla_cycle_collect,1095 14:19:32 INFO - PROCESS | 2008 | __end_cc_report 14:19:32 INFO - PROCESS | 2008 | __startTimestamp1483654772071__endTimestamp 14:19:32 INFO - PROCESS | 2008 | 14:19:32 INFO - PROCESS | 2008 | ------- Summary: start ------- 14:19:32 INFO - PROCESS | 2008 | Number of tests: 6 14:19:32 INFO - PROCESS | 2008 | 14:19:32 INFO - PROCESS | 2008 | [#0] dojo.html Cycles:165 Average:5505.25 Median:5725.37 stddev:624.41 (10.9%) stddev-sans-first:599.51 14:19:32 INFO - PROCESS | 2008 | Values: 3197.7 3239.5 3242.1 3264.9 3279.0 5498.1 5528.6 5542.5 5544.3 5558.6 5534.9 5587.0 5587.2 5594.2 5608.4 5003.9 5022.1 5062.1 5088.5 5101.2 4944.4 5052.5 5106.4 5107.7 5114.7 4939.6 4940.1 4954.4 4991.2 4992.7 4976.2 5013.8 5014.5 5065.9 5076.2 4755.0 4958.2 4978.3 5016.9 5027.1 5361.7 5371.4 5385.4 5446.6 5514.4 5856.5 5883.3 5896.2 5899.5 5906.9 5704.9 5953.7 5954.5 5964.3 5977.3 5390.9 5521.8 5559.1 5564.9 5580.2 6030.4 6052.5 6054.7 6056.9 6061.9 5552.8 5818.1 5820.4 5824.6 5871.1 5651.1 5852.4 5922.9 5944.9 6013.5 5942.9 5968.2 5972.3 5981.0 6015.6 5941.8 5973.4 5980.9 5984.5 5992.3 4445.3 4493.5 4533.4 4577.5 4584.3 4087.1 4103.7 4104.0 4132.8 4135.7 5718.8 5725.4 5726.9 5728.7 5730.1 5716.4 5774.4 5782.1 5845.2 6013.8 5568.6 5571.1 5580.1 5593.4 5607.6 5054.6 5089.6 5089.9 5091.5 5128.5 5858.7 5976.5 6097.1 6101.1 6142.6 5903.3 6000.1 6007.5 6010.4 6044.8 6228.3 6255.6 6264.4 6268.7 6269.0 5676.2 5750.7 5776.1 5888.4 5921.7 5943.4 6001.4 6011.2 6034.6 6043.5 5782.2 5805.2 5838.7 5843.8 5848.6 5637.5 5732.5 5862.2 5869.9 5874.6 5676.6 5744.7 5762.1 5807.5 5810.7 5838.9 5861.2 5865.7 5870.6 5872.2 5560.3 5623.2 5625.0 5724.4 5732.3 14:19:32 INFO - PROCESS | 2008 | 14:19:32 INFO - PROCESS | 2008 | [#1] ext.html Cycles:180 Average:62661.44 Median:186878.81 stddev:128650.88 (68.8%) stddev-sans-first:128927.36 14:19:32 INFO - PROCESS | 2008 | Values: 587.3 642.1 654.1 658.9 672.3 34668.8 37154.6 37226.8 45171.5 46684.3 46942.3 47561.5 47574.3 47604.8 47620.5 8766.8 8888.6 8912.3 8930.9 8931.6 8234.4 8457.2 8459.2 8680.6 8729.0 10539.8 10844.2 10845.9 11113.7 11127.1 10639.7 10731.7 10732.6 10736.6 10742.8 10598.6 10674.4 10680.4 10682.3 10687.1 43330.6 43342.6 43592.1 43637.0 43668.3 3624.2 3661.7 3673.7 3801.0 3808.2 31605.6 31964.2 32427.0 32549.8 33017.8 4354.4 4384.3 4423.1 4428.7 4498.6 369312.0 370057.0 370531.0 370989.0 371090.0 37944.6 61161.1 61400.7 61527.4 61683.0 39000.6 41408.2 41515.8 41575.4 41687.8 16642.1 16923.7 16931.5 16944.8 16948.7 13998.4 14254.7 14255.5 14255.5 14271.9 9008.7 9203.7 9219.8 9476.9 9561.0 3626.2 3672.3 3700.6 3707.8 3737.8 941.2 1012.3 1057.9 1182.0 1197.9 33701.8 34088.7 34148.0 34348.8 34653.3 1015.7 1031.2 1079.6 1105.8 1157.6 15849.7 18213.9 18302.5 18676.7 18703.3 574796.0 578012.0 578133.0 580369.0 581141.0 54259.5 55099.0 58960.7 59261.1 60146.7 1400.7 1441.1 1441.2 1441.4 1462.0 32971.5 35104.3 35330.0 35400.2 35659.5 53147.5 53459.2 53525.2 53601.7 53726.5 476432.0 480334.0 480442.0 480586.0 480612.0 30295.0 31292.0 31306.4 31336.7 31434.7 49296.0 49370.5 49430.5 49437.5 49616.5 36474.8 36527.5 36619.3 36723.1 37235.1 36295.3 36391.0 36581.5 36620.8 36866.0 43261.6 44287.1 44522.0 44969.0 45323.1 31178.8 32052.7 33927.8 34398.7 35145.3 29741.0 29983.4 30022.2 30542.5 30581.2 14:19:32 INFO - PROCESS | 2008 | 14:19:32 INFO - PROCESS | 2008 | [#2] jquery.html Cycles:180 Average:27983.01 Median:3490.37 stddev:76312.41 (2186.4%) stddev-sans-first:76498.37 14:19:32 INFO - PROCESS | 2008 | Values: 390.1 426.8 427.0 434.5 438.9 15580.8 19529.0 20165.7 20180.3 21140.6 20835.5 20873.0 20914.4 20956.8 21146.4 5716.3 5803.3 5817.9 5822.3 5825.9 5792.8 5858.4 5866.6 5866.7 5878.4 5605.7 5695.0 5745.3 5754.7 5756.1 5600.5 5744.2 5770.1 5781.8 5785.6 5207.0 5249.8 5256.6 5259.8 5261.4 24060.9 24211.2 24436.5 24479.3 24524.1 2498.9 2539.4 2598.2 2619.7 3086.6 10640.1 11003.4 11145.0 11158.6 11168.6 1933.6 1980.8 2013.5 2014.3 2037.9 67598.0 80665.2 81956.2 88470.0 93765.0 8973.9 9408.2 9465.9 9527.2 11763.8 12789.2 12889.7 12897.0 12898.5 12925.1 8041.3 8044.8 8077.2 8119.7 8235.7 8254.3 8455.2 8459.7 8561.2 8779.1 3894.2 3916.8 3952.4 4007.1 4043.2 1909.3 1913.4 1976.3 1985.2 2082.9 874.5 946.5 981.1 984.8 1052.5 20183.3 20198.0 20749.1 20762.6 21068.0 913.6 1007.4 1027.8 1034.5 1046.9 10410.9 11089.8 11155.2 11493.5 11609.4 442091.0 442712.0 443424.0 470977.0 510619.0 55528.4 56283.0 89202.6 91255.0 92407.0 1033.0 1099.1 1101.5 1104.6 1107.1 17723.8 18418.7 18439.9 18483.7 18570.2 40901.2 41797.7 44094.3 44399.0 46306.5 60400.7 60768.7 60827.0 61570.0 62345.7 7265.5 7719.7 7748.4 7790.4 7944.0 11817.9 12232.1 12741.7 12774.9 12971.2 11113.8 11450.7 11674.8 11732.3 11797.3 10791.0 10897.5 11120.2 11235.6 11483.3 11086.8 11376.4 11507.6 11785.8 12107.1 7590.4 7670.0 7767.6 7843.1 8118.8 11396.5 11661.4 11681.3 11697.8 11753.4 14:19:32 INFO - PROCESS | 2008 | 14:19:32 INFO - PROCESS | 2008 | [#3] mootools.html Cycles:180 Average:5570.03 Median:5175.79 stddev:3069.66 (59.3%) stddev-sans-first:3061.78 14:19:32 INFO - PROCESS | 2008 | Values: 1335.9 1492.0 1505.6 1653.0 1772.4 7252.3 8099.6 8354.6 8360.3 8480.3 8330.9 8397.0 8398.9 8405.0 8417.4 2371.4 2388.1 2398.4 2399.7 2401.0 2375.2 2435.4 2436.7 2436.9 2438.5 2056.3 2080.5 2080.8 2190.1 2209.9 2331.5 2342.0 2354.2 2364.0 2367.5 2360.5 2386.8 2388.9 2390.9 2394.0 8040.3 8279.3 8329.1 8489.0 8581.3 5093.8 5257.4 5265.6 5267.8 5285.2 3383.8 3395.2 3471.5 3477.0 3558.7 1170.3 1174.6 1191.8 1218.8 1229.5 11430.4 11560.9 11586.7 11596.1 11620.9 4702.3 4770.1 4784.2 4815.1 4863.0 9842.2 9867.5 9881.0 9906.2 9923.6 5331.4 5340.9 5343.0 5343.7 5346.4 4128.3 4275.3 4339.8 4881.0 4913.5 4079.2 4087.4 4186.1 4220.4 4240.9 1339.5 1353.1 1354.6 1355.6 1370.6 811.4 822.5 946.2 951.3 980.2 5681.9 5756.0 5814.0 5870.1 6094.8 494.0 495.4 498.7 502.7 504.1 3980.7 4076.5 4090.2 4141.3 4190.8 9936.8 10210.8 10315.2 10326.4 10333.9 9986.1 10266.2 10295.2 10299.8 10501.0 7903.2 8060.8 8064.6 8070.8 8084.8 5430.5 5609.1 5639.9 5640.0 5654.6 9530.4 9597.5 9710.1 9780.3 9788.3 8424.2 8703.4 9467.2 9679.6 9726.0 6712.2 6770.8 6776.5 7470.4 7628.3 8167.1 8181.0 8195.7 8219.9 8287.7 7127.9 7149.9 7255.2 7263.0 7308.8 6955.3 7106.2 7182.8 7363.2 7383.4 6639.5 6677.2 6735.5 6746.9 6754.5 5039.8 5088.6 5167.7 5183.9 5304.8 4990.9 5004.3 5022.9 5027.6 5202.4 14:19:32 INFO - PROCESS | 2008 | 14:19:32 INFO - PROCESS | 2008 | [#4] prototype.html Cycles:180 Average:4674.34 Median:5321.60 stddev:1352.29 (25.4%) stddev-sans-first:1316.16 14:19:32 INFO - PROCESS | 2008 | Values: 328.8 338.1 346.5 347.0 349.1 5256.4 5315.6 5320.8 5399.7 5403.2 5125.8 5237.6 5272.6 5301.3 5341.5 4196.4 4220.8 4223.9 4233.6 4252.4 4192.7 4226.2 4235.7 4251.6 4264.9 4188.6 4207.7 4208.1 4216.4 4219.4 4193.7 4201.6 4202.3 4205.2 4235.6 3574.6 3684.3 3685.7 3703.4 3790.4 5167.2 5179.8 5187.4 5205.4 5224.8 4724.1 4786.2 4793.7 4800.4 4800.9 5442.5 5618.2 5626.2 5630.6 5671.0 4053.3 4074.2 4084.8 4086.0 4104.6 5880.9 5893.3 5893.4 5900.0 5912.7 3992.2 4122.5 4160.4 4167.4 4191.4 4208.8 4213.6 4220.3 4229.1 4236.6 4786.8 4803.0 4833.0 4842.2 4857.3 5357.5 5608.4 5694.4 5708.7 5736.2 1316.0 1349.7 1374.3 1404.6 1404.9 960.6 980.7 982.5 985.8 986.1 5292.6 5302.3 5305.4 5311.5 5319.5 5554.0 5559.5 5559.8 5561.6 5566.6 5151.0 5227.0 5294.9 5317.2 5322.4 2919.6 2931.2 2939.9 2940.9 2952.3 5662.4 5673.4 5709.7 5720.5 5723.4 5418.5 5562.9 5572.8 5598.1 5598.2 5690.3 5690.5 5700.0 5707.4 5717.8 5333.0 5448.6 5472.9 5497.8 5520.9 5383.5 5398.8 5424.5 5469.6 5472.9 5696.6 5730.1 5742.5 5742.6 5743.8 3918.4 3997.8 4024.8 4038.9 4042.7 5442.9 5483.5 5497.7 5528.4 5537.3 5401.8 5546.9 5607.8 5619.1 5624.3 5553.9 5593.4 5597.0 5634.9 5649.8 5363.5 5533.4 5547.5 5584.2 5621.6 5643.5 5670.0 5689.8 5693.1 5697.9 5485.5 5558.5 5565.2 5637.5 5638.7 14:19:32 INFO - PROCESS | 2008 | 14:19:32 INFO - PROCESS | 2008 | [#5] yui.html Cycles:180 Average:17497.53 Median:26038.80 stddev:22260.46 (85.5%) stddev-sans-first:22287.40 14:19:32 INFO - PROCESS | 2008 | Values: 755.3 827.3 834.0 864.7 877.1 15385.7 15499.4 15799.4 15841.1 15844.7 14328.5 14454.1 14455.7 14469.6 14474.7 726.0 734.5 840.4 842.3 849.6 853.8 854.0 855.5 856.2 856.7 899.6 900.0 900.1 900.4 901.1 755.6 775.7 885.8 891.5 902.4 625.0 625.9 625.9 664.6 665.5 14814.2 15149.2 15177.2 15185.8 15190.7 13978.7 13991.7 14378.0 14868.3 15778.9 13232.2 13305.5 13438.4 13447.4 13796.4 4574.7 4666.1 4673.5 4796.0 4810.1 67898.7 68976.7 69821.3 70862.6 71419.6 11823.7 11925.5 11933.6 12075.9 12257.3 20979.7 21257.5 21385.0 21416.3 21425.3 8471.1 8503.5 8581.9 8806.0 8926.4 4636.2 4667.4 4841.4 4854.2 4938.5 3442.8 3514.2 3523.7 3576.1 3577.0 647.0 651.1 658.0 660.0 662.9 705.8 727.9 732.3 733.9 758.8 9103.7 9289.7 9310.5 9368.0 9400.7 621.1 639.4 731.9 735.1 739.3 4366.6 4566.3 4576.3 4579.9 4713.6 82884.6 83315.6 84564.6 86726.0 88738.6 51291.7 54617.2 66265.3 70571.0 72262.6 45174.8 46107.3 48836.5 68393.7 72053.6 9476.8 9578.4 9787.4 9797.1 9894.3 44432.0 45692.0 45767.3 46742.8 47364.0 62662.7 62724.4 62990.7 64838.4 65413.0 12807.7 13125.3 13165.0 13232.5 13242.0 13344.1 14234.2 14486.6 14606.2 15027.6 10707.2 10853.5 11091.7 12642.2 12828.9 12401.4 12964.7 13368.7 13410.2 13428.9 12371.3 12584.4 12854.0 12958.9 12997.6 11245.4 11266.2 11343.4 11505.3 11871.9 10810.7 10872.2 10908.3 10922.8 10960.3 14:19:32 INFO - PROCESS | 2008 | -------- Summary: end -------- 14:19:32 INFO - PROCESS | 2008 | 14:19:32 INFO - TEST-INFO | 2008: exit 0 14:19:32 INFO - TEST-OK | dromaeo_css | took 1116360ms 14:19:32 INFO - TEST-START | kraken 14:19:32 INFO - operating with platform_type : linux_ 14:19:32 INFO - Initialising browser for kraken test... 14:19:32 INFO - TEST-INFO | started process 2327 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjObAD8/profile http://localhost:46761/getInfo.html) 14:19:36 INFO - PROCESS | 2327 | __metrics Screen width/height:1600/1200 14:19:36 INFO - PROCESS | 2327 | colorDepth:24 14:19:36 INFO - PROCESS | 2327 | Browser inner width/height: 1024/697 14:19:36 INFO - PROCESS | 2327 | __metrics 14:19:37 INFO - PROCESS | 2327 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 14:19:37 INFO - PROCESS | 2327 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:19:38 INFO - PROCESS | 2327 | console.error: PushService: 14:19:38 INFO - PROCESS | 2327 | stateChangeProcessEnqueue: Error transitioning state 14:19:38 INFO - PROCESS | 2327 | UnknownError 14:19:38 INFO - TEST-INFO | 2327: exit 0 14:19:38 INFO - Browser initialized. 14:19:38 INFO - Running cycle 1/1 for kraken test... 14:19:38 INFO - TEST-INFO | started process 2495 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjObAD8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:19:50 INFO - PROCESS | 2495 | RSS: Main: 144789504 14:19:50 INFO - PROCESS | 2495 | 14:19:52 INFO - PROCESS | 2495 | Cycle 1(1): loaded http://localhost:46761/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46761/tests/kraken/driver.html?testName=audio-beat-detection) 14:19:53 INFO - PROCESS | 2495 | RSS: Main: 186122240 14:19:53 INFO - PROCESS | 2495 | 14:19:56 INFO - PROCESS | 2495 | Cycle 1(1): loaded http://localhost:46761/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46761/tests/kraken/driver.html?testName=audio-dft) 14:19:56 INFO - PROCESS | 2495 | RSS: Main: 174850048 14:19:56 INFO - PROCESS | 2495 | 14:19:59 INFO - PROCESS | 2495 | Cycle 1(1): loaded http://localhost:46761/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46761/tests/kraken/driver.html?testName=audio-fft) 14:20:00 INFO - PROCESS | 2495 | RSS: Main: 266747904 14:20:00 INFO - PROCESS | 2495 | 14:20:02 INFO - PROCESS | 2495 | Cycle 1(1): loaded http://localhost:46761/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46761/tests/kraken/driver.html?testName=audio-oscillator) 14:20:02 INFO - PROCESS | 2495 | RSS: Main: 172527616 14:20:02 INFO - PROCESS | 2495 | 14:20:04 INFO - PROCESS | 2495 | Cycle 1(1): loaded http://localhost:46761/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46761/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:20:05 INFO - PROCESS | 2495 | RSS: Main: 175722496 14:20:05 INFO - PROCESS | 2495 | 14:20:08 INFO - PROCESS | 2495 | Cycle 1(1): loaded http://localhost:46761/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46761/tests/kraken/driver.html?testName=imaging-darkroom) 14:20:09 INFO - PROCESS | 2495 | RSS: Main: 213393408 14:20:09 INFO - PROCESS | 2495 | 14:20:12 INFO - PROCESS | 2495 | Cycle 1(1): loaded http://localhost:46761/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46761/tests/kraken/driver.html?testName=imaging-desaturate) 14:20:12 INFO - PROCESS | 2495 | RSS: Main: 213155840 14:20:12 INFO - PROCESS | 2495 | 14:20:15 INFO - PROCESS | 2495 | Cycle 1(1): loaded http://localhost:46761/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46761/tests/kraken/driver.html?testName=json-parse-financial) 14:20:16 INFO - PROCESS | 2495 | RSS: Main: 211832832 14:20:16 INFO - PROCESS | 2495 | 14:20:17 INFO - PROCESS | 2495 | Cycle 1(1): loaded http://localhost:46761/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46761/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:20:18 INFO - PROCESS | 2495 | RSS: Main: 173785088 14:20:18 INFO - PROCESS | 2495 | 14:20:19 INFO - PROCESS | 2495 | Cycle 1(1): loaded http://localhost:46761/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46761/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:20:20 INFO - PROCESS | 2495 | RSS: Main: 180674560 14:20:20 INFO - PROCESS | 2495 | 14:20:22 INFO - PROCESS | 2495 | Cycle 1(1): loaded http://localhost:46761/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46761/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:20:23 INFO - PROCESS | 2495 | RSS: Main: 189517824 14:20:23 INFO - PROCESS | 2495 | 14:20:25 INFO - PROCESS | 2495 | Cycle 1(1): loaded http://localhost:46761/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46761/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:20:26 INFO - PROCESS | 2495 | RSS: Main: 198754304 14:20:26 INFO - PROCESS | 2495 | 14:20:29 INFO - PROCESS | 2495 | Cycle 1(1): loaded http://localhost:46761/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46761/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:20:29 INFO - PROCESS | 2495 | RSS: Main: 195276800 14:20:29 INFO - PROCESS | 2495 | 14:20:31 INFO - PROCESS | 2495 | Cycle 1(1): loaded http://localhost:46761/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46761/tests/kraken/driver.html?testName=ai-astar) 14:20:31 INFO - PROCESS | 2495 | RSS: Main: 246067200 14:20:31 INFO - PROCESS | 2495 | 14:20:31 INFO - PROCESS | 2495 | __start_tp_report 14:20:31 INFO - PROCESS | 2495 | _x_x_mozilla_page_load 14:20:31 INFO - PROCESS | 2495 | _x_x_mozilla_page_load_details 14:20:31 INFO - PROCESS | 2495 | |i|pagename|runs| 14:20:31 INFO - PROCESS | 2495 | |0;ai-astar;101;110;109;110;112;111;110;110;110;111 14:20:31 INFO - PROCESS | 2495 | |1;audio-beat-detection;147;118;119;146;118;120;122;118;148;118 14:20:31 INFO - PROCESS | 2495 | |2;audio-dft;166;163;160;160;160;160;162;161;160;160 14:20:31 INFO - PROCESS | 2495 | |3;audio-fft;73;75;75;111;76;76;75;76;103;75 14:20:31 INFO - PROCESS | 2495 | |4;audio-oscillator;81;81;114;83;83;82;99;82;82;105 14:20:31 INFO - PROCESS | 2495 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;116;117;116 14:20:31 INFO - PROCESS | 2495 | |6;imaging-darkroom;147;146;147;145;146;146;146;146;146;146 14:20:31 INFO - PROCESS | 2495 | |7;imaging-desaturate;85;85;84;85;85;84;85;84;84;85 14:20:31 INFO - PROCESS | 2495 | |8;json-parse-financial;51;51;51;51;50;52;50;50;50;50 14:20:31 INFO - PROCESS | 2495 | |9;json-stringify-tinderbox;61;62;60;60;62;59;60;61;61;61 14:20:31 INFO - PROCESS | 2495 | |10;stanford-crypto-aes;75;75;81;81;75;83;76;76;75;75 14:20:31 INFO - PROCESS | 2495 | |11;stanford-crypto-ccm;140;131;129;122;122;120;122;133;164;140 14:20:31 INFO - PROCESS | 2495 | |12;stanford-crypto-pbkdf2;159;152;155;153;158;159;155;160;158;154 14:20:31 INFO - PROCESS | 2495 | |13;stanford-crypto-sha256-iterative;62;66;62;62;62;66;61;64;62;62 14:20:31 INFO - PROCESS | 2495 | __end_tp_report 14:20:31 INFO - PROCESS | 2495 | __start_cc_report 14:20:31 INFO - PROCESS | 2495 | _x_x_mozilla_cycle_collect,1614 14:20:31 INFO - PROCESS | 2495 | __end_cc_report 14:20:31 INFO - PROCESS | 2495 | __startTimestamp1483654831555__endTimestamp 14:20:31 INFO - PROCESS | 2495 | 14:20:31 INFO - PROCESS | 2495 | ------- Summary: start ------- 14:20:31 INFO - PROCESS | 2495 | Number of tests: 14 14:20:31 INFO - PROCESS | 2495 | 14:20:31 INFO - PROCESS | 2495 | [#0] ai-astar Cycles:10 Average:109.40 Median:110.00 stddev:3.06 (2.8%) stddev-sans-first:0.87 14:20:31 INFO - PROCESS | 2495 | Values: 101.0 110.0 109.0 110.0 112.0 111.0 110.0 110.0 110.0 111.0 14:20:31 INFO - PROCESS | 2495 | 14:20:31 INFO - PROCESS | 2495 | [#1] audio-beat-detection Cycles:10 Average:127.40 Median:121.00 stddev:13.59 (11.2%) stddev-sans-first:12.43 14:20:31 INFO - PROCESS | 2495 | Values: 147.0 118.0 119.0 146.0 118.0 120.0 122.0 118.0 148.0 118.0 14:20:31 INFO - PROCESS | 2495 | 14:20:31 INFO - PROCESS | 2495 | [#2] audio-dft Cycles:10 Average:161.20 Median:160.50 stddev:1.99 (1.2%) stddev-sans-first:1.12 14:20:31 INFO - PROCESS | 2495 | Values: 166.0 163.0 160.0 160.0 160.0 160.0 162.0 161.0 160.0 160.0 14:20:31 INFO - PROCESS | 2495 | 14:20:31 INFO - PROCESS | 2495 | [#3] audio-fft Cycles:10 Average:81.50 Median:75.00 stddev:13.60 (18.1%) stddev-sans-first:14.07 14:20:31 INFO - PROCESS | 2495 | Values: 73.0 75.0 75.0 111.0 76.0 76.0 75.0 76.0 103.0 75.0 14:20:31 INFO - PROCESS | 2495 | 14:20:31 INFO - PROCESS | 2495 | [#4] audio-oscillator Cycles:10 Average:89.20 Median:82.00 stddev:12.15 (14.8%) stddev-sans-first:12.51 14:20:31 INFO - PROCESS | 2495 | Values: 81.0 81.0 114.0 83.0 83.0 82.0 99.0 82.0 82.0 105.0 14:20:31 INFO - PROCESS | 2495 | 14:20:31 INFO - PROCESS | 2495 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 14:20:31 INFO - PROCESS | 2495 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 116.0 117.0 116.0 14:20:31 INFO - PROCESS | 2495 | 14:20:31 INFO - PROCESS | 2495 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.57 (0.4%) stddev-sans-first:0.50 14:20:31 INFO - PROCESS | 2495 | Values: 147.0 146.0 147.0 145.0 146.0 146.0 146.0 146.0 146.0 146.0 14:20:31 INFO - PROCESS | 2495 | 14:20:31 INFO - PROCESS | 2495 | [#7] imaging-desaturate Cycles:10 Average:84.60 Median:85.00 stddev:0.52 (0.6%) stddev-sans-first:0.53 14:20:31 INFO - PROCESS | 2495 | Values: 85.0 85.0 84.0 85.0 85.0 84.0 85.0 84.0 84.0 85.0 14:20:31 INFO - PROCESS | 2495 | 14:20:31 INFO - PROCESS | 2495 | [#8] json-parse-financial Cycles:10 Average:50.60 Median:51.00 stddev:0.70 (1.4%) stddev-sans-first:0.73 14:20:31 INFO - PROCESS | 2495 | Values: 51.0 51.0 51.0 51.0 50.0 52.0 50.0 50.0 50.0 50.0 14:20:31 INFO - PROCESS | 2495 | 14:20:31 INFO - PROCESS | 2495 | [#9] json-stringify-tinderbox Cycles:10 Average:60.70 Median:61.00 stddev:0.95 (1.6%) stddev-sans-first:1.00 14:20:31 INFO - PROCESS | 2495 | Values: 61.0 62.0 60.0 60.0 62.0 59.0 60.0 61.0 61.0 61.0 14:20:31 INFO - PROCESS | 2495 | 14:20:31 INFO - PROCESS | 2495 | [#10] stanford-crypto-aes Cycles:10 Average:77.20 Median:76.00 stddev:3.16 (4.2%) stddev-sans-first:3.24 14:20:31 INFO - PROCESS | 2495 | Values: 75.0 75.0 81.0 81.0 75.0 83.0 76.0 76.0 75.0 75.0 14:20:31 INFO - PROCESS | 2495 | 14:20:31 INFO - PROCESS | 2495 | [#11] stanford-crypto-ccm Cycles:10 Average:132.30 Median:132.00 stddev:13.36 (10.1%) stddev-sans-first:13.88 14:20:31 INFO - PROCESS | 2495 | Values: 140.0 131.0 129.0 122.0 122.0 120.0 122.0 133.0 164.0 140.0 14:20:31 INFO - PROCESS | 2495 | 14:20:31 INFO - PROCESS | 2495 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:156.30 Median:158.00 stddev:2.83 (1.8%) stddev-sans-first:2.83 14:20:31 INFO - PROCESS | 2495 | Values: 159.0 152.0 155.0 153.0 158.0 159.0 155.0 160.0 158.0 154.0 14:20:31 INFO - PROCESS | 2495 | 14:20:31 INFO - PROCESS | 2495 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.90 Median:62.00 stddev:1.79 (2.9%) stddev-sans-first:1.87 14:20:31 INFO - PROCESS | 2495 | Values: 62.0 66.0 62.0 62.0 62.0 66.0 61.0 64.0 62.0 62.0 14:20:31 INFO - PROCESS | 2495 | -------- Summary: end -------- 14:20:31 INFO - PROCESS | 2495 | 14:20:32 INFO - TEST-INFO | 2495: exit 0 14:20:32 INFO - TEST-OK | kraken | took 59779ms 14:20:32 INFO - SUITE-END | took 1176s 14:20:32 INFO - Completed test suite (00:19:36) 14:20:32 INFO - javascript benchmark 14:20:32 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3197.6642452542483, 3239.465488194448, 3242.059802657231, 3264.9347013059723, 3278.967210327896, 5498.120300751875, 5528.640638358504, 5542.473465020827, 5544.306961629796, 5558.638688485245, 5534.889302213964, 5586.972065139679, 5587.217789509472, 5594.216809646653, 5608.355039170497, 5003.924941125895, 5022.146235140017, 5062.063518249117, 5088.491150884919, 5101.20931255656, 4944.4313903900975, 5052.4947505249365, 5106.4382917879, 5107.744612769366, 5114.667546609458, 4939.60483161348, 4940.061388336205, 4954.430240522332, 4991.226359914201, 4992.67547609406, 4976.2286845539, 5013.824516141954, 5014.498550144993, 5065.8733531662, 5076.213186956028, 4755.0489902019735, 4958.231474121517, 4978.278149668277, 5016.924746128811, 5027.145385284474, 5361.678299302015, 5371.435999220064, 5385.407605163429, 5446.564274858041, 5514.420985796473, 5856.531477481792, 5883.323417806964, 5896.204012458349, 5899.528037756969, 5906.881862362771, 5704.942950570524, 5953.7320820562745, 5954.523638108984, 5964.343922168601, 5977.342492325841, 5390.865228369283, 5521.834344969658, 5559.054960656698, 5564.916526252109, 5580.19087232349, 6030.427109424598, 6052.515798736091, 6054.697265136726, 6056.939430605637, 6061.878762424815, 5552.805651802168, 5818.127280907897, 5820.3888591698105, 5824.592278540546, 5871.089981052944, 5651.0675738503505, 5852.385499522489, 5922.940770592325, 5944.940550594525, 6013.458788709037, 5942.910856337158, 5968.1644569760265, 5972.25346831646, 5981.0, 6015.639061656227, 5941.792037278675, 5973.37279585646, 5980.850478738066, 5984.491318237999, 5992.250968628921, 4445.2887537993765, 4493.460784705856, 4533.410656614619, 4577.519360467103, 4584.33527138563, 4087.141700242923, 4103.733257338264, 4103.97948010258, 4132.8140233689555, 4135.669146468275, 5718.828435146952, 5725.370209276976, 5726.885462290731, 5728.656280623176, 5730.111832665943, 5716.428357164334, 5774.422557744192, 5782.132680098019, 5845.210896528914, 6013.849653758691, 5568.582356323211, 5571.1086226204425, 5580.135079062752, 5593.356763972195, 5607.635503692247, 5054.595632349403, 5089.643724939293, 5089.898202036013, 5091.541761241432, 5128.461511541309, 5858.677772722541, 5976.491998180029, 6097.115918191837, 6101.084837274444, 6142.600730952474, 5903.321118071477, 6000.129981152796, 6007.48936340416, 6010.398960103955, 6044.758209671564, 6228.28374736893, 6255.624662520263, 6264.404881536247, 6268.686565671789, 6268.9969604863, 5676.205331253545, 5750.741216645345, 5776.133579963039, 5888.411158884077, 5921.733521991435, 5943.375945525658, 6001.3998600141385, 6011.248593925759, 6034.607750496204, 6043.486303664238, 5782.2194003808945, 5805.245318108618, 5838.678872662044, 5843.795467158629, 5848.561357898089, 5637.49262566371, 5732.455416735404, 5862.237909071793, 5869.882602347844, 5874.618149820248, 5676.631018983753, 5744.684042377709, 5762.078067509178, 5807.477327040587, 5810.680412577349, 5838.854028649148, 5861.208736820475, 5865.736041878211, 5870.55970802183, 5872.207252020922, 5560.277163968658, 5623.184638227516, 5625.015622266169, 5724.398938111605, 5732.340780810094], "value": 5463.686682749667, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [587.265917602996, 642.075411407573, 654.1071437487831, 658.8945768677013, 672.3377473188905, 34668.82665586672, 37154.62845371546, 37226.813865930664, 45171.54828451723, 46684.29973550399, 46942.29586556196, 47561.52438475614, 47574.28638570424, 47604.76197619007, 47620.52379476204, 8766.824663506726, 8888.644454221823, 8912.287017038621, 8930.86603700945, 8931.64273429062, 8234.382421318425, 8457.238848503634, 8459.238668519833, 8680.609372578218, 8728.956355218215, 10539.789204215911, 10844.186685998582, 10845.891541084606, 11113.666590002313, 11127.109831213484, 10639.734006649818, 10731.678049658523, 10732.624358147428, 10736.624218152405, 10742.78514429707, 10598.576056957712, 10674.412907290096, 10680.359178449318, 10682.305650132717, 10687.091597214247, 43330.56669433297, 43342.56657433449, 43592.12815743667, 43637.0, 43668.344974825406, 3624.2207925295925, 3661.743677942545, 3673.651003154696, 3801.0, 3808.2383523295453, 31605.562579013862, 31964.200894977577, 32427.0, 32549.83725081383, 33017.834910825535, 4354.433923589913, 4384.298512238059, 4423.137488189805, 4428.71213371133, 4498.640108791322, 369311.9999999973, 370057.0, 370531.0, 370989.0, 371090.0, 37944.62055379466, 61161.08258376128, 61400.692996535625, 61527.38472615306, 61683.0, 39000.60999390027, 41408.1718365631, 41515.7924210377, 41575.37636935448, 41687.791561042606, 16642.08468534218, 16923.661526769396, 16931.492055238363, 16944.830551694573, 16948.661026779642, 13998.44006239739, 14254.714905702036, 14255.50105746294, 14255.501057463147, 14271.857281427261, 9008.729738107868, 9203.723888283363, 9219.76950576241, 9476.857847132298, 9560.952195238979, 3626.165981824195, 3672.2839046386234, 3700.615604295743, 3707.7589956652732, 3737.794421306854, 941.2187884056217, 1012.2661070723814, 1057.931234469757, 1181.9822702659467, 1197.868234494205, 33701.831490842385, 34088.65911340904, 34147.97556073322, 34348.82825585856, 34653.30693386118, 1015.6952914125733, 1031.159604922001, 1079.643717573199, 1105.7677887643686, 1157.5543415784985, 15849.68300634004, 18213.90893045526, 18302.542436439195, 18676.740291842776, 18703.345382911804, 574796.0, 578012.0, 578133.0, 580369.0, 581141.0, 54259.45740542623, 55099.0, 58960.70519647374, 59261.11108333379, 60146.69926650339, 1400.733860566489, 1441.0705095213739, 1441.1569231999188, 1441.4090223008516, 1462.0277515452317, 32971.505427419084, 35104.29791404209, 35330.0, 35400.191857488084, 35659.46510802288, 53147.46852531425, 53459.198112027574, 53525.197122042424, 53601.731991339795, 53726.462735372144, 476432.0, 480334.0, 480442.0, 480586.0, 480612.0, 30295.0, 31292.0, 31306.373872522876, 31336.686633133377, 31434.685653143177, 49296.0, 49370.50629493659, 49430.50569494259, 49437.50562494473, 49616.503834961186, 36474.8176259117, 36527.45208821923, 36619.267614647026, 36723.08192295214, 37235.06912327214, 36295.27409451849, 36391.0, 36581.45127823138, 36620.81689591535, 36866.0, 43261.617211869554, 44287.11425771531, 44522.0, 44969.0, 45323.09353812971, 31178.77528291019, 32052.67947320497, 33927.830360849024, 34398.656013440544, 35145.29709405747, 29741.0, 29983.400331993675, 30022.24944376408, 30542.541861871647, 30581.23546911256], "value": 19861.967780338513, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [390.07886160658785, 426.7951383335999, 427.02911123963753, 434.5285365378564, 438.8639521748257, 15580.844191558095, 19529.0, 20165.697514537274, 20180.293689720864, 21140.57718845622, 20835.479113022182, 20873.0, 20914.37256882292, 20956.790432095673, 21146.365609031753, 5716.314042314928, 5803.274590676166, 5817.8836423271505, 5822.301323841145, 5825.941740582603, 5792.82621521355, 5858.3848695886745, 5866.589338746289, 5866.677332746697, 5878.382769809173, 5605.7197140143035, 5694.971525142369, 5745.310562732478, 5754.7410366533395, 5756.050251708463, 5600.4959553640365, 5744.16709577111, 5770.134479828017, 5781.82654520365, 5785.566082543805, 5207.036698210805, 5249.816256431045, 5256.632035757499, 5259.789608415659, 5261.421243663194, 24060.87969560141, 24211.152609658755, 24436.511269774684, 24479.26562203137, 24524.14165504199, 2498.8750562471805, 2539.377852426149, 2598.2075466982565, 2619.6594442722326, 3086.5833112529745, 10640.0955918747, 11003.449827508673, 11145.0, 11158.609448669258, 11168.553257869675, 1933.584279379926, 1980.772211195702, 2013.476496111007, 2014.2748610500355, 2037.9184832606677, 67598.0, 80665.19334806636, 81956.18043819605, 88470.0, 93764.99999999932, 8973.865392018994, 9408.200302974186, 9465.90534094664, 9527.190188833889, 11763.823542646867, 12789.232646041268, 12889.677758055936, 12897.0, 12898.548550800677, 12925.095243333064, 8041.276285134366, 8044.839103217902, 8077.232662897015, 8119.715809946623, 8235.670573177125, 8254.339652827759, 8455.196756308142, 8459.703910363107, 8561.229489345864, 8779.12208779117, 3894.162755007687, 3916.823742931575, 3952.446657467957, 4007.0984028593334, 4043.1711499142607, 1909.3221906223368, 1913.3781521005728, 1976.337926794511, 1985.2356842615698, 2082.854200206001, 874.4971641306147, 946.4983558713893, 981.1464026297167, 984.773502094508, 1052.5053224984244, 20183.293584724463, 20198.0, 20749.066292016894, 20762.58474830495, 21068.0, 913.6436789652041, 1007.4106647611229, 1027.768752030787, 1034.4879284754095, 1046.931949423285, 10410.895891041144, 11089.83365249522, 11155.163362747826, 11493.54025838957, 11609.36148511823, 442091.0, 442712.0, 443424.0, 470977.0, 510619.0, 55528.44471555233, 56283.0, 89202.55398722965, 91255.0, 92407.0, 1032.994835025835, 1099.0987390340003, 1101.515333253366, 1104.5747387255965, 1107.1198397274186, 17723.847949883217, 18418.723719143956, 18439.90780046091, 18483.722744159117, 18570.164342604887, 40901.1819763609, 41797.73716967222, 44094.33858492189, 44399.0, 46306.53693463157, 60400.697996509734, 60768.696156518934, 60827.0, 61570.0, 62345.68827155835, 7265.4550908681, 7719.652615632423, 7748.418868584991, 7790.415718821225, 7944.0, 11817.881821181678, 12232.143749937419, 12741.681457963625, 12774.872251277367, 12971.221726696429, 11113.777724445305, 11450.656480305604, 11674.824877626672, 11732.296062236293, 11797.29216247028, 10791.0, 10897.455127243447, 11120.165987550805, 11235.606753763579, 11483.311001339613, 11086.833697494705, 11376.43117844088, 11507.597234097102, 11785.764284714429, 12107.091968102251, 7590.430717696085, 7669.9616501917135, 7767.572783496736, 7843.137254901842, 8118.83762324762, 11396.48715807774, 11661.416929153338, 11681.299122052704, 11697.766044679229, 11753.412329383325], "value": 9170.27716652518, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1335.9332033398339, 1491.992904789267, 1505.638646724786, 1652.9669406611868, 1772.3530911217401, 7252.347288744012, 8099.554524501157, 8354.624041918121, 8360.289375403097, 8480.279176270009, 8330.91669083309, 8397.0, 8398.874016889737, 8404.957975210116, 8417.368697347692, 2371.4427109629223, 2388.128333158393, 2398.364433425144, 2399.7360290368047, 2400.9759902401015, 2375.239923224569, 2435.4033261850873, 2436.671049408325, 2436.890339934698, 2438.500107477963, 2056.321413933398, 2080.5006798368436, 2080.8023237792386, 2190.11300423328, 2209.9116035358566, 2331.4870728439714, 2341.988290058556, 2354.176038386551, 2364.042562762084, 2367.4554852383962, 2360.480694247263, 2386.773256540626, 2388.868612226327, 2390.8565486070715, 2393.9760602393926, 8040.276375126266, 8279.337652987746, 8329.08380078191, 8489.0, 8581.270591999624, 5093.770780314895, 5257.395399529065, 5265.552428043621, 5267.789288428458, 5285.154375299972, 3383.813890236036, 3395.151212196951, 3471.5178647267326, 3477.0264325988765, 3558.733095017884, 1170.3270619393882, 1174.618249069056, 1191.8033524468453, 1218.8049912014035, 1229.538922903911, 11430.428478576121, 11560.884391156065, 11586.652400428, 11596.072314214927, 11620.941895290554, 4702.262812331624, 4770.141374552614, 4784.210605250164, 4815.061063092663, 4862.95137048625, 9842.212622990144, 9867.457289848984, 9880.950595246977, 9906.157976571927, 9923.553440095213, 5331.360236771612, 5340.866478338073, 5343.0, 5343.679379237258, 5346.4118946915805, 4128.318827393507, 4275.315949448135, 4339.761313127745, 4880.975595122072, 4913.533214344631, 4079.224947260011, 4087.379259935145, 4186.099988502426, 4220.409142720022, 4240.915181696349, 1339.4709089909431, 1353.1204716934071, 1354.607163922471, 1355.620426280643, 1370.5545697648304, 811.3711873298123, 822.4900561651814, 946.1531928923575, 951.3007939164709, 980.2452111873818, 5681.914771278434, 5756.0, 5813.970930145322, 5870.090136028923, 6094.847628809315, 493.9654224204271, 495.35603715170856, 498.72071639881784, 502.7084291111147, 504.11276153969277, 3980.7412518186807, 4076.510818701775, 4090.202410529918, 4141.316682747313, 4190.769507677107, 9936.751581210528, 10210.846837297446, 10315.1747860171, 10326.432046237529, 10333.948330258301, 9986.101250887456, 10266.230032747573, 10295.227857910537, 10299.794004120025, 10501.0, 7903.24919132693, 8060.798480038046, 8064.596770161468, 8070.798230044295, 8084.83830323402, 5430.456954304538, 5609.074502707171, 5639.887202256014, 5640.0, 5654.604177707521, 9530.380525265835, 9597.520123993912, 9710.126088652056, 9780.266480013885, 9788.314817962675, 8424.157584241771, 8703.390762646808, 9467.242620590474, 9679.564419601276, 9726.027397260217, 6712.160979877515, 6770.763023294358, 6776.45788336922, 7470.365018973448, 7628.313451789144, 8167.0607880092175, 8180.9590952044855, 8195.679165631984, 8219.917800822155, 8287.709930152416, 7127.928720712726, 7149.928500715135, 7255.238199988925, 7263.0, 7308.817279568053, 6955.304469553004, 7106.182788979334, 7182.784516464514, 7363.2268611797135, 7383.446241531799, 6639.502037347122, 6677.232118306457, 6735.528513004238, 6746.8650626988165, 6754.459643228628, 5039.798408063783, 5088.618353623567, 5167.689938603696, 5183.896322073613, 5304.787808487617, 4990.8752281193265, 5004.274380214922, 5022.874428139179, 5027.64806463544, 5202.401723801811], "value": 4458.366706995765, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [328.7573859345152, 338.0770496544434, 346.5339118885102, 346.9514268002479, 349.1028057891219, 5256.369235691713, 5315.601329900259, 5320.834103708297, 5399.676019438836, 5403.162509810981, 5125.8462246132585, 5237.607179461536, 5272.604554658396, 5301.3373328333955, 5341.4925582069645, 4196.412502249687, 4220.810063547147, 4223.915521689564, 4233.618974292313, 4252.38340440636, 4192.706510544263, 4226.197022565702, 4235.7246778959425, 4251.5535868733805, 4264.893377665568, 4188.602082802144, 4207.747535147885, 4208.137331846964, 4216.430781844458, 4219.43037689911, 4193.748375097504, 4201.6008479194425, 4202.2646036943715, 4205.158968206356, 4235.618794308496, 3574.5531808523933, 3684.2631473705364, 3685.7235707322056, 3703.4444833274956, 3790.4080286279827, 5167.199084141964, 5179.8446046618665, 5187.3775146982225, 5205.401378841444, 5224.843254702365, 4724.055188962221, 4786.21027530457, 4793.71237725734, 4800.375716334181, 4800.855974320776, 5442.530516760453, 5618.213450116987, 5626.240457538262, 5630.605857589971, 5671.0, 4053.3312003519386, 4074.164796216798, 4084.7737982799445, 4085.9795701021303, 4104.589541045902, 5880.852978675524, 5893.3222679391565, 5893.381194974551, 5899.970500147515, 5912.733926973254, 3992.181602771425, 4122.484689413824, 4160.355144952538, 4167.416561681367, 4191.434156388909, 4208.789560521962, 4213.620774130343, 4220.324748040299, 4229.111886503869, 4236.6187043166265, 4786.8085276588545, 4802.975985120122, 4832.95167048332, 4842.201036828954, 4857.319975203474, 5357.499900027999, 5608.439156084441, 5694.373618901917, 5708.743106560131, 5736.196932429463, 1315.9932651521594, 1349.6828245362333, 1374.29223949666, 1404.6207523968471, 1404.9438022479192, 960.644561512245, 980.6616717232544, 982.5480279071564, 985.8274801909637, 986.127277359542, 5292.623917781405, 5302.28419163408, 5305.4164041955355, 5311.548518375981, 5319.547838433777, 5553.972230138905, 5559.527440167631, 5559.833205003856, 5561.63849349791, 5566.6381685191145, 5150.97424512875, 5226.980516269379, 5294.8941021180135, 5317.229001794718, 5322.361316642027, 2919.562065690121, 2931.1646180838784, 2939.911802645924, 2940.853067303753, 2952.320966177791, 5662.405447428043, 5673.361886722694, 5709.714514274269, 5720.513756330675, 5723.399043100415, 5418.539424148913, 5562.888742225133, 5572.832815015556, 5598.081343059793, 5598.216249725042, 5690.288713910679, 5690.5447564194765, 5700.038473261044, 5707.429257074259, 5717.771289148387, 5332.9733351333, 5448.56411487088, 5472.945270547243, 5497.752601132878, 5520.889582208413, 5383.5423988961375, 5398.811041613525, 5424.511793938565, 5469.562435005269, 5472.932778108231, 5696.601237913306, 5730.109064008951, 5742.454466825645, 5742.626729262584, 5743.798967036134, 3918.3534716772556, 3997.760134391946, 4024.7786371749835, 4038.8586399475876, 4042.6563742081075, 5442.945570544244, 5483.506484416422, 5497.697626630414, 5528.364238112507, 5537.2524709163745, 5401.783928642967, 5546.889062218814, 5607.80372686954, 5619.129034999582, 5624.3250809903075, 5553.916691249554, 5593.384727680033, 5597.048501754793, 5634.88730225385, 5649.774009039593, 5363.463653634605, 5533.418991005887, 5547.5007249347755, 5584.246126772996, 5621.634593751557, 5643.548516118783, 5670.0, 5689.776698009948, 5693.146028095819, 5697.857553561194, 5485.518909894386, 5558.499735023867, 5565.248691426606, 5637.49262566371, 5638.7462564185535], "value": 4244.433039145225, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [755.3315315945387, 827.3381294964028, 833.9916600833992, 864.6627815152095, 877.14478383576, 15385.692286154284, 15499.38002479901, 15799.447019354326, 15841.12873791941, 15844.683106337867, 14328.498502552387, 14454.132752034886, 14455.710885782304, 14469.5659130226, 14474.710505789904, 725.9637018149072, 734.4858598980708, 840.4075127035455, 842.2882664148784, 849.5794581682076, 853.8164294676643, 853.9573021348939, 855.5038077914794, 856.1737922904396, 856.6830272799042, 899.6086702284528, 900.0234745301356, 900.0549423105746, 900.3562452846213, 901.0583939782942, 755.588204428585, 775.7052320118347, 885.7741275974586, 891.4695756025154, 902.4044130873657, 624.9781257656006, 625.871696302257, 625.9123722678829, 664.5713514782938, 665.4543274514899, 14814.185219812905, 15149.166795826226, 15177.16525591092, 15185.772213416698, 15190.696186076217, 13978.720425591533, 13991.65020874476, 14378.0, 14868.256587170597, 15778.921105394515, 13232.206067635876, 13305.467781288833, 13438.395272212774, 13447.394867230998, 13796.379162937592, 4574.725516469022, 4666.113438446684, 4673.532646735333, 4796.0, 4810.06203790261, 67898.66050669715, 68976.65511672459, 69821.30178698199, 70862.64568677124, 71419.64290178516, 11823.704407389883, 11925.522979080914, 11933.582324618597, 12075.939620301842, 12257.325847078497, 20979.685304720442, 21257.468563285733, 21385.0, 21416.250431234832, 21425.250116245857, 8471.110533394029, 8503.489790612583, 8581.871271930926, 8806.0, 8926.375153739305, 4636.211843986531, 4667.369905062841, 4841.370621819141, 4854.150523658345, 4938.481459446778, 3442.8278586070596, 3514.172630232265, 3523.6652518010746, 3576.088097535164, 3576.9821150894077, 647.0423772816258, 651.1177354684429, 657.9967100164564, 660.0066899316498, 662.8773676869795, 705.7953193573807, 727.930846569575, 732.2787054751066, 733.8935854301096, 758.7761610324967, 9103.726888193365, 9289.674861379819, 9310.487923164155, 9368.0, 9400.717978460658, 621.1180124223613, 639.3542522052667, 731.9414446844239, 735.1263405390888, 739.2959228977259, 4366.628836548865, 4566.337881007302, 4576.26779715244, 4579.885502862388, 4713.599344055725, 82884.58557707294, 83315.5834220825, 84564.57717711494, 86726.0, 88738.55630721805, 51291.7435412828, 54617.180742288896, 66265.33734662688, 70571.0, 72262.63868680623, 45174.77412612916, 46107.30839037417, 48836.511634883194, 68393.65803170952, 72053.639731801, 9476.810463790824, 9578.425294482353, 9787.36382135159, 9797.06927841854, 9894.307398482326, 44432.0, 45692.0, 45767.313490297005, 46742.76628616835, 47364.0, 62662.686686566274, 62724.372756271856, 62990.685046576305, 64838.35161648512, 65413.018804717016, 12807.679808004874, 13125.343732813511, 13165.0, 13232.470701171846, 13242.0, 13344.132631378929, 14234.217118058607, 14486.637834054232, 14606.196659183846, 15027.624309392353, 10707.196960227859, 10853.45732713377, 11091.667249982513, 12642.24146551173, 12828.935855320664, 12401.441935113122, 12964.675883102998, 13368.732625347244, 13410.195388276734, 13428.865711343153, 12371.257724536557, 12584.41004690272, 12853.97168226521, 12958.870411295766, 12997.610071697864, 11245.437728113398, 11266.211365204357, 11343.376114313793, 11505.252158609663, 11871.940640296743, 10810.729731756453, 10872.238943273895, 10908.290961087503, 10922.781544368909, 10960.28758130719], "value": 7310.477268399041, "unit": "score"}], "name": "dromaeo_css", "value": 7185.872220275113, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 110.0, 109.0, 110.0, 112.0, 111.0, 110.0, 110.0, 110.0, 111.0], "value": 109.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 118.0, 119.0, 146.0, 118.0, 120.0, 122.0, 118.0, 148.0, 118.0], "value": 127.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 163.0, 160.0, 160.0, 160.0, 160.0, 162.0, 161.0, 160.0, 160.0], "value": 161.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 75.0, 75.0, 111.0, 76.0, 76.0, 75.0, 76.0, 103.0, 75.0], "value": 81.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 81.0, 114.0, 83.0, 83.0, 82.0, 99.0, 82.0, 82.0, 105.0], "value": 89.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 116.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 147.0, 145.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0], "value": 146.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 84.0, 85.0, 85.0, 84.0, 85.0, 84.0, 84.0, 85.0], "value": 84.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 51.0, 51.0, 51.0, 50.0, 52.0, 50.0, 50.0, 50.0, 50.0], "value": 50.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 60.0, 60.0, 62.0, 59.0, 60.0, 61.0, 61.0, 61.0], "value": 60.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 81.0, 81.0, 75.0, 83.0, 76.0, 76.0, 75.0, 75.0], "value": 77.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 131.0, 129.0, 122.0, 122.0, 120.0, 122.0, 133.0, 164.0, 140.0], "value": 132.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 152.0, 155.0, 153.0, 158.0, 159.0, 155.0, 160.0, 158.0, 154.0], "value": 156.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 66.0, 62.0, 62.0, 62.0, 66.0, 61.0, 64.0, 62.0, 62.0], "value": 62.9, "unit": "score"}], "name": "kraken", "value": 1456.2, "alertThreshold": 2.0}]} 14:20:32 INFO - Return code: 0 14:20:32 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:20:32 INFO - # TBPL SUCCESS # 14:20:32 INFO - Running post-action listener: _resource_record_post_action 14:20:32 INFO - [mozharness: 2017-01-05 22:20:32.858741Z] Finished run-tests step (success) 14:20:32 INFO - Running post-run listener: _resource_record_post_run 14:20:32 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 266240; Write bytes: 364236800; Read time: 184; Write time: 240012 14:20:32 INFO - TinderboxPrint: CPU usage
13.0% 14:20:32 INFO - TinderboxPrint: I/O read bytes / time
266,240 / 184 14:20:32 INFO - TinderboxPrint: I/O write bytes / time
364,236,800 / 240,012 14:20:32 INFO - TinderboxPrint: CPU idle
8,277.7 (87.0%) 14:20:32 INFO - TinderboxPrint: CPU user
1,193.6 (12.5%) 14:20:32 INFO - TinderboxPrint: Swap in / out
0 / 0 14:20:32 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 118767616; Read time: 0; Write time: 78792 14:20:32 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 266240; Write bytes: 245465088; Read time: 184; Write time: 161220 14:20:33 INFO - Running post-run listener: _upload_blobber_files 14:20:33 INFO - Blob upload gear active. 14:20:33 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:20:33 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 14:20:33 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-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:20:33 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-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:20:33 INFO - (blobuploader) - INFO - Open directory for files ... 14:20:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:20:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:20:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:20:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:20:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:20:34 INFO - (blobuploader) - INFO - Done attempting. 14:20:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:20:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:20:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:20:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:20:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:20:35 INFO - (blobuploader) - INFO - Done attempting. 14:20:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:20:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:20:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:20:38 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:20:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:20:38 INFO - (blobuploader) - INFO - Done attempting. 14:20:38 INFO - (blobuploader) - INFO - Iteration through files over. 14:20:38 INFO - Return code: 0 14:20:38 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:20:38 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:20:38 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2cd744d35fd61f9b3692f4060f6c9eaa83880ac4bf028d19b0619082f9f7a3a67af08d4c0160b0ad7af5ac37b9be5859925dcdf1c7c3f80121460dbcd20d8aa3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/84a6a5684d01738f0eb1aedbd5540e33e397658a39b4669ce314beaa014506c3c15e8a64e5947b9e5698b5dc4eefe9a882d156c7b9e4b20b334accaca7700710", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6af1f0afee8278725c346274d9030b037262d542a7ae80c36cce2202e9ce4914b87c5294ed0d2f808f5771a99bb190a6c1bb3f9f6faddc65267705fa24264be7"} 14:20:38 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:20:38 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:20:38 INFO - Contents: 14:20:38 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2cd744d35fd61f9b3692f4060f6c9eaa83880ac4bf028d19b0619082f9f7a3a67af08d4c0160b0ad7af5ac37b9be5859925dcdf1c7c3f80121460dbcd20d8aa3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/84a6a5684d01738f0eb1aedbd5540e33e397658a39b4669ce314beaa014506c3c15e8a64e5947b9e5698b5dc4eefe9a882d156c7b9e4b20b334accaca7700710", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6af1f0afee8278725c346274d9030b037262d542a7ae80c36cce2202e9ce4914b87c5294ed0d2f808f5771a99bb190a6c1bb3f9f6faddc65267705fa24264be7"} 14:20:38 INFO - Running post-run listener: copy_logs_to_upload_dir 14:20:38 INFO - Copying logs to upload dir... 14:20:38 INFO - mkdir: /builds/slave/test/build/upload/logs 14:20:38 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.751691 ========= master_lag: 0.08 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2017-01-05 14:20:38.713830) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-05 14:20:38.720539) ========= 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=41bf3e9aed84707956354da8000001c5-1483653505.14609-773529423 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-Aurora/sha512/2cd744d35fd61f9b3692f4060f6c9eaa83880ac4bf028d19b0619082f9f7a3a67af08d4c0160b0ad7af5ac37b9be5859925dcdf1c7c3f80121460dbcd20d8aa3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/84a6a5684d01738f0eb1aedbd5540e33e397658a39b4669ce314beaa014506c3c15e8a64e5947b9e5698b5dc4eefe9a882d156c7b9e4b20b334accaca7700710", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6af1f0afee8278725c346274d9030b037262d542a7ae80c36cce2202e9ce4914b87c5294ed0d2f808f5771a99bb190a6c1bb3f9f6faddc65267705fa24264be7"} build_url:https://queue.taskcluster.net/v1/task/EBrDfoGWS0qFeW7wMB7nrw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011356 build_url: 'https://queue.taskcluster.net/v1/task/EBrDfoGWS0qFeW7wMB7nrw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2cd744d35fd61f9b3692f4060f6c9eaa83880ac4bf028d19b0619082f9f7a3a67af08d4c0160b0ad7af5ac37b9be5859925dcdf1c7c3f80121460dbcd20d8aa3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/84a6a5684d01738f0eb1aedbd5540e33e397658a39b4669ce314beaa014506c3c15e8a64e5947b9e5698b5dc4eefe9a882d156c7b9e4b20b334accaca7700710", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6af1f0afee8278725c346274d9030b037262d542a7ae80c36cce2202e9ce4914b87c5294ed0d2f808f5771a99bb190a6c1bb3f9f6faddc65267705fa24264be7"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-05 14:20:38.745564) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-05 14:20:38.745926) ========= 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=41bf3e9aed84707956354da8000001c5-1483653505.14609-773529423 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004458 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-05 14:20:38.830873) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-05 14:20:38.831244) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-05 14:20:38.831553) ========= ========= Total master_lag: 0.27 =========