builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-064 starttime: 1477832332.94 results: success (0) buildid: 20161030030204 builduid: ad75f2f9f6854d1b9de0e8158fcf7f67 revision: 969c3295d3aa77931cca26eddb047d9d74bd9858 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-30 05:58:52.938908) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-30 05:58:52.939441) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-30 05:58:52.939773) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-30 05:58:52.955166) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-30 05:58:52.955573) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1477832331.64917-62864460 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-30 05:58:54-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 224M=0s 2016-10-30 05:58:54 (224 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.078018 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-30 05:58:53.047956) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-30 05:58:53.048317) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1477832331.64917-62864460 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013086 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-30 05:58:53.098663) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-30 05:58:53.099192) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 969c3295d3aa77931cca26eddb047d9d74bd9858 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 969c3295d3aa77931cca26eddb047d9d74bd9858 --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=a12cd81e0ef515edd9e0d800000001bb-1477832331.64917-62864460 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-30 05:58:54,646 truncating revision to first 12 chars 2016-10-30 05:58:54,646 Setting DEBUG logging. 2016-10-30 05:58:54,646 attempt 1/10 2016-10-30 05:58:54,646 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/969c3295d3aa?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-30 05:58:55,040 unpacking tar archive at: mozilla-central-969c3295d3aa/testing/mozharness/ program finished with exit code 0 elapsedTime=0.716068 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-30 05:58:53.829086) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-30 05:58:53.829403) ========= script_repo_revision: 969c3295d3aa77931cca26eddb047d9d74bd9858 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-30 05:58:53.829808) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-30 05:58:53.830072) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-30 05:58:53.839240) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-10-30 05:58:53.839622) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a12cd81e0ef515edd9e0d800000001bb-1477832331.64917-62864460 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:58:55 INFO - MultiFileLogger online at 20161030 05:58:55 in /builds/slave/test 05:58:55 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:58:55 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:58:55 INFO - {'append_to_log': False, 05:58:55 INFO - 'base_work_dir': '/builds/slave/test', 05:58:55 INFO - 'blob_upload_branch': 'Firefox', 05:58:55 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:58:55 INFO - 'branch': 'Firefox', 05:58:55 INFO - 'buildbot_json_path': 'buildprops.json', 05:58:55 INFO - 'config_files': ('talos/linux_config.py',), 05:58:55 INFO - 'default_actions': ('clobber', 05:58:55 INFO - 'read-buildbot-config', 05:58:55 INFO - 'download-and-extract', 05:58:55 INFO - 'populate-webroot', 05:58:55 INFO - 'create-virtualenv', 05:58:55 INFO - 'install', 05:58:55 INFO - 'run-tests'), 05:58:55 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:58:55 INFO - 'download_minidump_stackwalk': True, 05:58:55 INFO - 'download_symbols': 'ondemand', 05:58:55 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:58:55 INFO - 'tooltool.py': '/tools/tooltool.py', 05:58:55 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:58:55 INFO - '/tools/misc-python/virtualenv.py')}, 05:58:55 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:58:55 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:58:55 INFO - 'installer_path': 'installer.exe', 05:58:55 INFO - 'log_level': 'info', 05:58:55 INFO - 'log_name': 'talos', 05:58:55 INFO - 'log_to_console': True, 05:58:55 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:58:55 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:58:55 INFO - 'opt_config_files': (), 05:58:55 INFO - 'pip_index': False, 05:58:55 INFO - 'sps_profile': False, 05:58:55 INFO - 'sps_profile_interval': 0, 05:58:55 INFO - 'suite': 'dromaeojs', 05:58:55 INFO - 'system_bits': '32', 05:58:55 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:58:55 INFO - 'title': 'talos-linux64-ix-064', 05:58:55 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:58:55 INFO - 'use_talos_json': True, 05:58:55 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:58:55 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:58:55 INFO - 'work_dir': 'build'} 05:58:55 INFO - [mozharness: 2016-10-30 12:58:55.481030Z] Running clobber step. 05:58:55 INFO - Running pre-action listener: _resource_record_pre_action 05:58:55 INFO - Running main action method: clobber 05:58:55 INFO - rmtree: /builds/slave/test/build 05:58:55 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:58:55 INFO - Running post-action listener: _resource_record_post_action 05:58:55 INFO - [mozharness: 2016-10-30 12:58:55.939416Z] Finished clobber step (success) 05:58:55 INFO - [mozharness: 2016-10-30 12:58:55.939516Z] Running read-buildbot-config step. 05:58:55 INFO - Running pre-action listener: _resource_record_pre_action 05:58:55 INFO - Running main action method: read_buildbot_config 05:58:55 INFO - Using buildbot properties: 05:58:55 INFO - { 05:58:55 INFO - "project": "", 05:58:55 INFO - "product": "firefox", 05:58:55 INFO - "script_repo_revision": "production", 05:58:55 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 05:58:55 INFO - "repository": "", 05:58:55 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 05:58:55 INFO - "buildid": "20161030030204", 05:58:55 INFO - "stage_platform": "linux64-pgo", 05:58:55 INFO - "basedir": "/builds/slave/test", 05:58:55 INFO - "nightly_build": "True", 05:58:55 INFO - "buildnumber": 604, 05:58:55 INFO - "slavename": "talos-linux64-ix-064", 05:58:55 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 05:58:55 INFO - "platform": "ubuntu64_hw", 05:58:55 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 05:58:55 INFO - "branch": "mozilla-central", 05:58:55 INFO - "repo_path": "mozilla-central", 05:58:55 INFO - "revision": "969c3295d3aa77931cca26eddb047d9d74bd9858", 05:58:55 INFO - "pgo_build": "True", 05:58:55 INFO - "builduid": "ad75f2f9f6854d1b9de0e8158fcf7f67", 05:58:55 INFO - "slavebuilddir": "test" 05:58:55 INFO - } 05:58:55 INFO - Found installer url https://queue.taskcluster.net/v1/task/Q8ZWW-SSR0eeW_aR4NU8zQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 05:58:55 INFO - Running post-action listener: _resource_record_post_action 05:58:55 INFO - [mozharness: 2016-10-30 12:58:55.942026Z] Finished read-buildbot-config step (success) 05:58:55 INFO - [mozharness: 2016-10-30 12:58:55.942115Z] Running download-and-extract step. 05:58:55 INFO - Running pre-action listener: _resource_record_pre_action 05:58:55 INFO - Running main action method: download_and_extract 05:58:55 INFO - mkdir: /builds/slave/test/build/tests 05:58:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:58:55 INFO - trying https://queue.taskcluster.net/v1/task/Q8ZWW-SSR0eeW_aR4NU8zQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 05:58:55 INFO - Downloading https://queue.taskcluster.net/v1/task/Q8ZWW-SSR0eeW_aR4NU8zQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 05:58:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Q8ZWW-SSR0eeW_aR4NU8zQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 05:58:56 INFO - Downloaded 1361 bytes. 05:58:56 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 05:58:56 INFO - Using the following test package requirements: 05:58:56 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 05:58:56 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:58:56 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:58:56 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:58:56 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:58:56 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:58:56 INFO - u'jsshell-linux-x86_64.zip'], 05:58:56 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:58:56 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:58:56 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 05:58:56 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:58:56 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:58:56 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:58:56 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:58:56 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:58:56 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:58:56 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:58:56 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:58:56 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:58:56 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Q8ZWW-SSR0eeW_aR4NU8zQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 05:58:56 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Q8ZWW-SSR0eeW_aR4NU8zQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:58:56 INFO - Fetch https://queue.taskcluster.net/v1/task/Q8ZWW-SSR0eeW_aR4NU8zQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 05:58:57 INFO - Http code: 200 05:58:57 INFO - via: 1.1 5c2ff4ca1e447265402af29264e83497.cloudfront.net (CloudFront) 05:58:57 INFO - x-amz-cf-id: tI4Usv4kEUNo5Wf4jbh5vojPpazTSXpNlSZL7xkuyaAEKVNjqs2Glg== 05:58:57 INFO - x-amz-version-id: 9jryXHcrFi1UcNS9OtlUobx61KneWWLc 05:58:58 INFO - Expected file size: 22006150 05:58:58 INFO - Obtained file size: 22006150 05:59:02 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:59:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Q8ZWW-SSR0eeW_aR4NU8zQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 05:59:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Q8ZWW-SSR0eeW_aR4NU8zQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:59:02 INFO - Fetch https://queue.taskcluster.net/v1/task/Q8ZWW-SSR0eeW_aR4NU8zQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 05:59:03 INFO - Http code: 200 05:59:03 INFO - via: 1.1 6cd88b9fd84ad5daa3b3867fb8c5c91a.cloudfront.net (CloudFront) 05:59:03 INFO - x-amz-cf-id: 3yHV6Ln5jmXm18ikpaabJ6Eg9ODjGYMDe97GF965PvzUrrM2o-EuZA== 05:59:03 INFO - x-amz-version-id: 9jryXHcrFi1UcNS9OtlUobx61KneWWLc 05:59:03 INFO - Expected file size: 22006150 05:59:03 INFO - Obtained file size: 22006150 05:59:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Q8ZWW-SSR0eeW_aR4NU8zQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 05:59:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Q8ZWW-SSR0eeW_aR4NU8zQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:59:08 INFO - Fetch https://queue.taskcluster.net/v1/task/Q8ZWW-SSR0eeW_aR4NU8zQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 05:59:08 INFO - Http code: 200 05:59:08 INFO - via: 1.1 b3bccc0e4c2cc0a33e7e8308d88cacdd.cloudfront.net (CloudFront) 05:59:08 INFO - x-amz-cf-id: _THBSGN14_uOQ6xkAVRYHWHEWRyk8M4P39UGGgU4040TvuC89cDs-w== 05:59:08 INFO - x-amz-version-id: 8X5jbRDCH3OM1UPXmWDY_WZfthsF0cQi 05:59:09 INFO - Expected file size: 14409038 05:59:09 INFO - Obtained file size: 14409038 05:59:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:59:10 INFO - trying https://queue.taskcluster.net/v1/task/Q8ZWW-SSR0eeW_aR4NU8zQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 05:59:10 INFO - Downloading https://queue.taskcluster.net/v1/task/Q8ZWW-SSR0eeW_aR4NU8zQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 05:59:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Q8ZWW-SSR0eeW_aR4NU8zQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 05:59:12 INFO - Downloaded 59631384 bytes. 05:59:12 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Q8ZWW-SSR0eeW_aR4NU8zQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 05:59:12 INFO - mkdir: /builds/slave/test/properties 05:59:12 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:59:12 INFO - Writing to file /builds/slave/test/properties/build_url 05:59:12 INFO - Contents: 05:59:12 INFO - build_url:https://queue.taskcluster.net/v1/task/Q8ZWW-SSR0eeW_aR4NU8zQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 05:59:13 INFO - Running post-action listener: _resource_record_post_action 05:59:13 INFO - Running post-action listener: set_extra_try_arguments 05:59:13 INFO - [mozharness: 2016-10-30 12:59:13.189143Z] Finished download-and-extract step (success) 05:59:13 INFO - [mozharness: 2016-10-30 12:59:13.189369Z] Running populate-webroot step. 05:59:13 INFO - Running pre-action listener: _resource_record_pre_action 05:59:13 INFO - Running main action method: populate_webroot 05:59:13 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:59:13 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:59:13 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:59:13 INFO - '--tppagecycles', 05:59:13 INFO - '7'], 05:59:13 INFO - 'tests': ['tsvgm']}}, 05:59:13 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:59:13 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:59:13 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:59:13 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:59:13 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:59:13 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:59:13 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:59:13 INFO - 'talos_options': ['--disable-e10s'], 05:59:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:59:13 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:59:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:59:13 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:59:13 INFO - 'talos_options': ['--disable-e10s'], 05:59:13 INFO - 'tests': ['damp', 'tps']}, 05:59:13 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:59:13 INFO - 'tests': ['damp', 'tps']}, 05:59:13 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:59:13 INFO - 'tests': ['dromaeo_dom']}, 05:59:13 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:59:13 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:59:13 INFO - 'tests': ['basic_compositor_video']}, 05:59:13 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:59:13 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:59:13 INFO - 'tests': ['a11yr', 05:59:13 INFO - 'ts_paint', 05:59:13 INFO - 'tpaint', 05:59:13 INFO - 'sessionrestore', 05:59:13 INFO - 'sessionrestore_no_auto_restore', 05:59:13 INFO - 'tabpaint']}, 05:59:13 INFO - 'other-e10s': {'tests': ['a11yr', 05:59:13 INFO - 'ts_paint', 05:59:13 INFO - 'tpaint', 05:59:13 INFO - 'sessionrestore', 05:59:13 INFO - 'sessionrestore_no_auto_restore', 05:59:13 INFO - 'tabpaint']}, 05:59:13 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:59:13 INFO - 'ts_paint', 05:59:13 INFO - 'tpaint', 05:59:13 INFO - 'sessionrestore', 05:59:13 INFO - 'sessionrestore_no_auto_restore', 05:59:13 INFO - 'tabpaint']}, 05:59:13 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:59:13 INFO - 'ts_paint', 05:59:13 INFO - 'tpaint', 05:59:13 INFO - 'sessionrestore', 05:59:13 INFO - 'sessionrestore_no_auto_restore', 05:59:13 INFO - 'tabpaint']}, 05:59:13 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:59:13 INFO - 'tests': ['a11yr', 05:59:13 INFO - 'ts_paint', 05:59:13 INFO - 'tpaint', 05:59:13 INFO - 'sessionrestore', 05:59:13 INFO - 'sessionrestore_no_auto_restore', 05:59:13 INFO - 'tabpaint']}, 05:59:13 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:59:13 INFO - 'tests': ['a11yr', 05:59:13 INFO - 'ts_paint', 05:59:13 INFO - 'tpaint', 05:59:13 INFO - 'sessionrestore', 05:59:13 INFO - 'sessionrestore_no_auto_restore', 05:59:13 INFO - 'tabpaint']}, 05:59:13 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:59:13 INFO - 'tests': ['tsvgx', 05:59:13 INFO - 'tsvgr_opacity', 05:59:13 INFO - 'tart', 05:59:13 INFO - 'tscrollx', 05:59:13 INFO - 'cart']}, 05:59:13 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:59:13 INFO - 'tsvgr_opacity', 05:59:13 INFO - 'tart', 05:59:13 INFO - 'tscrollx', 05:59:13 INFO - 'cart']}, 05:59:13 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:59:13 INFO - 'talos_options': ['--disable-e10s'], 05:59:13 INFO - 'tests': ['tp5o']}, 05:59:13 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:59:13 INFO - 'tests': ['tp5o']}, 05:59:13 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:59:13 INFO - 'talos_options': ['--disable-e10s', 05:59:13 INFO - '--xperf_path', 05:59:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:59:13 INFO - 'tests': ['tp5n']}, 05:59:13 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:59:13 INFO - 'talos_options': ['--xperf_path', 05:59:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:59:13 INFO - 'tests': ['tp5n']}}, 05:59:13 INFO - 'talos.zip': {'path': '', 05:59:13 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:59:13 INFO - Running post-action listener: _resource_record_post_action 05:59:13 INFO - [mozharness: 2016-10-30 12:59:13.205211Z] Finished populate-webroot step (success) 05:59:13 INFO - [mozharness: 2016-10-30 12:59:13.205319Z] Running create-virtualenv step. 05:59:13 INFO - Running pre-action listener: _resource_record_pre_action 05:59:13 INFO - Running main action method: create_virtualenv 05:59:13 INFO - Creating virtualenv /builds/slave/test/build/venv 05:59:13 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 05:59:13 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:59:13 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:59:13 INFO - Using real prefix '/usr' 05:59:13 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:59:13 INFO - Installing distribute.............................................................................................................................................................................................done. 05:59:15 INFO - Installing pip.................done. 05:59:15 INFO - Return code: 0 05:59:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 05:59:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 05:59:15 INFO - Reading from file tmpfile_stdout 05:59:15 INFO - Output received: 05:59:15 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 05:59:15 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:59: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')]} 05:59:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:59:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59: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')]} 05:59:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:59:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59:15 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 0x7f681eb29f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28c88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29947b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a23790>, '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 0x2a24690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a24b20>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1477832331.64917-62864460', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:59:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:59:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:59:15 INFO - Using env: {'DISPLAY': ':0', 05:59:15 INFO - 'HOME': '/home/cltbld', 05:59:15 INFO - 'LANG': 'en_US.UTF-8', 05:59:15 INFO - 'LANGUAGE': 'en_US:en', 05:59:15 INFO - 'LOGNAME': 'cltbld', 05:59:15 INFO - 'MAIL': '/var/mail/cltbld', 05:59:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:59:15 INFO - 'MOZ_NO_REMOTE': '1', 05:59:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:59:15 INFO - 'NO_EM_RESTART': '1', 05:59:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:59:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:59:15 INFO - 'PWD': '/builds/slave/test', 05:59:15 INFO - 'SHELL': '/bin/bash', 05:59:15 INFO - 'SHLVL': '1', 05:59:15 INFO - 'TERM': 'linux', 05:59:15 INFO - 'TMOUT': '86400', 05:59:15 INFO - 'USER': 'cltbld', 05:59:15 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1477832331.64917-62864460', 05:59:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:59:15 INFO - '_': '/tools/buildbot/bin/python'} 05:59:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:59:16 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:59:16 INFO - Cleaning up... 05:59:16 INFO - Return code: 0 05:59:16 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:59:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:59:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:59:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:59:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:59:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59:16 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 0x7f681eb29f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28c88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29947b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a23790>, '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 0x2a24690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a24b20>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1477832331.64917-62864460', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:59:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 05:59:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 05:59:16 INFO - Using env: {'DISPLAY': ':0', 05:59:16 INFO - 'HOME': '/home/cltbld', 05:59:16 INFO - 'LANG': 'en_US.UTF-8', 05:59:16 INFO - 'LANGUAGE': 'en_US:en', 05:59:16 INFO - 'LOGNAME': 'cltbld', 05:59:16 INFO - 'MAIL': '/var/mail/cltbld', 05:59:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:59:16 INFO - 'MOZ_NO_REMOTE': '1', 05:59:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:59:16 INFO - 'NO_EM_RESTART': '1', 05:59:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:59:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:59:16 INFO - 'PWD': '/builds/slave/test', 05:59:16 INFO - 'SHELL': '/bin/bash', 05:59:16 INFO - 'SHLVL': '1', 05:59:16 INFO - 'TERM': 'linux', 05:59:16 INFO - 'TMOUT': '86400', 05:59:16 INFO - 'USER': 'cltbld', 05:59:16 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1477832331.64917-62864460', 05:59:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:59:16 INFO - '_': '/tools/buildbot/bin/python'} 05:59:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:59:16 INFO - Downloading/unpacking psutil>=3.1.1 05:59:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:59:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:59:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:59:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:59:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:59:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:59:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:59:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:59:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:59:18 INFO - Installing collected packages: psutil 05:59:18 INFO - Running setup.py install for psutil 05:59:18 INFO - building 'psutil._psutil_linux' extension 05:59:18 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 05:59:18 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 05:59:18 INFO - building 'psutil._psutil_posix' extension 05:59:18 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 05:59:18 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 05:59:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:59:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:59:18 INFO - Successfully installed psutil 05:59:18 INFO - Cleaning up... 05:59:18 INFO - Return code: 0 05:59:18 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:59:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:59:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:59:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:59:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:59:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f681eb29f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28c88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29947b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a23790>, '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 0x2a24690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a24b20>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1477832331.64917-62864460', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:59: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:59: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 mozsystemmonitor==0.3 05:59:19 INFO - Using env: {'DISPLAY': ':0', 05:59:19 INFO - 'HOME': '/home/cltbld', 05:59:19 INFO - 'LANG': 'en_US.UTF-8', 05:59:19 INFO - 'LANGUAGE': 'en_US:en', 05:59:19 INFO - 'LOGNAME': 'cltbld', 05:59:19 INFO - 'MAIL': '/var/mail/cltbld', 05:59:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:59:19 INFO - 'MOZ_NO_REMOTE': '1', 05:59:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:59:19 INFO - 'NO_EM_RESTART': '1', 05:59:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:59:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:59:19 INFO - 'PWD': '/builds/slave/test', 05:59:19 INFO - 'SHELL': '/bin/bash', 05:59:19 INFO - 'SHLVL': '1', 05:59:19 INFO - 'TERM': 'linux', 05:59:19 INFO - 'TMOUT': '86400', 05:59:19 INFO - 'USER': 'cltbld', 05:59:19 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1477832331.64917-62864460', 05:59:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:59:19 INFO - '_': '/tools/buildbot/bin/python'} 05:59:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:59:19 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:59:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:59:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:59:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:59:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:59:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:59:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:59:21 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:59:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:59:21 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:59:21 INFO - Installing collected packages: mozsystemmonitor 05:59:21 INFO - Running setup.py install for mozsystemmonitor 05:59:21 INFO - Successfully installed mozsystemmonitor 05:59:21 INFO - Cleaning up... 05:59:21 INFO - Return code: 0 05:59:21 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:59:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:59:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:59:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:59:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:59:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59:21 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 0x7f681eb29f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28c88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29947b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a23790>, '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 0x2a24690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a24b20>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1477832331.64917-62864460', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:59:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 05:59:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 05:59:21 INFO - Using env: {'DISPLAY': ':0', 05:59:21 INFO - 'HOME': '/home/cltbld', 05:59:21 INFO - 'LANG': 'en_US.UTF-8', 05:59:21 INFO - 'LANGUAGE': 'en_US:en', 05:59:21 INFO - 'LOGNAME': 'cltbld', 05:59:21 INFO - 'MAIL': '/var/mail/cltbld', 05:59:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:59:21 INFO - 'MOZ_NO_REMOTE': '1', 05:59:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:59:21 INFO - 'NO_EM_RESTART': '1', 05:59:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:59:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:59:21 INFO - 'PWD': '/builds/slave/test', 05:59:21 INFO - 'SHELL': '/bin/bash', 05:59:21 INFO - 'SHLVL': '1', 05:59:21 INFO - 'TERM': 'linux', 05:59:21 INFO - 'TMOUT': '86400', 05:59:21 INFO - 'USER': 'cltbld', 05:59:21 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1477832331.64917-62864460', 05:59:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:59:21 INFO - '_': '/tools/buildbot/bin/python'} 05:59:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:59:21 INFO - Downloading/unpacking jsonschema==2.5.1 05:59:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:59:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:59:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:59:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:59:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:59:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:59:23 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:59:23 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:59: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 05:59: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 05:59: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 05:59: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 05:59: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 05:59: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 05:59:23 INFO - Downloading functools32-3.2.3-2.tar.gz 05:59:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:59:23 INFO - warning: no files found matching '*.txt' 05:59:23 INFO - no previously-included directories found matching 'build' 05:59:23 INFO - no previously-included directories found matching 'dist' 05:59:23 INFO - no previously-included directories found matching '.git*' 05:59:23 INFO - Installing collected packages: jsonschema, functools32 05:59:23 INFO - Running setup.py install for functools32 05:59:23 INFO - warning: no files found matching '*.txt' 05:59:23 INFO - no previously-included directories found matching 'build' 05:59:23 INFO - no previously-included directories found matching 'dist' 05:59:23 INFO - no previously-included directories found matching '.git*' 05:59:23 INFO - Successfully installed jsonschema functools32 05:59:23 INFO - Cleaning up... 05:59:23 INFO - Return code: 0 05:59:23 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:59: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')]} 05:59:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:59:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59: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')]} 05:59:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:59:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59: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', '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 0x7f681eb29f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28c88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29947b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a23790>, '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 0x2a24690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a24b20>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1477832331.64917-62864460', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:59: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 05:59: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 functools32==3.2.3-2 05:59:23 INFO - Using env: {'DISPLAY': ':0', 05:59:23 INFO - 'HOME': '/home/cltbld', 05:59:23 INFO - 'LANG': 'en_US.UTF-8', 05:59:23 INFO - 'LANGUAGE': 'en_US:en', 05:59:23 INFO - 'LOGNAME': 'cltbld', 05:59:23 INFO - 'MAIL': '/var/mail/cltbld', 05:59:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:59:23 INFO - 'MOZ_NO_REMOTE': '1', 05:59:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:59:23 INFO - 'NO_EM_RESTART': '1', 05:59:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:59:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:59:23 INFO - 'PWD': '/builds/slave/test', 05:59:23 INFO - 'SHELL': '/bin/bash', 05:59:23 INFO - 'SHLVL': '1', 05:59:23 INFO - 'TERM': 'linux', 05:59:23 INFO - 'TMOUT': '86400', 05:59:23 INFO - 'USER': 'cltbld', 05:59:23 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1477832331.64917-62864460', 05:59:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:59:23 INFO - '_': '/tools/buildbot/bin/python'} 05:59:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:59:24 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:59:24 INFO - Cleaning up... 05:59:24 INFO - Return code: 0 05:59:24 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:59:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:59:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:59:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:59:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:59:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f681eb29f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28c88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29947b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a23790>, '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 0x2a24690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a24b20>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1477832331.64917-62864460', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:59:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:59:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:59:24 INFO - Using env: {'DISPLAY': ':0', 05:59:24 INFO - 'HOME': '/home/cltbld', 05:59:24 INFO - 'LANG': 'en_US.UTF-8', 05:59:24 INFO - 'LANGUAGE': 'en_US:en', 05:59:24 INFO - 'LOGNAME': 'cltbld', 05:59:24 INFO - 'MAIL': '/var/mail/cltbld', 05:59:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:59:24 INFO - 'MOZ_NO_REMOTE': '1', 05:59:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:59:24 INFO - 'NO_EM_RESTART': '1', 05:59:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:59:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:59:24 INFO - 'PWD': '/builds/slave/test', 05:59:24 INFO - 'SHELL': '/bin/bash', 05:59:24 INFO - 'SHLVL': '1', 05:59:24 INFO - 'TERM': 'linux', 05:59:24 INFO - 'TMOUT': '86400', 05:59:24 INFO - 'USER': 'cltbld', 05:59:24 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1477832331.64917-62864460', 05:59:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:59:24 INFO - '_': '/tools/buildbot/bin/python'} 05:59:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:59:24 INFO - Downloading/unpacking blobuploader==1.2.4 05:59:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:59:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:59:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:59:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:59:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:59:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:59:26 INFO - Downloading blobuploader-1.2.4.tar.gz 05:59:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:59:26 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:59:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:59:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:59:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:59:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:59:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:59:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:59:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:59:26 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:59:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:59:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:59:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:59:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:59:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:59:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:59:27 INFO - Downloading docopt-0.6.1.tar.gz 05:59:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:59:27 INFO - Installing collected packages: blobuploader, requests, docopt 05:59:27 INFO - Running setup.py install for blobuploader 05:59:27 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:59:27 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:59:27 INFO - Running setup.py install for requests 05:59:27 INFO - Running setup.py install for docopt 05:59:27 INFO - Successfully installed blobuploader requests docopt 05:59:27 INFO - Cleaning up... 05:59:27 INFO - Return code: 0 05:59:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:59:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:59:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:59:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:59:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:59:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59:27 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 0x7f681eb29f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28c88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29947b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a23790>, '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 0x2a24690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a24b20>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1477832331.64917-62864460', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:59:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:59:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:59:27 INFO - Using env: {'DISPLAY': ':0', 05:59:27 INFO - 'HOME': '/home/cltbld', 05:59:27 INFO - 'LANG': 'en_US.UTF-8', 05:59:27 INFO - 'LANGUAGE': 'en_US:en', 05:59:27 INFO - 'LOGNAME': 'cltbld', 05:59:27 INFO - 'MAIL': '/var/mail/cltbld', 05:59:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:59:27 INFO - 'MOZ_NO_REMOTE': '1', 05:59:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:59:27 INFO - 'NO_EM_RESTART': '1', 05:59:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:59:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:59:27 INFO - 'PWD': '/builds/slave/test', 05:59:27 INFO - 'SHELL': '/bin/bash', 05:59:27 INFO - 'SHLVL': '1', 05:59:27 INFO - 'TERM': 'linux', 05:59:27 INFO - 'TMOUT': '86400', 05:59:27 INFO - 'USER': 'cltbld', 05:59:27 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1477832331.64917-62864460', 05:59:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:59:27 INFO - '_': '/tools/buildbot/bin/python'} 05:59:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:59:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:59:27 INFO - Running setup.py (path:/tmp/pip-aWXSVf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:59:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:59:28 INFO - Running setup.py (path:/tmp/pip-p6_vq6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:59:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:59:28 INFO - Running setup.py (path:/tmp/pip-zukhOF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:59:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:59:28 INFO - Running setup.py (path:/tmp/pip-roHYIF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:59:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:59:28 INFO - Running setup.py (path:/tmp/pip-fk09MK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:59:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:59:28 INFO - Running setup.py (path:/tmp/pip-_9qRDg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:59:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:59:28 INFO - Running setup.py (path:/tmp/pip-B0FeY5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:59:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:59:28 INFO - Running setup.py (path:/tmp/pip-xGrUyo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:59:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:59:28 INFO - Running setup.py (path:/tmp/pip-G9xUJG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:59:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:59:28 INFO - Running setup.py (path:/tmp/pip-l_opTS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:59:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:59:28 INFO - Running setup.py (path:/tmp/pip-YYR0yD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:59:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:59:28 INFO - Running setup.py (path:/tmp/pip-4_6QNp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:59:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:59:28 INFO - Running setup.py (path:/tmp/pip-M7FFm0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:59:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:59:28 INFO - Running setup.py (path:/tmp/pip-7wW2gq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:59:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:59:28 INFO - Running setup.py (path:/tmp/pip-xXKhxT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:59:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:59:29 INFO - Running setup.py (path:/tmp/pip-pT7QbL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:59:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:59:29 INFO - Running setup.py (path:/tmp/pip-RysSbs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:59:29 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:59:29 INFO - Running setup.py install for manifestparser 05:59:29 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:59:29 INFO - Running setup.py install for mozcrash 05:59:29 INFO - Running setup.py install for mozdebug 05:59:29 INFO - Running setup.py install for mozdevice 05:59:29 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:59:29 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:59:29 INFO - Running setup.py install for mozfile 05:59:29 INFO - Running setup.py install for mozhttpd 05:59:29 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:59:29 INFO - Running setup.py install for mozinfo 05:59:29 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:59:29 INFO - Running setup.py install for mozInstall 05:59:29 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:59:29 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:59:29 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:59:29 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:59:29 INFO - Running setup.py install for mozleak 05:59:30 INFO - Running setup.py install for mozlog 05:59:30 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:59:30 INFO - Running setup.py install for moznetwork 05:59:30 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:59:30 INFO - Running setup.py install for mozprocess 05:59:30 INFO - Running setup.py install for mozprofile 05:59:30 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:59:30 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:59:30 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:59:30 INFO - Running setup.py install for mozrunner 05:59:30 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:59:30 INFO - Running setup.py install for mozscreenshot 05:59:30 INFO - Running setup.py install for moztest 05:59:30 INFO - Running setup.py install for mozversion 05:59:30 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:59:30 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:59:30 INFO - Cleaning up... 05:59:30 INFO - Return code: 0 05:59:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:59:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:59:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:59:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:59:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:59:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59:31 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 0x7f681eb29f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28c88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29947b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a23790>, '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 0x2a24690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a24b20>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1477832331.64917-62864460', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:59:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:59:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:59:31 INFO - Using env: {'DISPLAY': ':0', 05:59:31 INFO - 'HOME': '/home/cltbld', 05:59:31 INFO - 'LANG': 'en_US.UTF-8', 05:59:31 INFO - 'LANGUAGE': 'en_US:en', 05:59:31 INFO - 'LOGNAME': 'cltbld', 05:59:31 INFO - 'MAIL': '/var/mail/cltbld', 05:59:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:59:31 INFO - 'MOZ_NO_REMOTE': '1', 05:59:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:59:31 INFO - 'NO_EM_RESTART': '1', 05:59:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:59:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:59:31 INFO - 'PWD': '/builds/slave/test', 05:59:31 INFO - 'SHELL': '/bin/bash', 05:59:31 INFO - 'SHLVL': '1', 05:59:31 INFO - 'TERM': 'linux', 05:59:31 INFO - 'TMOUT': '86400', 05:59:31 INFO - 'USER': 'cltbld', 05:59:31 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1477832331.64917-62864460', 05:59:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:59:31 INFO - '_': '/tools/buildbot/bin/python'} 05:59:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:59:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:59:31 INFO - Running setup.py (path:/tmp/pip-lwLpPA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:59:31 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 05:59:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:59:31 INFO - Running setup.py (path:/tmp/pip-1MZlYo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:59:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:59:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:59:31 INFO - Running setup.py (path:/tmp/pip-N1Wvhe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:59:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:59:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:59:31 INFO - Running setup.py (path:/tmp/pip-oL64En-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:59:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:59:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:59:31 INFO - Running setup.py (path:/tmp/pip-OFcQkW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:59:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 05:59:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:59:31 INFO - Running setup.py (path:/tmp/pip-c2bs0y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:59:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 05:59:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:59:31 INFO - Running setup.py (path:/tmp/pip-PKRunI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:59:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 05:59:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:59:31 INFO - Running setup.py (path:/tmp/pip-GPXP7m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:59:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 05:59:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:59:31 INFO - Running setup.py (path:/tmp/pip-c88wbY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:59:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 05:59:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:59:31 INFO - Running setup.py (path:/tmp/pip-3rJOkX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:59:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:59:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:59:31 INFO - Running setup.py (path:/tmp/pip-fihnzq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:59:32 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 05:59:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:59:32 INFO - Running setup.py (path:/tmp/pip-GmytT7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:59:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 05:59:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:59:32 INFO - Running setup.py (path:/tmp/pip-fvdOPY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:59:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 05:59:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:59:32 INFO - Running setup.py (path:/tmp/pip-tnUt7S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:59:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 05:59:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:59:32 INFO - Running setup.py (path:/tmp/pip-mBfduS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:59:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 05:59:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:59:32 INFO - Running setup.py (path:/tmp/pip-c8pOPi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:59:32 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 05:59:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:59:32 INFO - Running setup.py (path:/tmp/pip-DS9YwR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:59:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 05:59:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:59:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:59:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:59:32 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:59:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:59:32 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:59:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:59:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:59:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:59:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:59:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:59:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:59:34 INFO - Downloading blessings-1.6.tar.gz 05:59:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:59:34 INFO - Installing collected packages: blessings 05:59:34 INFO - Running setup.py install for blessings 05:59:34 INFO - Successfully installed blessings 05:59:34 INFO - Cleaning up... 05:59:34 INFO - Return code: 0 05:59:34 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:59:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:59:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:59:34 INFO - Reading from file tmpfile_stdout 05:59:34 INFO - Current package versions: 05:59:34 INFO - argparse == 1.2.1 05:59:34 INFO - blessings == 1.6 05:59:34 INFO - blobuploader == 1.2.4 05:59:34 INFO - docopt == 0.6.1 05:59:34 INFO - functools32 == 3.2.3-2 05:59:34 INFO - jsonschema == 2.5.1 05:59:34 INFO - manifestparser == 1.1 05:59:34 INFO - mozInstall == 1.12 05:59:34 INFO - mozcrash == 0.17 05:59:34 INFO - mozdebug == 0.1 05:59:34 INFO - mozdevice == 0.48 05:59:34 INFO - mozfile == 1.2 05:59:34 INFO - mozhttpd == 0.7 05:59:34 INFO - mozinfo == 0.9 05:59:34 INFO - mozleak == 0.1 05:59:34 INFO - mozlog == 3.4 05:59:34 INFO - moznetwork == 0.27 05:59:34 INFO - mozprocess == 0.23 05:59:34 INFO - mozprofile == 0.28 05:59:34 INFO - mozrunner == 6.12 05:59:34 INFO - mozscreenshot == 0.1 05:59:34 INFO - mozsystemmonitor == 0.3 05:59:34 INFO - moztest == 0.7 05:59:34 INFO - mozversion == 1.4 05:59:34 INFO - psutil == 3.1.1 05:59:34 INFO - requests == 1.2.3 05:59:34 INFO - wsgiref == 0.1.2 05:59:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:59:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:59:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:59:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:59:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:59:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59:34 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 0x7f681eb29f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28c88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29947b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a23790>, '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 0x2a24690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a24b20>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1477832331.64917-62864460', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:59:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 05:59:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:59:34 INFO - Using env: {'DISPLAY': ':0', 05:59:34 INFO - 'HOME': '/home/cltbld', 05:59:34 INFO - 'LANG': 'en_US.UTF-8', 05:59:34 INFO - 'LANGUAGE': 'en_US:en', 05:59:34 INFO - 'LOGNAME': 'cltbld', 05:59:34 INFO - 'MAIL': '/var/mail/cltbld', 05:59:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:59:34 INFO - 'MOZ_NO_REMOTE': '1', 05:59:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:59:34 INFO - 'NO_EM_RESTART': '1', 05:59:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:59:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:59:34 INFO - 'PWD': '/builds/slave/test', 05:59:34 INFO - 'SHELL': '/bin/bash', 05:59:34 INFO - 'SHLVL': '1', 05:59:34 INFO - 'TERM': 'linux', 05:59:34 INFO - 'TMOUT': '86400', 05:59:34 INFO - 'USER': 'cltbld', 05:59:34 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1477832331.64917-62864460', 05:59:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:59:34 INFO - '_': '/tools/buildbot/bin/python'} 05:59:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:59:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:59:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 05:59:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 05:59:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:59:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 05:59:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 05:59:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 05:59:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 05:59:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 05:59:35 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:59:35 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:59:35 INFO - Cleaning up... 05:59:35 INFO - Return code: 0 05:59:35 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:59: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')]} 05:59:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:59:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59: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')]} 05:59:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:59:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f681eb29f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28c88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29947b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a23790>, '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 0x2a24690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a24b20>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1477832331.64917-62864460', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:59:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:59:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:59:35 INFO - Using env: {'DISPLAY': ':0', 05:59:35 INFO - 'HOME': '/home/cltbld', 05:59:35 INFO - 'LANG': 'en_US.UTF-8', 05:59:35 INFO - 'LANGUAGE': 'en_US:en', 05:59:35 INFO - 'LOGNAME': 'cltbld', 05:59:35 INFO - 'MAIL': '/var/mail/cltbld', 05:59:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:59:35 INFO - 'MOZ_NO_REMOTE': '1', 05:59:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:59:35 INFO - 'NO_EM_RESTART': '1', 05:59:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:59:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:59:35 INFO - 'PWD': '/builds/slave/test', 05:59:35 INFO - 'SHELL': '/bin/bash', 05:59:35 INFO - 'SHLVL': '1', 05:59:35 INFO - 'TERM': 'linux', 05:59:35 INFO - 'TMOUT': '86400', 05:59:35 INFO - 'USER': 'cltbld', 05:59:35 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1477832331.64917-62864460', 05:59:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:59:35 INFO - '_': '/tools/buildbot/bin/python'} 05:59:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:59:35 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:59:35 INFO - Cleaning up... 05:59:35 INFO - Return code: 0 05:59:35 INFO - Running post-action listener: _resource_record_post_action 05:59:35 INFO - Running post-action listener: _start_resource_monitoring 05:59:35 INFO - Starting resource monitoring. 05:59:35 INFO - [mozharness: 2016-10-30 12:59:35.327210Z] Finished create-virtualenv step (success) 05:59:35 INFO - [mozharness: 2016-10-30 12:59:35.327674Z] Running install step. 05:59:35 INFO - Running pre-action listener: _resource_record_pre_action 05:59:35 INFO - Running main action method: install 05:59:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:59:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:59:35 INFO - Reading from file tmpfile_stdout 05:59:35 INFO - Detecting whether we're running mozinstall >=1.0... 05:59:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:59:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:59:35 INFO - Reading from file tmpfile_stdout 05:59:35 INFO - Output received: 05:59:35 INFO - Usage: mozinstall [options] installer 05:59:35 INFO - Options: 05:59:35 INFO - -h, --help show this help message and exit 05:59:35 INFO - -d DEST, --destination=DEST 05:59:35 INFO - Directory to install application into. [default: 05:59:35 INFO - "/builds/slave/test"] 05:59:35 INFO - --app=APP Application being installed. [default: firefox] 05:59:35 INFO - mkdir: /builds/slave/test/build/application 05:59:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 05:59:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 05:59:52 INFO - Reading from file tmpfile_stdout 05:59:52 INFO - Output received: 05:59:52 INFO - /builds/slave/test/build/application/firefox/firefox 05:59:52 INFO - Running post-action listener: _resource_record_post_action 05:59:52 INFO - [mozharness: 2016-10-30 12:59:52.576694Z] Finished install step (success) 05:59:52 INFO - [mozharness: 2016-10-30 12:59:52.576940Z] Running run-tests step. 05:59:52 INFO - Running pre-action listener: _resource_record_pre_action 05:59:52 INFO - Running main action method: run_tests 05:59:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:59:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:59:52 INFO - Python 2.7.3 05:59:52 INFO - Return code: 0 05:59:52 INFO - grabbing minidump binary from tooltool 05:59:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:59:52 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 0x2a23790>, '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 0x2a24690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a24b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:59:52 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 05:59:52 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 05:59:52 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 05:59:52 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:59:52 INFO - Return code: 0 05:59:52 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:59:52 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:59:52 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:59:52 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:59:52 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:59:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Q8ZWW-SSR0eeW_aR4NU8zQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 05:59:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Q8ZWW-SSR0eeW_aR4NU8zQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-064 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 05:59:52 INFO - Using env: {'DISPLAY': ':0', 05:59:52 INFO - 'HOME': '/home/cltbld', 05:59:52 INFO - 'LANG': 'en_US.UTF-8', 05:59:52 INFO - 'LANGUAGE': 'en_US:en', 05:59:52 INFO - 'LOGNAME': 'cltbld', 05:59:52 INFO - 'MAIL': '/var/mail/cltbld', 05:59:52 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:59:52 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:59:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:59:52 INFO - 'MOZ_NO_REMOTE': '1', 05:59:52 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:59:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:59:52 INFO - 'NO_EM_RESTART': '1', 05:59:52 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:59:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:59:52 INFO - 'PWD': '/builds/slave/test', 05:59:52 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:59:52 INFO - 'SHELL': '/bin/bash', 05:59:52 INFO - 'SHLVL': '1', 05:59:52 INFO - 'TERM': 'linux', 05:59:52 INFO - 'TMOUT': '86400', 05:59:52 INFO - 'USER': 'cltbld', 05:59:52 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1477832331.64917-62864460', 05:59:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:59:52 INFO - '_': '/tools/buildbot/bin/python'} 05:59:52 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Q8ZWW-SSR0eeW_aR4NU8zQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 05:59:52 INFO - mozversion application_buildid: 20161030030204 05:59:52 INFO - mozversion application_changeset: 969c3295d3aa77931cca26eddb047d9d74bd9858 05:59:52 INFO - mozversion application_display_name: Nightly 05:59:52 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:59:52 INFO - mozversion application_name: Firefox 05:59:52 INFO - mozversion application_remotingname: firefox 05:59:52 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:59:52 INFO - mozversion application_vendor: Mozilla 05:59:52 INFO - mozversion application_version: 52.0a1 05:59:52 INFO - mozversion platform_buildid: 20161030030204 05:59:52 INFO - mozversion platform_changeset: 969c3295d3aa77931cca26eddb047d9d74bd9858 05:59:52 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:59:52 INFO - mozversion platform_version: 52.0a1 05:59:52 INFO - using testdate: 1477832392 05:59:52 INFO - actual date: 1477832392 05:59:52 INFO - starting webserver on 'localhost:33771' 05:59:52 INFO - SUITE-START | Running 2 tests 05:59:52 INFO - TEST-START | dromaeo_css 05:59:52 INFO - operating with platform_type : linux_ 05:59:52 INFO - Initialising browser for dromaeo_css test... 05:59:52 INFO - TEST-INFO | started process 32744 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDwsH6n/profile http://localhost:33771/getInfo.html) 05:59:57 INFO - PROCESS | 32744 | __metrics Screen width/height:1600/1200 05:59:57 INFO - PROCESS | 32744 | colorDepth:24 05:59:57 INFO - PROCESS | 32744 | Browser inner width/height: 1024/697 05:59:57 INFO - PROCESS | 32744 | __metrics 05:59:57 INFO - PROCESS | 32744 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:59:57 INFO - PROCESS | 32744 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 205: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:59:58 INFO - PROCESS | 32744 | console.error: PushService: 05:59:58 INFO - PROCESS | 32744 | stateChangeProcessEnqueue: Error transitioning state 05:59:58 INFO - PROCESS | 32744 | UnknownError 05:59:59 INFO - TEST-INFO | 32744: exit 0 05:59:59 INFO - Browser initialized. 05:59:59 INFO - Running cycle 1/1 for dromaeo_css test... 05:59:59 INFO - TEST-INFO | started process 359 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDwsH6n/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:00:11 INFO - PROCESS | 359 | RSS: Main: 174047232 06:00:11 INFO - PROCESS | 359 | 06:01:02 INFO - PROCESS | 359 | 1477832462882 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 06:03:13 INFO - PROCESS | 359 | Cycle 1(1): loaded http://localhost:33771/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33771/tests/dromaeo/cssquery-ext.html) 06:03:14 INFO - PROCESS | 359 | RSS: Main: 316043264 06:03:14 INFO - PROCESS | 359 | 06:06:17 INFO - PROCESS | 359 | Cycle 1(1): loaded http://localhost:33771/tests/dromaeo/cssquery-ext.html (next: http://localhost:33771/tests/dromaeo/cssquery-jquery.html) 06:06:17 INFO - PROCESS | 359 | RSS: Main: 272990208 06:06:17 INFO - PROCESS | 359 | 06:09:20 INFO - PROCESS | 359 | Cycle 1(1): loaded http://localhost:33771/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33771/tests/dromaeo/cssquery-mootools.html) 06:09:20 INFO - PROCESS | 359 | RSS: Main: 214765568 06:09:20 INFO - PROCESS | 359 | 06:12:22 INFO - PROCESS | 359 | Cycle 1(1): loaded http://localhost:33771/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33771/tests/dromaeo/cssquery-prototype.html) 06:12:23 INFO - PROCESS | 359 | RSS: Main: 278097920 06:12:23 INFO - PROCESS | 359 | 06:15:26 INFO - PROCESS | 359 | Cycle 1(1): loaded http://localhost:33771/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33771/tests/dromaeo/cssquery-yui.html) 06:15:26 INFO - PROCESS | 359 | RSS: Main: 216350720 06:15:26 INFO - PROCESS | 359 | 06:18:29 INFO - PROCESS | 359 | Cycle 1(1): loaded http://localhost:33771/tests/dromaeo/cssquery-yui.html (next: http://localhost:33771/tests/dromaeo/cssquery-dojo.html) 06:18:29 INFO - PROCESS | 359 | RSS: Main: 313167872 06:18:29 INFO - PROCESS | 359 | 06:18:29 INFO - PROCESS | 359 | __start_tp_report 06:18:29 INFO - PROCESS | 359 | _x_x_mozilla_page_load 06:18:29 INFO - PROCESS | 359 | _x_x_mozilla_page_load_details 06:18:29 INFO - PROCESS | 359 | |i|pagename|runs| 06:18:29 INFO - PROCESS | 359 | |0;dojo.html;2935.8550165435477;2972.762179025678;3004.984975075125;3016.7737419693512;3019.1697283247104;4988.825391111312;5070.974645126769;5091.923621145681;5146.871328216792;5232.398274198464;5077.3907131144315;5141.177411614142;5179.093658609738;5188.92216616751;5231.764570594323;4697.53024697531;4704.294355846633;4772.856814295559;4779.354787103749;4789.090072886158;4800.183968725325;4810.855674329776;4863.732494712789;4866.902661946759;4924.753762311888;4637.582617564435;4763.714177149365;4770.427548694144;4770.522947705236;4887.975560122212;4643.210654188762;4675.298705194214;4710.505396933307;4719.10337035962;4733.952660473386;4714.080754252922;4719;4724.149653062447;4761.6904901181315;4786.305985632099;5132.769025393866;5160.535551800356;5165.509276618715;5167.741612919339;5168.534831865112;5297.47025297471;5335.919961200585;5431.782728690887;5473.0969390050595;5566.276384070085;5526.032944234743;5542.0855558832745;5543.307086614173;5603.3836278009385;5609.046462101453;5194.27280180775;5196.948030519684;5196.9740151299;5197.506236907488;5248.343957005374;5493.7802487900835;5544.1960915667005;5570.220169176318;5647.463490968352;5650.23721797552;5407.70257635826;5434.972825135849;5446.373667028263;5499;5510.91733623996;5478.150886612581;5527.088030474926;5527.695976721238;5532.944670553324;5536.944630553723;5312.1500559911;5352.57179425645;5461.180822876521;5518.862028449321;5540.335159780852;5375.220593014069;5428.809991650273;5461.208124821958;5601.187827764951;5608.186812912105;4237.745735255895;4238.618524332764;4262.808173632194;4284.378765079046;4337.891552711208;3835.827387767557;3853.2293541291856;3857.864974725871;3894.922101557953;3901.4733011043713;5110.361204849394;5142.2286657001005;5220.086484865134;5236.659617124875;5268.078086334876;5465.699386533779;5466.480684334982;5476.288082549323;5491.588130890199;5508.14623733322;5165.612579056586;5224.320838290998;5224.320838290998;5224.764885580158;5305.893882122413;4552.590266875931;4583.427071616048;4610.585047345688;4619.5611416915335;4646.767661616906;5596.132599447093;5597.160425936142;5597.384287728265;5646.774129034792;5664.716764161858;5403.189521571796;5403.756830942539;5410.107332290128;5410.810621628224;5414.242006119225;5483.616146869681;5545.833624991256;5605.271314729059;5647.915281270702;5674.687892165971;5383.703896285742;5486.6982315973;5486.890262194814;5515.117581186991;5536.252605898152;5499.092649712753;5537.473939975695;5545.112781954868;5545.694986775766;5548.4174161712435;5287;5325;5408.4321146280645;5459.235707000944;5527.115661494142;5347.304850369427;5379.085555455504;5388.976094542025;5436.103042997861;5485.6434331768305;5348.625596208228;5353.357597088374;5374.220737992891;5386.730663466733;5387.407385187705;5259.579233661221;5455.045367060828;5473.644213126293;5475.123980163314;5536.114221724666;5200.5059519345605;5261.736913154404;5282.894342113059;5311.734413279398;5383.7846486140115 06:18:29 INFO - PROCESS | 359 | |1;ext.html;542.374729153323;577.6534079552268;591.2874985642303;623.9656818874963;634.5082561015215;30160;41584;41973.16053678932;42238.57761422389;42260.57739422605;44219.77890110553;44637.10725785483;44670.77664611673;44742.32886506705;44768;7903.249191326843;8758;8947.50788706621;8954.14935581122;8959.104089591021;7977.641006154708;10447.268691191619;10689.412082335468;10704.46477676117;11043.558257669683;10794.082502987256;10908.945455272713;10916.345019298828;10926.562937482491;10928;7807.453478256524;8005.6797728090805;10679.946600266987;10733.51699173539;10753.408562529057;8069.435139540235;8125.065617454009;10246;10575.947120264427;10594.311369761019;40922;41280;41328.627278453605;41388.37917431241;41392;3251.756118291114;3265.6244531878665;3328.8502017409273;3340.866365345383;3363.327334533103;29665.851670741726;30365.848170759225;30429.543556846664;31108.533371999438;31413.214669633213;3783.5270591176104;3904.2191561687778;3923.8626648067466;3958.841646334143;4032.5967403259733;346218;347754;348529;348847.99999999744;349100;55216.44783552193;55441;55636.72181639066;55664.72167639217;55755;58566.707166464745;58569.41430585725;58813.117803232984;58836.41163588395;58851;15431.922840385727;15688.058716477048;15688.215589220494;15691.450799221973;15691.921540392224;11002.779944401067;11161.162912781574;11233.831492527619;12112.39438028095;12179;15264.23678816077;15747.212639367986;15892.443764468188;15945.601359966093;15950.60123496922;5215.7913683453;6190.2571691397325;6354.904676429857;6416.486681065504;6428.19647544057;943.8489841625307;1028.9588416463407;1029.9897001030045;1055.519738518972;1099.6920862158609;27581.448371032468;27774.583381249297;27837;28418.857905710753;28492.857535712188;1086.896744809242;1094.217634391398;1118.669992352258;1139.5270962550449;1183.3964678014274;15142.545723628089;15684.451044213398;15716.449924252596;15989.680206395808;16021.919890400706;493562;496297;498024;499687;500591;45742.313865292046;53962.73018634882;55169.172462413095;55245.72377138169;60359.396406036256;1280.8398950131234;1296.4425297122139;1307.7319149574125;1319.3139567424885;1334.5129027904745;30216;32265.838670806497;33921.49117763285;33987.32025359529;34144;52873.7356313216;53315.20027199518;53436;53489;53525.732371337894;463774;464323;469026;469674;470062;26832.463350733266;27128.186154415398;27132.593011105244;27206.591901121104;27229.04698335549;46323;46332.53667463282;46914.76542617265;47176.29235561538;47379.526204737514;39283;39654.405183921685;39940.800295998335;41288.38067428931;41727.37408938929;37361.43957840689;39551.40672889852;39642.40536391899;39994.800025999684;40385;36424.63575364213;39862.20275594414;40653.593464066165;40933.590664092975;40973.1805363897;30476.695233047387;34299;35249;36013.63986360103;36169.45745813762;24874.378140546632;26377.340566485993;26471.33821654474;26942.73057269402;27803.58294625623 06:18:29 INFO - PROCESS | 359 | |2;jquery.html;365.4919661670277;375.470586473073;375.9604693023789;389.4800441410717;397.78122032881924;13875.930620346897;17436.476905692834;17597.824021759778;18259.726104108417;18490.35283765065;17796.733049004277;17893.418117023462;18067.81932180678;18120.18459169337;18412.539686507844;5494.972525137378;5688.175214593882;5717.885642287151;5745.253117094772;5751.683657398841;4062.045419326456;4289.613934745872;5572.108462645978;5666.46168613981;5677;4317.784110794463;6325.240971083476;6379.553431259814;6419.422251997319;6492.123563318939;6229.190205273331;6314.905276420857;6366.522510811661;6461.579997300184;6469.773557925473;5523.6685798852195;5547.944520554784;5552.583556233259;5554.361463368316;5555.722213889289;21377.144914203414;21385.67921481179;21558.245461408776;21603.135874565;21726.13095476179;2207.3708992936936;2253.9098436062536;2519.7102333231546;2828.702986186462;3099.736522395599;9439.292053095976;9843.950780246125;9885.505724713736;9893.653722119763;9893.802123957552;1854.6568884756364;1915.5594213330874;1941.7766956800008;1993.3421970749619;2077.511784730587;79598;79898.6005069971;79990.99999999942;80107;82100;10325.586976520855;10340.844887326695;10520.473976301155;10914.836277455845;10945.179111566664;14819.481318153812;14831.332590033475;14868.479603214051;14872.405103795943;14877.628059298388;7276.017737605462;7524.5861477619255;7527.962360188164;7657.387409007266;7748.108967468813;7060.752873649398;7184.425245980309;7261.8547629047125;7308.744193953186;7349.412047036224;4458.7547684877645;4534.093181363741;4537.342085397665;4600.6549508786975;4681.555252251031;1866.6733321668653;1898.677224871775;1913.111202084834;1959.511420495962;1963.528753099246;706.7628870072737;778.8948491953627;826.6197549127348;919.2048877720723;1020.260311274335;17526.561835953948;17625.55936101582;18280.62351894245;18963.525911852037;19215.615687686168;955.4362925873768;977.9070988256104;1015.8628585141059;1049.7900419916048;1059.8145324568325;9905.355883725706;10599.735006624896;10628.787424251626;10665.786684266272;10673.306235094695;439037;439047;459925;462314;462336.7532649395;85182.5740871304;86173.13826861777;88266.38002149736;88834;89590.55204724065;985.7092157813462;1008.7780688248573;1019.9490025498844;1022.6727447216967;1035.6789395287335;16059.678806423572;16441;16605.83394166043;16896.40862569804;16983.7452438216;41243;42366.5763342375;42723.7863810679;43085.3537196936;43289.3506597395;55827.16259256033;57385.426145738005;59009.40990590039;59758.40241597702;60806;6501.44737697301;8015.278624923785;8160.387970902325;8477.74566762998;8606.913930860861;11435.428228588371;12606.93696531548;12726.490940362282;12817.87182128204;12821.358932053547;6798.456123510008;10494.370337779757;10813.56745730162;10879.782404352027;11437.085033197158;10254.794904102026;10599.523021464207;10610.469476526298;10679.89320106789;10865.456727163451;10722.73193170177;10745.140388769036;10770.51532681047;11188.496517656562;11465.541378344773;7240.239774823778;7535.397168226419;7594.202608726005;7773.533587984739;8440.409171357946;10538.631147909786;11198.608048718255;11362;11476.426178690865;11581 06:18:29 INFO - PROCESS | 359 | |3;mootools.html;1405.8755834981496;1463.070949946784;1555.18352864746;1699.1419333236713;1732.861371090313;7834.960825195873;8368.958155209231;8369.874451883219;8370.246677799005;8387;7183;7386.4460165487535;7928.524288542677;8167.346612271019;8253;2238.675392068153;2261.3781210167253;2265.5808675395106;2266.909323627053;2274.385915802732;2185.49733561281;2209.9005544750526;2245.494763678176;2255.954880902381;2257.604919139152;2187.4093994621444;2213.5351576169023;2247.8763667998255;2274.943126421836;2278.3734473019886;2167.6856855755905;2170.934871953844;2188.8577242479187;2195.8462907596554;2197.527531580718;2228.353777404551;2236.9217077402377;2251.8198544116594;2252.662100684894;2255.5827171973237;8340.833183336359;8358.373122015873;8454.070052294242;8458.281046111088;8468.110848360957;4911.631627627942;5056.241563765428;5061.772220250097;5063.873403164914;5064.366954130734;3156.4949608062598;3271.8364081796053;3378.2061215614312;3421.1447138215444;3451.758376913617;1096.5887792077972;1105.5688281570194;1128.8024595695802;1149.126663735567;1151.6602602232279;11363.772724545463;11429.371384573846;11458.484368203452;11485.540578376938;11495.712607184803;4305.827766889352;4432.268675668543;4532.773361331986;4557.521460246693;4559.726416415026;9676.080772326617;9680.661176858775;9680.903190968;9684;9688.951555242178;5045.066662667418;5049.520295571915;5050.49495050492;5052.520010598987;5053.949460505348;4105.507339119265;4435.645148388121;4632.60622847055;4651.953480465219;4662.277347011219;3634.509341238952;3685.8341374638208;3755.1363186467265;3768.698504119664;3813.5423749149722;1195.7907366210877;1203.139755075108;1210.7881120803825;1212.4968138222716;1227.1900545639835;910.2581396162107;913.57975331347;915.4049867586123;940.8689318693165;942.495764765847;5569.498745112959;5574.16387541872;5684.744186511617;5700.315962084576;5840.415958404125;898.4609234459272;928.4707716601472;930.8929473110679;944.5230158769778;955.7323949294208;3892.824822882977;3892.8637497687446;3914.178022615226;3921.098147426108;3949.585293544194;9485.762855928657;9928.156106730865;9944.10503054714;9950.45272510019;9950.701478955643;9628.133467987915;9888.653897113567;9898.158656514277;9901.801963960681;9902.059304366074;7588.848223035508;7835.0597928247835;7878.330341920886;7937.32532734724;7941.2455816698475;5383.5962302826665;5385.192221166856;5391.595630327663;5398.244245805512;5537.833864984057;9254.814903701754;9261.120193581599;9270.304727145356;9354.672586459441;9472.715818525456;9494.24046076326;9538.904610953801;9541.856872146784;9660.855087173557;9687.225021998363;6319.8104056878365;6492.870142597216;6865.519413640997;7022.54353467023;7188.065551478275;7857.842843143219;8175;8201.753947381589;8202.17978202175;8208.548529830916;7221.31397517235;7384.52000619958;7501.662425190771;7562.773116806505;7678.385729141543;7103.822404439724;7234.782956511313;7257.709691612276;7336.926630733838;7486.6256687166515;6513.218413790375;6619.66901654925;6634.734610615521;6635.966820165868;6641.435477984425;4735.928961065518;4748.3352330674425;4800.303955926441;5021.221710634857;5062.240663900445;4866.172750632471;4902.485239049991;4905.337779399735;5037.92443113361;5083.644144909968 06:18:29 INFO - PROCESS | 359 | |4;prototype.html;313.69884910485916;333.85310463396104;336.91071865955524;340.5300685054625;342.3478273888244;5206.167013277876;5293.338332708411;5329.147336426173;5341.759620817063;5383.650062745919;5267.157254839217;5282;5284.445133261001;5286.550643195333;5295.735213239342;4192.790360481979;4195.951012246938;4204.159168166364;4204.516480604724;4205.768682722449;4125.876223713293;4175.394567787669;4203.201391735561;4206.768627725474;4211.115665710189;4135.255653982282;4145.461090058288;4150.294449943517;4158.313878210091;4164.333706606943;4163.708540402173;4166.458360413158;4166.708330416872;4182.665386769051;4189.581041895816;3670.853165873362;3707.796071216082;3719.3863012602887;3727.552693676776;3742.906427339311;4920.3111564381015;5127.769250383742;5145.794168233266;5153.330067091254;5167.534921857051;4656.604188643969;4675.509071547473;4683.531646835323;4687.367205427257;4707.105649926503;5262.316218728438;5449.3460784706085;5455.072637651609;5459.672419654833;5462.754176062087;3897.707671924589;3933.567307596162;3934.390169523728;3947.1710940702487;3949.407588861665;5373.328333958255;5510.724463776835;5627.521660658849;5645.689487078209;5647.576431767593;3898.493195884517;3899.122697393064;3906.7069969752383;3910;3954.7824869632445;4058.228936502055;4059.6048331484567;4079.4696689430184;4089.2434899543678;4096.5903409659395;4608.953910460919;4609.700369475973;4633.791479383436;4652.813887444532;4666.4633567139535;5235.214717792285;5441.6190866639745;5554.777808887599;5589.441055894378;5596.873188188462;1418.581518452059;1435.9282035898163;1438.3671184678708;1442.9278536073155;1444.8771854392285;868.7654333330092;890.8485557455248;899.1547944931743;912.4935660708238;924.4176169013613;4736.289556566474;4744.2446294871115;4768.737719425465;4841.975790121027;4849.151398505247;5022.648414610942;5031.7987280509105;5060.49395060491;5064.215046667772;5085.262636917626;4773.570378665937;4800.231962885921;4805.8077676892535;4821.445533763592;5025.271335656383;2979.4636965346444;3015.381846721417;3022.5163973764093;3025.712557307096;3029.9242518936762;5848.116822453214;5870.094303319798;5896.174535565025;5905.43898329658;5919.289685237799;5540.972295138579;5776.711164441761;5798.333191682926;5804.332501762267;5812.534997200214;5838.766449342149;5852.765889364463;5869;5884.704965063629;5888.941110588925;5413.269208656939;5646.463585959327;5671.801486947937;5687.402822703557;5702.857428564153;5633.577481688808;5637.43625637433;5649.994252040467;5664.895345407606;5680.630759000817;5639;5740.68426236561;5795.391483894299;5872.29532456108;5879.559033072451;4075.633193012643;4082.1427500225286;4084.9795751021056;4093.6929730269753;4098.959010409858;5723.399043100415;5724.284464441945;5729.799457018984;5731.312242530923;5736.8239510901;5389.568834493152;5523.392426832965;5580.665160090408;5603.74783134768;5618.297712785902;5551.250581171652;5554.389017208185;5586.1062230043;5588.497035266845;5589.888202236014;5275.551578115903;5553.888922221452;5559.555235581225;5561.582881283839;5583.0787919992745;5586.217929489793;5599.272094627672;5616.38219795814;5621.578381621476;5622.606417550732;5473.534749546174;5481.697686971402;5493.2858728366655;5497.36780270274;5570.916436253378 06:18:29 INFO - PROCESS | 359 | |5;yui.html;714.9571025738456;729.7227053719586;761.8819083042131;764.6176911544228;794.3645083932852;12861.614151575455;13370.264635445072;13441.126326788752;13451.260180690058;13460.999999999987;12550;12625.873741262585;12702.618921432371;12705.174163679354;12710.872891271085;764.6635480388625;776.2121446731572;777.7316825695154;777.8755399136139;778.283978739561;774.0363247756551;774.8566515194678;777.5529070784322;777.7977725791307;778.2567647896245;801.3549092980148;803.1045384396415;803.3091541274499;803.3894240377297;803.4737247103128;800.083903929997;803.1887793328722;803.2971150243537;804.2359758229646;804.4489524675616;588.7821506042749;592.6651441935293;593.5666963116905;594.8661551151;595.2291782142137;11512.079033677286;11512.539498420054;11524.020458261059;11528.423578821026;11529.308241505452;11107.333559986346;11303.604373846958;11365.374904380256;11917.735630230316;12016.279023258545;10207.489625518769;10220.74448138795;10328.948355258251;10389.42858142802;10874.782504349947;3572.5355703758605;3614.9096272593133;3678.2275722098125;3792.9620703792884;3795.6773674237725;58483.707581462244;59146;59985;64695.35304646987;65011.67494162499;8392.496450213006;8502.957485212535;8677.1756683115;9906.752331191778;10436.060754532129;17349.13254337278;17478.91260543689;17512.64974700524;17518.824811751718;17541.386051488138;7036.366726994493;7346.6326683666675;7351.926480735231;7633.313001829751;7791.766247012599;3972.8609498667406;4034.435179074932;4035.9394609080887;4039.656629186552;4050.696197785178;3333.933321333608;3372.3423932332958;3376.9662303376654;3401.6768407001296;3414.573178352706;573.8995675756726;583.9970800146057;589.9616524925866;592.2448877680905;609.704293417692;621.1025068775576;636.4081404293959;648.9772857950044;660.207750699163;667.9332066793281;7491.8501629967095;7862.764117076496;7878.448508604342;7989.920100799034;8341.374396920255;608.4432744039243;621.4438077920236;638.4381744065192;649.4057936987604;660.5376236634376;3661.2677464506673;3665.908352291214;3711.2206436648607;3728.7762734236035;3852.4028775539837;87181;87916.56041719878;91876;92830;94767;51401;59660.70169649124;81329.59335203405;81352;85060;50853;67716;69537.65231173811;69666.65166674236;70814.29185708077;7320;7372.115346158281;7399.630018499161;7441.590712510864;7547.660355284135;49321.50678493169;49359.50640493549;50474.495255048445;50997.7450112747;52743.73628131835;40587;52671.47328526819;54943;55139.724301378235;57851;12052.879471205526;12281;12350.197237179555;12674.176178548734;12683.619491415273;13108.147970381895;13165;13285.335733213495;13796.586102416944;13936.651583710489;11571.768564628828;11699.181057325906;11779.764404712028;11888.108391870817;12478.750424991267;11865.881341186823;12077.51689932428;12351.444185011876;12753.48986040585;12770.68073298175;11491.712707182387;11737.413129343327;11981.400929953641;12096.818547721967;12509.624711258677;9543.141117299476;9893.55479003461;10252.58989640406;10430.629151429332;10733.570657173626;8846.80568123295;9988.900110998797;10066.647667331608;10131.79736405253;10262.384256944608 06:18:29 INFO - PROCESS | 359 | __end_tp_report 06:18:29 INFO - PROCESS | 359 | __start_cc_report 06:18:29 INFO - PROCESS | 359 | _x_x_mozilla_cycle_collect,1374 06:18:29 INFO - PROCESS | 359 | __end_cc_report 06:18:29 INFO - PROCESS | 359 | __startTimestamp1477833509838__endTimestamp 06:18:29 INFO - PROCESS | 359 | 06:18:29 INFO - PROCESS | 359 | ------- Summary: start ------- 06:18:29 INFO - PROCESS | 359 | Number of tests: 6 06:18:29 INFO - PROCESS | 359 | 06:18:29 INFO - PROCESS | 359 | [#0] dojo.html Cycles:165 Average:5124.36 Median:5312.15 stddev:558.57 (10.5%) stddev-sans-first:533.25 06:18:29 INFO - PROCESS | 359 | Values: 2935.9 2972.8 3005.0 3016.8 3019.2 4988.8 5071.0 5091.9 5146.9 5232.4 5077.4 5141.2 5179.1 5188.9 5231.8 4697.5 4704.3 4772.9 4779.4 4789.1 4800.2 4810.9 4863.7 4866.9 4924.8 4637.6 4763.7 4770.4 4770.5 4888.0 4643.2 4675.3 4710.5 4719.1 4734.0 4714.1 4719.0 4724.1 4761.7 4786.3 5132.8 5160.5 5165.5 5167.7 5168.5 5297.5 5335.9 5431.8 5473.1 5566.3 5526.0 5542.1 5543.3 5603.4 5609.0 5194.3 5196.9 5197.0 5197.5 5248.3 5493.8 5544.2 5570.2 5647.5 5650.2 5407.7 5435.0 5446.4 5499.0 5510.9 5478.2 5527.1 5527.7 5532.9 5536.9 5312.2 5352.6 5461.2 5518.9 5540.3 5375.2 5428.8 5461.2 5601.2 5608.2 4237.7 4238.6 4262.8 4284.4 4337.9 3835.8 3853.2 3857.9 3894.9 3901.5 5110.4 5142.2 5220.1 5236.7 5268.1 5465.7 5466.5 5476.3 5491.6 5508.1 5165.6 5224.3 5224.3 5224.8 5305.9 4552.6 4583.4 4610.6 4619.6 4646.8 5596.1 5597.2 5597.4 5646.8 5664.7 5403.2 5403.8 5410.1 5410.8 5414.2 5483.6 5545.8 5605.3 5647.9 5674.7 5383.7 5486.7 5486.9 5515.1 5536.3 5499.1 5537.5 5545.1 5545.7 5548.4 5287.0 5325.0 5408.4 5459.2 5527.1 5347.3 5379.1 5389.0 5436.1 5485.6 5348.6 5353.4 5374.2 5386.7 5387.4 5259.6 5455.0 5473.6 5475.1 5536.1 5200.5 5261.7 5282.9 5311.7 5383.8 06:18:29 INFO - PROCESS | 359 | 06:18:29 INFO - PROCESS | 359 | [#1] ext.html Cycles:180 Average:59199.27 Median:36893.04 stddev:117293.53 (317.9%) stddev-sans-first:117539.89 06:18:29 INFO - PROCESS | 359 | Values: 542.4 577.7 591.3 624.0 634.5 30160.0 41584.0 41973.2 42238.6 42260.6 44219.8 44637.1 44670.8 44742.3 44768.0 7903.2 8758.0 8947.5 8954.1 8959.1 7977.6 10447.3 10689.4 10704.5 11043.6 10794.1 10908.9 10916.3 10926.6 10928.0 7807.5 8005.7 10679.9 10733.5 10753.4 8069.4 8125.1 10246.0 10575.9 10594.3 40922.0 41280.0 41328.6 41388.4 41392.0 3251.8 3265.6 3328.9 3340.9 3363.3 29665.9 30365.8 30429.5 31108.5 31413.2 3783.5 3904.2 3923.9 3958.8 4032.6 346218.0 347754.0 348529.0 348848.0 349100.0 55216.4 55441.0 55636.7 55664.7 55755.0 58566.7 58569.4 58813.1 58836.4 58851.0 15431.9 15688.1 15688.2 15691.5 15691.9 11002.8 11161.2 11233.8 12112.4 12179.0 15264.2 15747.2 15892.4 15945.6 15950.6 5215.8 6190.3 6354.9 6416.5 6428.2 943.8 1029.0 1030.0 1055.5 1099.7 27581.4 27774.6 27837.0 28418.9 28492.9 1086.9 1094.2 1118.7 1139.5 1183.4 15142.5 15684.5 15716.4 15989.7 16021.9 493562.0 496297.0 498024.0 499687.0 500591.0 45742.3 53962.7 55169.2 55245.7 60359.4 1280.8 1296.4 1307.7 1319.3 1334.5 30216.0 32265.8 33921.5 33987.3 34144.0 52873.7 53315.2 53436.0 53489.0 53525.7 463774.0 464323.0 469026.0 469674.0 470062.0 26832.5 27128.2 27132.6 27206.6 27229.0 46323.0 46332.5 46914.8 47176.3 47379.5 39283.0 39654.4 39940.8 41288.4 41727.4 37361.4 39551.4 39642.4 39994.8 40385.0 36424.6 39862.2 40653.6 40933.6 40973.2 30476.7 34299.0 35249.0 36013.6 36169.5 24874.4 26377.3 26471.3 26942.7 27803.6 06:18:29 INFO - PROCESS | 359 | 06:18:29 INFO - PROCESS | 359 | [#2] jquery.html Cycles:180 Average:27436.36 Median:2229.91 stddev:74832.76 (3355.9%) stddev-sans-first:75015.08 06:18:29 INFO - PROCESS | 359 | Values: 365.5 375.5 376.0 389.5 397.8 13875.9 17436.5 17597.8 18259.7 18490.4 17796.7 17893.4 18067.8 18120.2 18412.5 5495.0 5688.2 5717.9 5745.3 5751.7 4062.0 4289.6 5572.1 5666.5 5677.0 4317.8 6325.2 6379.6 6419.4 6492.1 6229.2 6314.9 6366.5 6461.6 6469.8 5523.7 5547.9 5552.6 5554.4 5555.7 21377.1 21385.7 21558.2 21603.1 21726.1 2207.4 2253.9 2519.7 2828.7 3099.7 9439.3 9844.0 9885.5 9893.7 9893.8 1854.7 1915.6 1941.8 1993.3 2077.5 79598.0 79898.6 79991.0 80107.0 82100.0 10325.6 10340.8 10520.5 10914.8 10945.2 14819.5 14831.3 14868.5 14872.4 14877.6 7276.0 7524.6 7528.0 7657.4 7748.1 7060.8 7184.4 7261.9 7308.7 7349.4 4458.8 4534.1 4537.3 4600.7 4681.6 1866.7 1898.7 1913.1 1959.5 1963.5 706.8 778.9 826.6 919.2 1020.3 17526.6 17625.6 18280.6 18963.5 19215.6 955.4 977.9 1015.9 1049.8 1059.8 9905.4 10599.7 10628.8 10665.8 10673.3 439037.0 439047.0 459925.0 462314.0 462336.8 85182.6 86173.1 88266.4 88834.0 89590.6 985.7 1008.8 1019.9 1022.7 1035.7 16059.7 16441.0 16605.8 16896.4 16983.7 41243.0 42366.6 42723.8 43085.4 43289.4 55827.2 57385.4 59009.4 59758.4 60806.0 6501.4 8015.3 8160.4 8477.7 8606.9 11435.4 12606.9 12726.5 12817.9 12821.4 6798.5 10494.4 10813.6 10879.8 11437.1 10254.8 10599.5 10610.5 10679.9 10865.5 10722.7 10745.1 10770.5 11188.5 11465.5 7240.2 7535.4 7594.2 7773.5 8440.4 10538.6 11198.6 11362.0 11476.4 11581.0 06:18:29 INFO - PROCESS | 359 | 06:18:29 INFO - PROCESS | 359 | [#3] mootools.html Cycles:180 Average:5449.81 Median:5384.39 stddev:3026.06 (56.2%) stddev-sans-first:3019.29 06:18:29 INFO - PROCESS | 359 | Values: 1405.9 1463.1 1555.2 1699.1 1732.9 7835.0 8369.0 8369.9 8370.2 8387.0 7183.0 7386.4 7928.5 8167.3 8253.0 2238.7 2261.4 2265.6 2266.9 2274.4 2185.5 2209.9 2245.5 2256.0 2257.6 2187.4 2213.5 2247.9 2274.9 2278.4 2167.7 2170.9 2188.9 2195.8 2197.5 2228.4 2236.9 2251.8 2252.7 2255.6 8340.8 8358.4 8454.1 8458.3 8468.1 4911.6 5056.2 5061.8 5063.9 5064.4 3156.5 3271.8 3378.2 3421.1 3451.8 1096.6 1105.6 1128.8 1149.1 1151.7 11363.8 11429.4 11458.5 11485.5 11495.7 4305.8 4432.3 4532.8 4557.5 4559.7 9676.1 9680.7 9680.9 9684.0 9689.0 5045.1 5049.5 5050.5 5052.5 5053.9 4105.5 4435.6 4632.6 4652.0 4662.3 3634.5 3685.8 3755.1 3768.7 3813.5 1195.8 1203.1 1210.8 1212.5 1227.2 910.3 913.6 915.4 940.9 942.5 5569.5 5574.2 5684.7 5700.3 5840.4 898.5 928.5 930.9 944.5 955.7 3892.8 3892.9 3914.2 3921.1 3949.6 9485.8 9928.2 9944.1 9950.5 9950.7 9628.1 9888.7 9898.2 9901.8 9902.1 7588.8 7835.1 7878.3 7937.3 7941.2 5383.6 5385.2 5391.6 5398.2 5537.8 9254.8 9261.1 9270.3 9354.7 9472.7 9494.2 9538.9 9541.9 9660.9 9687.2 6319.8 6492.9 6865.5 7022.5 7188.1 7857.8 8175.0 8201.8 8202.2 8208.5 7221.3 7384.5 7501.7 7562.8 7678.4 7103.8 7234.8 7257.7 7336.9 7486.6 6513.2 6619.7 6634.7 6636.0 6641.4 4735.9 4748.3 4800.3 5021.2 5062.2 4866.2 4902.5 4905.3 5037.9 5083.6 06:18:29 INFO - PROCESS | 359 | 06:18:29 INFO - PROCESS | 359 | [#4] prototype.html Cycles:180 Average:4619.68 Median:5220.69 stddev:1350.56 (25.9%) stddev-sans-first:1315.11 06:18:29 INFO - PROCESS | 359 | Values: 313.7 333.9 336.9 340.5 342.3 5206.2 5293.3 5329.1 5341.8 5383.7 5267.2 5282.0 5284.4 5286.6 5295.7 4192.8 4196.0 4204.2 4204.5 4205.8 4125.9 4175.4 4203.2 4206.8 4211.1 4135.3 4145.5 4150.3 4158.3 4164.3 4163.7 4166.5 4166.7 4182.7 4189.6 3670.9 3707.8 3719.4 3727.6 3742.9 4920.3 5127.8 5145.8 5153.3 5167.5 4656.6 4675.5 4683.5 4687.4 4707.1 5262.3 5449.3 5455.1 5459.7 5462.8 3897.7 3933.6 3934.4 3947.2 3949.4 5373.3 5510.7 5627.5 5645.7 5647.6 3898.5 3899.1 3906.7 3910.0 3954.8 4058.2 4059.6 4079.5 4089.2 4096.6 4609.0 4609.7 4633.8 4652.8 4666.5 5235.2 5441.6 5554.8 5589.4 5596.9 1418.6 1435.9 1438.4 1442.9 1444.9 868.8 890.8 899.2 912.5 924.4 4736.3 4744.2 4768.7 4842.0 4849.2 5022.6 5031.8 5060.5 5064.2 5085.3 4773.6 4800.2 4805.8 4821.4 5025.3 2979.5 3015.4 3022.5 3025.7 3029.9 5848.1 5870.1 5896.2 5905.4 5919.3 5541.0 5776.7 5798.3 5804.3 5812.5 5838.8 5852.8 5869.0 5884.7 5888.9 5413.3 5646.5 5671.8 5687.4 5702.9 5633.6 5637.4 5650.0 5664.9 5680.6 5639.0 5740.7 5795.4 5872.3 5879.6 4075.6 4082.1 4085.0 4093.7 4099.0 5723.4 5724.3 5729.8 5731.3 5736.8 5389.6 5523.4 5580.7 5603.7 5618.3 5551.3 5554.4 5586.1 5588.5 5589.9 5275.6 5553.9 5559.6 5561.6 5583.1 5586.2 5599.3 5616.4 5621.6 5622.6 5473.5 5481.7 5493.3 5497.4 5570.9 06:18:29 INFO - PROCESS | 359 | 06:18:29 INFO - PROCESS | 359 | [#5] yui.html Cycles:180 Average:16801.31 Median:53843.37 stddev:23183.06 (43.1%) stddev-sans-first:23216.63 06:18:29 INFO - PROCESS | 359 | Values: 715.0 729.7 761.9 764.6 794.4 12861.6 13370.3 13441.1 13451.3 13461.0 12550.0 12625.9 12702.6 12705.2 12710.9 764.7 776.2 777.7 777.9 778.3 774.0 774.9 777.6 777.8 778.3 801.4 803.1 803.3 803.4 803.5 800.1 803.2 803.3 804.2 804.4 588.8 592.7 593.6 594.9 595.2 11512.1 11512.5 11524.0 11528.4 11529.3 11107.3 11303.6 11365.4 11917.7 12016.3 10207.5 10220.7 10328.9 10389.4 10874.8 3572.5 3614.9 3678.2 3793.0 3795.7 58483.7 59146.0 59985.0 64695.4 65011.7 8392.5 8503.0 8677.2 9906.8 10436.1 17349.1 17478.9 17512.6 17518.8 17541.4 7036.4 7346.6 7351.9 7633.3 7791.8 3972.9 4034.4 4035.9 4039.7 4050.7 3333.9 3372.3 3377.0 3401.7 3414.6 573.9 584.0 590.0 592.2 609.7 621.1 636.4 649.0 660.2 667.9 7491.9 7862.8 7878.4 7989.9 8341.4 608.4 621.4 638.4 649.4 660.5 3661.3 3665.9 3711.2 3728.8 3852.4 87181.0 87916.6 91876.0 92830.0 94767.0 51401.0 59660.7 81329.6 81352.0 85060.0 50853.0 67716.0 69537.7 69666.7 70814.3 7320.0 7372.1 7399.6 7441.6 7547.7 49321.5 49359.5 50474.5 50997.7 52743.7 40587.0 52671.5 54943.0 55139.7 57851.0 12052.9 12281.0 12350.2 12674.2 12683.6 13108.1 13165.0 13285.3 13796.6 13936.7 11571.8 11699.2 11779.8 11888.1 12478.8 11865.9 12077.5 12351.4 12753.5 12770.7 11491.7 11737.4 11981.4 12096.8 12509.6 9543.1 9893.6 10252.6 10430.6 10733.6 8846.8 9988.9 10066.6 10131.8 10262.4 06:18:29 INFO - PROCESS | 359 | -------- Summary: end -------- 06:18:29 INFO - PROCESS | 359 | 06:18:30 INFO - TEST-INFO | 359: exit 0 06:18:30 INFO - TEST-OK | dromaeo_css | took 1117965ms 06:18:30 INFO - TEST-START | kraken 06:18:30 INFO - operating with platform_type : linux_ 06:18:30 INFO - Initialising browser for kraken test... 06:18:30 INFO - TEST-INFO | started process 676 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptoI4IG/profile http://localhost:33771/getInfo.html) 06:18:35 INFO - PROCESS | 676 | __metrics Screen width/height:1600/1200 06:18:35 INFO - PROCESS | 676 | colorDepth:24 06:18:35 INFO - PROCESS | 676 | Browser inner width/height: 1024/697 06:18:35 INFO - PROCESS | 676 | __metrics 06:18:36 INFO - PROCESS | 676 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 06:18:36 INFO - PROCESS | 676 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 205: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:18:36 INFO - PROCESS | 676 | console.error: PushService: 06:18:36 INFO - PROCESS | 676 | stateChangeProcessEnqueue: Error transitioning state 06:18:36 INFO - PROCESS | 676 | UnknownError 06:18:37 INFO - TEST-INFO | 676: exit 0 06:18:37 INFO - Browser initialized. 06:18:37 INFO - Running cycle 1/1 for kraken test... 06:18:37 INFO - TEST-INFO | started process 763 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptoI4IG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:18:49 INFO - PROCESS | 763 | RSS: Main: 174600192 06:18:49 INFO - PROCESS | 763 | 06:18:52 INFO - PROCESS | 763 | Cycle 1(1): loaded http://localhost:33771/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33771/tests/kraken/driver.html?testName=audio-beat-detection) 06:18:52 INFO - PROCESS | 763 | RSS: Main: 231694336 06:18:52 INFO - PROCESS | 763 | 06:18:55 INFO - PROCESS | 763 | Cycle 1(1): loaded http://localhost:33771/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33771/tests/kraken/driver.html?testName=audio-dft) 06:18:56 INFO - PROCESS | 763 | RSS: Main: 218337280 06:18:56 INFO - PROCESS | 763 | 06:18:59 INFO - PROCESS | 763 | Cycle 1(1): loaded http://localhost:33771/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33771/tests/kraken/driver.html?testName=audio-fft) 06:18:59 INFO - PROCESS | 763 | RSS: Main: 300134400 06:18:59 INFO - PROCESS | 763 | 06:19:02 INFO - PROCESS | 763 | Cycle 1(1): loaded http://localhost:33771/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33771/tests/kraken/driver.html?testName=audio-oscillator) 06:19:02 INFO - PROCESS | 763 | RSS: Main: 209256448 06:19:02 INFO - PROCESS | 763 | 06:19:04 INFO - PROCESS | 763 | Cycle 1(1): loaded http://localhost:33771/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33771/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:19:05 INFO - PROCESS | 763 | RSS: Main: 214315008 06:19:05 INFO - PROCESS | 763 | 06:19:08 INFO - PROCESS | 763 | Cycle 1(1): loaded http://localhost:33771/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33771/tests/kraken/driver.html?testName=imaging-darkroom) 06:19:08 INFO - PROCESS | 763 | RSS: Main: 250216448 06:19:08 INFO - PROCESS | 763 | 06:19:12 INFO - PROCESS | 763 | Cycle 1(1): loaded http://localhost:33771/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33771/tests/kraken/driver.html?testName=imaging-desaturate) 06:19:12 INFO - PROCESS | 763 | RSS: Main: 248471552 06:19:12 INFO - PROCESS | 763 | 06:19:15 INFO - PROCESS | 763 | Cycle 1(1): loaded http://localhost:33771/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33771/tests/kraken/driver.html?testName=json-parse-financial) 06:19:16 INFO - PROCESS | 763 | RSS: Main: 248868864 06:19:16 INFO - PROCESS | 763 | 06:19:17 INFO - PROCESS | 763 | Cycle 1(1): loaded http://localhost:33771/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33771/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:19:18 INFO - PROCESS | 763 | RSS: Main: 211238912 06:19:18 INFO - PROCESS | 763 | 06:19:19 INFO - PROCESS | 763 | Cycle 1(1): loaded http://localhost:33771/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33771/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:19:20 INFO - PROCESS | 763 | RSS: Main: 219316224 06:19:20 INFO - PROCESS | 763 | 06:19:22 INFO - PROCESS | 763 | Cycle 1(1): loaded http://localhost:33771/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33771/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:19:23 INFO - PROCESS | 763 | RSS: Main: 228327424 06:19:23 INFO - PROCESS | 763 | 06:19:25 INFO - PROCESS | 763 | Cycle 1(1): loaded http://localhost:33771/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33771/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:19:26 INFO - PROCESS | 763 | RSS: Main: 237084672 06:19:26 INFO - PROCESS | 763 | 06:19:29 INFO - PROCESS | 763 | Cycle 1(1): loaded http://localhost:33771/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33771/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:19:29 INFO - PROCESS | 763 | RSS: Main: 234098688 06:19:29 INFO - PROCESS | 763 | 06:19:31 INFO - PROCESS | 763 | Cycle 1(1): loaded http://localhost:33771/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33771/tests/kraken/driver.html?testName=ai-astar) 06:19:31 INFO - PROCESS | 763 | RSS: Main: 283504640 06:19:31 INFO - PROCESS | 763 | 06:19:31 INFO - PROCESS | 763 | __start_tp_report 06:19:31 INFO - PROCESS | 763 | _x_x_mozilla_page_load 06:19:31 INFO - PROCESS | 763 | _x_x_mozilla_page_load_details 06:19:31 INFO - PROCESS | 763 | |i|pagename|runs| 06:19:31 INFO - PROCESS | 763 | |0;ai-astar;104;112;111;111;112;114;111;113;112;111 06:19:31 INFO - PROCESS | 763 | |1;audio-beat-detection;154;122;121;156;128;125;128;127;177;123 06:19:31 INFO - PROCESS | 763 | |2;audio-dft;160;161;160;159;160;159;159;160;161;161 06:19:31 INFO - PROCESS | 763 | |3;audio-fft;74;77;76;109;76;77;76;77;103;74 06:19:31 INFO - PROCESS | 763 | |4;audio-oscillator;82;81;112;83;83;82;109;83;83;115 06:19:31 INFO - PROCESS | 763 | |5;imaging-gaussian-blur;117;116;117;116;117;117;117;117;117;116 06:19:31 INFO - PROCESS | 763 | |6;imaging-darkroom;145;145;146;152;146;145;146;145;145;146 06:19:31 INFO - PROCESS | 763 | |7;imaging-desaturate;85;85;84;84;84;84;85;84;84;85 06:19:31 INFO - PROCESS | 763 | |8;json-parse-financial;53;54;55;54;55;54;55;54;54;55 06:19:31 INFO - PROCESS | 763 | |9;json-stringify-tinderbox;61;62;62;61;62;61;62;62;63;63 06:19:31 INFO - PROCESS | 763 | |10;stanford-crypto-aes;85;80;80;81;80;79;79;79;79;80 06:19:31 INFO - PROCESS | 763 | |11;stanford-crypto-ccm;143;133;127;129;131;137;132;133;175;136 06:19:31 INFO - PROCESS | 763 | |12;stanford-crypto-pbkdf2;165;165;163;163;167;165;166;168;169;164 06:19:31 INFO - PROCESS | 763 | |13;stanford-crypto-sha256-iterative;63;65;64;65;68;65;64;65;63;65 06:19:31 INFO - PROCESS | 763 | __end_tp_report 06:19:31 INFO - PROCESS | 763 | __start_cc_report 06:19:31 INFO - PROCESS | 763 | _x_x_mozilla_cycle_collect,1706 06:19:31 INFO - PROCESS | 763 | __end_cc_report 06:19:31 INFO - PROCESS | 763 | __startTimestamp1477833571864__endTimestamp 06:19:31 INFO - PROCESS | 763 | 06:19:31 INFO - PROCESS | 763 | ------- Summary: start ------- 06:19:31 INFO - PROCESS | 763 | Number of tests: 14 06:19:31 INFO - PROCESS | 763 | 06:19:31 INFO - PROCESS | 763 | [#0] ai-astar Cycles:10 Average:111.10 Median:112.00 stddev:2.69 (2.4%) stddev-sans-first:1.05 06:19:31 INFO - PROCESS | 763 | Values: 104.0 112.0 111.0 111.0 112.0 114.0 111.0 113.0 112.0 111.0 06:19:31 INFO - PROCESS | 763 | 06:19:31 INFO - PROCESS | 763 | [#1] audio-beat-detection Cycles:10 Average:136.10 Median:128.00 stddev:19.22 (15.0%) stddev-sans-first:19.26 06:19:31 INFO - PROCESS | 763 | Values: 154.0 122.0 121.0 156.0 128.0 125.0 128.0 127.0 177.0 123.0 06:19:31 INFO - PROCESS | 763 | 06:19:31 INFO - PROCESS | 763 | [#2] audio-dft Cycles:10 Average:160.00 Median:160.00 stddev:0.82 (0.5%) stddev-sans-first:0.87 06:19:31 INFO - PROCESS | 763 | Values: 160.0 161.0 160.0 159.0 160.0 159.0 159.0 160.0 161.0 161.0 06:19:31 INFO - PROCESS | 763 | 06:19:31 INFO - PROCESS | 763 | [#3] audio-fft Cycles:10 Average:81.90 Median:76.00 stddev:12.83 (16.9%) stddev-sans-first:13.28 06:19:31 INFO - PROCESS | 763 | Values: 74.0 77.0 76.0 109.0 76.0 77.0 76.0 77.0 103.0 74.0 06:19:31 INFO - PROCESS | 763 | 06:19:31 INFO - PROCESS | 763 | [#4] audio-oscillator Cycles:10 Average:91.30 Median:82.50 stddev:14.37 (17.4%) stddev-sans-first:14.84 06:19:31 INFO - PROCESS | 763 | Values: 82.0 81.0 112.0 83.0 83.0 82.0 109.0 83.0 83.0 115.0 06:19:31 INFO - PROCESS | 763 | 06:19:31 INFO - PROCESS | 763 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 06:19:31 INFO - PROCESS | 763 | Values: 117.0 116.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 116.0 06:19:31 INFO - PROCESS | 763 | 06:19:31 INFO - PROCESS | 763 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:2.13 (1.5%) stddev-sans-first:2.22 06:19:31 INFO - PROCESS | 763 | Values: 145.0 145.0 146.0 152.0 146.0 145.0 146.0 145.0 145.0 146.0 06:19:31 INFO - PROCESS | 763 | 06:19:31 INFO - PROCESS | 763 | [#7] imaging-desaturate Cycles:10 Average:84.40 Median:84.50 stddev:0.52 (0.6%) stddev-sans-first:0.50 06:19:31 INFO - PROCESS | 763 | Values: 85.0 85.0 84.0 84.0 84.0 84.0 85.0 84.0 84.0 85.0 06:19:31 INFO - PROCESS | 763 | 06:19:31 INFO - PROCESS | 763 | [#8] json-parse-financial Cycles:10 Average:54.30 Median:54.50 stddev:0.67 (1.2%) stddev-sans-first:0.53 06:19:31 INFO - PROCESS | 763 | Values: 53.0 54.0 55.0 54.0 55.0 54.0 55.0 54.0 54.0 55.0 06:19:31 INFO - PROCESS | 763 | 06:19:31 INFO - PROCESS | 763 | [#9] json-stringify-tinderbox Cycles:10 Average:61.90 Median:62.00 stddev:0.74 (1.2%) stddev-sans-first:0.71 06:19:31 INFO - PROCESS | 763 | Values: 61.0 62.0 62.0 61.0 62.0 61.0 62.0 62.0 63.0 63.0 06:19:31 INFO - PROCESS | 763 | 06:19:31 INFO - PROCESS | 763 | [#10] stanford-crypto-aes Cycles:10 Average:80.20 Median:80.00 stddev:1.81 (2.3%) stddev-sans-first:0.71 06:19:31 INFO - PROCESS | 763 | Values: 85.0 80.0 80.0 81.0 80.0 79.0 79.0 79.0 79.0 80.0 06:19:31 INFO - PROCESS | 763 | 06:19:31 INFO - PROCESS | 763 | [#11] stanford-crypto-ccm Cycles:10 Average:137.60 Median:134.50 stddev:13.88 (10.3%) stddev-sans-first:14.59 06:19:31 INFO - PROCESS | 763 | Values: 143.0 133.0 127.0 129.0 131.0 137.0 132.0 133.0 175.0 136.0 06:19:31 INFO - PROCESS | 763 | 06:19:31 INFO - PROCESS | 763 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.50 Median:165.50 stddev:2.01 (1.2%) stddev-sans-first:2.13 06:19:31 INFO - PROCESS | 763 | Values: 165.0 165.0 163.0 163.0 167.0 165.0 166.0 168.0 169.0 164.0 06:19:31 INFO - PROCESS | 763 | 06:19:31 INFO - PROCESS | 763 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.70 Median:65.00 stddev:1.42 (2.2%) stddev-sans-first:1.36 06:19:31 INFO - PROCESS | 763 | Values: 63.0 65.0 64.0 65.0 68.0 65.0 64.0 65.0 63.0 65.0 06:19:31 INFO - PROCESS | 763 | -------- Summary: end -------- 06:19:31 INFO - PROCESS | 763 | 06:19:33 INFO - TEST-INFO | 763: exit 0 06:19:33 INFO - TEST-OK | kraken | took 62347ms 06:19:33 INFO - SUITE-END | took 1180s 06:19:33 INFO - Completed test suite (00:19:40) 06:19:33 INFO - javascript benchmark 06:19:33 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2935.8550165435477, 2972.762179025678, 3004.984975075125, 3016.7737419693512, 3019.1697283247104, 4988.825391111312, 5070.974645126769, 5091.923621145681, 5146.871328216792, 5232.398274198464, 5077.3907131144315, 5141.177411614142, 5179.093658609738, 5188.92216616751, 5231.764570594323, 4697.53024697531, 4704.294355846633, 4772.856814295559, 4779.354787103749, 4789.090072886158, 4800.183968725325, 4810.855674329776, 4863.732494712789, 4866.902661946759, 4924.753762311888, 4637.582617564435, 4763.714177149365, 4770.427548694144, 4770.522947705236, 4887.975560122212, 4643.210654188762, 4675.298705194214, 4710.505396933307, 4719.10337035962, 4733.952660473386, 4714.080754252922, 4719.0, 4724.149653062447, 4761.6904901181315, 4786.305985632099, 5132.769025393866, 5160.535551800356, 5165.509276618715, 5167.741612919339, 5168.534831865112, 5297.47025297471, 5335.919961200585, 5431.782728690887, 5473.0969390050595, 5566.276384070085, 5526.032944234743, 5542.0855558832745, 5543.307086614173, 5603.3836278009385, 5609.046462101453, 5194.27280180775, 5196.948030519684, 5196.9740151299, 5197.506236907488, 5248.343957005374, 5493.7802487900835, 5544.1960915667005, 5570.220169176318, 5647.463490968352, 5650.23721797552, 5407.70257635826, 5434.972825135849, 5446.373667028263, 5499.0, 5510.91733623996, 5478.150886612581, 5527.088030474926, 5527.695976721238, 5532.944670553324, 5536.944630553723, 5312.1500559911, 5352.57179425645, 5461.180822876521, 5518.862028449321, 5540.335159780852, 5375.220593014069, 5428.809991650273, 5461.208124821958, 5601.187827764951, 5608.186812912105, 4237.745735255895, 4238.618524332764, 4262.808173632194, 4284.378765079046, 4337.891552711208, 3835.827387767557, 3853.2293541291856, 3857.864974725871, 3894.922101557953, 3901.4733011043713, 5110.361204849394, 5142.2286657001005, 5220.086484865134, 5236.659617124875, 5268.078086334876, 5465.699386533779, 5466.480684334982, 5476.288082549323, 5491.588130890199, 5508.14623733322, 5165.612579056586, 5224.320838290998, 5224.320838290998, 5224.764885580158, 5305.893882122413, 4552.590266875931, 4583.427071616048, 4610.585047345688, 4619.5611416915335, 4646.767661616906, 5596.132599447093, 5597.160425936142, 5597.384287728265, 5646.774129034792, 5664.716764161858, 5403.189521571796, 5403.756830942539, 5410.107332290128, 5410.810621628224, 5414.242006119225, 5483.616146869681, 5545.833624991256, 5605.271314729059, 5647.915281270702, 5674.687892165971, 5383.703896285742, 5486.6982315973, 5486.890262194814, 5515.117581186991, 5536.252605898152, 5499.092649712753, 5537.473939975695, 5545.112781954868, 5545.694986775766, 5548.4174161712435, 5287.0, 5325.0, 5408.4321146280645, 5459.235707000944, 5527.115661494142, 5347.304850369427, 5379.085555455504, 5388.976094542025, 5436.103042997861, 5485.6434331768305, 5348.625596208228, 5353.357597088374, 5374.220737992891, 5386.730663466733, 5387.407385187705, 5259.579233661221, 5455.045367060828, 5473.644213126293, 5475.123980163314, 5536.114221724666, 5200.5059519345605, 5261.736913154404, 5282.894342113059, 5311.734413279398, 5383.7846486140115], "value": 5087.968308153226, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [542.374729153323, 577.6534079552268, 591.2874985642303, 623.9656818874963, 634.5082561015215, 30160.0, 41584.0, 41973.16053678932, 42238.57761422389, 42260.57739422605, 44219.77890110553, 44637.10725785483, 44670.77664611673, 44742.32886506705, 44768.0, 7903.249191326843, 8758.0, 8947.50788706621, 8954.14935581122, 8959.104089591021, 7977.641006154708, 10447.268691191619, 10689.412082335468, 10704.46477676117, 11043.558257669683, 10794.082502987256, 10908.945455272713, 10916.345019298828, 10926.562937482491, 10928.0, 7807.453478256524, 8005.6797728090805, 10679.946600266987, 10733.51699173539, 10753.408562529057, 8069.435139540235, 8125.065617454009, 10246.0, 10575.947120264427, 10594.311369761019, 40922.0, 41280.0, 41328.627278453605, 41388.37917431241, 41392.0, 3251.756118291114, 3265.6244531878665, 3328.8502017409273, 3340.866365345383, 3363.327334533103, 29665.851670741726, 30365.848170759225, 30429.543556846664, 31108.533371999438, 31413.214669633213, 3783.5270591176104, 3904.2191561687778, 3923.8626648067466, 3958.841646334143, 4032.5967403259733, 346218.0, 347754.0, 348529.0, 348847.99999999744, 349100.0, 55216.44783552193, 55441.0, 55636.72181639066, 55664.72167639217, 55755.0, 58566.707166464745, 58569.41430585725, 58813.117803232984, 58836.41163588395, 58851.0, 15431.922840385727, 15688.058716477048, 15688.215589220494, 15691.450799221973, 15691.921540392224, 11002.779944401067, 11161.162912781574, 11233.831492527619, 12112.39438028095, 12179.0, 15264.23678816077, 15747.212639367986, 15892.443764468188, 15945.601359966093, 15950.60123496922, 5215.7913683453, 6190.2571691397325, 6354.904676429857, 6416.486681065504, 6428.19647544057, 943.8489841625307, 1028.9588416463407, 1029.9897001030045, 1055.519738518972, 1099.6920862158609, 27581.448371032468, 27774.583381249297, 27837.0, 28418.857905710753, 28492.857535712188, 1086.896744809242, 1094.217634391398, 1118.669992352258, 1139.5270962550449, 1183.3964678014274, 15142.545723628089, 15684.451044213398, 15716.449924252596, 15989.680206395808, 16021.919890400706, 493562.0, 496297.0, 498024.0, 499687.0, 500591.0, 45742.313865292046, 53962.73018634882, 55169.172462413095, 55245.72377138169, 60359.396406036256, 1280.8398950131234, 1296.4425297122139, 1307.7319149574125, 1319.3139567424885, 1334.5129027904745, 30216.0, 32265.838670806497, 33921.49117763285, 33987.32025359529, 34144.0, 52873.7356313216, 53315.20027199518, 53436.0, 53489.0, 53525.732371337894, 463774.0, 464323.0, 469026.0, 469674.0, 470062.0, 26832.463350733266, 27128.186154415398, 27132.593011105244, 27206.591901121104, 27229.04698335549, 46323.0, 46332.53667463282, 46914.76542617265, 47176.29235561538, 47379.526204737514, 39283.0, 39654.405183921685, 39940.800295998335, 41288.38067428931, 41727.37408938929, 37361.43957840689, 39551.40672889852, 39642.40536391899, 39994.800025999684, 40385.0, 36424.63575364213, 39862.20275594414, 40653.593464066165, 40933.590664092975, 40973.1805363897, 30476.695233047387, 34299.0, 35249.0, 36013.63986360103, 36169.45745813762, 24874.378140546632, 26377.340566485993, 26471.33821654474, 26942.73057269402, 27803.58294625623], "value": 19588.766285983875, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [365.4919661670277, 375.470586473073, 375.9604693023789, 389.4800441410717, 397.78122032881924, 13875.930620346897, 17436.476905692834, 17597.824021759778, 18259.726104108417, 18490.35283765065, 17796.733049004277, 17893.418117023462, 18067.81932180678, 18120.18459169337, 18412.539686507844, 5494.972525137378, 5688.175214593882, 5717.885642287151, 5745.253117094772, 5751.683657398841, 4062.045419326456, 4289.613934745872, 5572.108462645978, 5666.46168613981, 5677.0, 4317.784110794463, 6325.240971083476, 6379.553431259814, 6419.422251997319, 6492.123563318939, 6229.190205273331, 6314.905276420857, 6366.522510811661, 6461.579997300184, 6469.773557925473, 5523.6685798852195, 5547.944520554784, 5552.583556233259, 5554.361463368316, 5555.722213889289, 21377.144914203414, 21385.67921481179, 21558.245461408776, 21603.135874565, 21726.13095476179, 2207.3708992936936, 2253.9098436062536, 2519.7102333231546, 2828.702986186462, 3099.736522395599, 9439.292053095976, 9843.950780246125, 9885.505724713736, 9893.653722119763, 9893.802123957552, 1854.6568884756364, 1915.5594213330874, 1941.7766956800008, 1993.3421970749619, 2077.511784730587, 79598.0, 79898.6005069971, 79990.99999999942, 80107.0, 82100.0, 10325.586976520855, 10340.844887326695, 10520.473976301155, 10914.836277455845, 10945.179111566664, 14819.481318153812, 14831.332590033475, 14868.479603214051, 14872.405103795943, 14877.628059298388, 7276.017737605462, 7524.5861477619255, 7527.962360188164, 7657.387409007266, 7748.108967468813, 7060.752873649398, 7184.425245980309, 7261.8547629047125, 7308.744193953186, 7349.412047036224, 4458.7547684877645, 4534.093181363741, 4537.342085397665, 4600.6549508786975, 4681.555252251031, 1866.6733321668653, 1898.677224871775, 1913.111202084834, 1959.511420495962, 1963.528753099246, 706.7628870072737, 778.8948491953627, 826.6197549127348, 919.2048877720723, 1020.260311274335, 17526.561835953948, 17625.55936101582, 18280.62351894245, 18963.525911852037, 19215.615687686168, 955.4362925873768, 977.9070988256104, 1015.8628585141059, 1049.7900419916048, 1059.8145324568325, 9905.355883725706, 10599.735006624896, 10628.787424251626, 10665.786684266272, 10673.306235094695, 439037.0, 439047.0, 459925.0, 462314.0, 462336.7532649395, 85182.5740871304, 86173.13826861777, 88266.38002149736, 88834.0, 89590.55204724065, 985.7092157813462, 1008.7780688248573, 1019.9490025498844, 1022.6727447216967, 1035.6789395287335, 16059.678806423572, 16441.0, 16605.83394166043, 16896.40862569804, 16983.7452438216, 41243.0, 42366.5763342375, 42723.7863810679, 43085.3537196936, 43289.3506597395, 55827.16259256033, 57385.426145738005, 59009.40990590039, 59758.40241597702, 60806.0, 6501.44737697301, 8015.278624923785, 8160.387970902325, 8477.74566762998, 8606.913930860861, 11435.428228588371, 12606.93696531548, 12726.490940362282, 12817.87182128204, 12821.358932053547, 6798.456123510008, 10494.370337779757, 10813.56745730162, 10879.782404352027, 11437.085033197158, 10254.794904102026, 10599.523021464207, 10610.469476526298, 10679.89320106789, 10865.456727163451, 10722.73193170177, 10745.140388769036, 10770.51532681047, 11188.496517656562, 11465.541378344773, 7240.239774823778, 7535.397168226419, 7594.202608726005, 7773.533587984739, 8440.409171357946, 10538.631147909786, 11198.608048718255, 11362.0, 11476.426178690865, 11581.0], "value": 8861.435729343653, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1405.8755834981496, 1463.070949946784, 1555.18352864746, 1699.1419333236713, 1732.861371090313, 7834.960825195873, 8368.958155209231, 8369.874451883219, 8370.246677799005, 8387.0, 7183.0, 7386.4460165487535, 7928.524288542677, 8167.346612271019, 8253.0, 2238.675392068153, 2261.3781210167253, 2265.5808675395106, 2266.909323627053, 2274.385915802732, 2185.49733561281, 2209.9005544750526, 2245.494763678176, 2255.954880902381, 2257.604919139152, 2187.4093994621444, 2213.5351576169023, 2247.8763667998255, 2274.943126421836, 2278.3734473019886, 2167.6856855755905, 2170.934871953844, 2188.8577242479187, 2195.8462907596554, 2197.527531580718, 2228.353777404551, 2236.9217077402377, 2251.8198544116594, 2252.662100684894, 2255.5827171973237, 8340.833183336359, 8358.373122015873, 8454.070052294242, 8458.281046111088, 8468.110848360957, 4911.631627627942, 5056.241563765428, 5061.772220250097, 5063.873403164914, 5064.366954130734, 3156.4949608062598, 3271.8364081796053, 3378.2061215614312, 3421.1447138215444, 3451.758376913617, 1096.5887792077972, 1105.5688281570194, 1128.8024595695802, 1149.126663735567, 1151.6602602232279, 11363.772724545463, 11429.371384573846, 11458.484368203452, 11485.540578376938, 11495.712607184803, 4305.827766889352, 4432.268675668543, 4532.773361331986, 4557.521460246693, 4559.726416415026, 9676.080772326617, 9680.661176858775, 9680.903190968, 9684.0, 9688.951555242178, 5045.066662667418, 5049.520295571915, 5050.49495050492, 5052.520010598987, 5053.949460505348, 4105.507339119265, 4435.645148388121, 4632.60622847055, 4651.953480465219, 4662.277347011219, 3634.509341238952, 3685.8341374638208, 3755.1363186467265, 3768.698504119664, 3813.5423749149722, 1195.7907366210877, 1203.139755075108, 1210.7881120803825, 1212.4968138222716, 1227.1900545639835, 910.2581396162107, 913.57975331347, 915.4049867586123, 940.8689318693165, 942.495764765847, 5569.498745112959, 5574.16387541872, 5684.744186511617, 5700.315962084576, 5840.415958404125, 898.4609234459272, 928.4707716601472, 930.8929473110679, 944.5230158769778, 955.7323949294208, 3892.824822882977, 3892.8637497687446, 3914.178022615226, 3921.098147426108, 3949.585293544194, 9485.762855928657, 9928.156106730865, 9944.10503054714, 9950.45272510019, 9950.701478955643, 9628.133467987915, 9888.653897113567, 9898.158656514277, 9901.801963960681, 9902.059304366074, 7588.848223035508, 7835.0597928247835, 7878.330341920886, 7937.32532734724, 7941.2455816698475, 5383.5962302826665, 5385.192221166856, 5391.595630327663, 5398.244245805512, 5537.833864984057, 9254.814903701754, 9261.120193581599, 9270.304727145356, 9354.672586459441, 9472.715818525456, 9494.24046076326, 9538.904610953801, 9541.856872146784, 9660.855087173557, 9687.225021998363, 6319.8104056878365, 6492.870142597216, 6865.519413640997, 7022.54353467023, 7188.065551478275, 7857.842843143219, 8175.0, 8201.753947381589, 8202.17978202175, 8208.548529830916, 7221.31397517235, 7384.52000619958, 7501.662425190771, 7562.773116806505, 7678.385729141543, 7103.822404439724, 7234.782956511313, 7257.709691612276, 7336.926630733838, 7486.6256687166515, 6513.218413790375, 6619.66901654925, 6634.734610615521, 6635.966820165868, 6641.435477984425, 4735.928961065518, 4748.3352330674425, 4800.303955926441, 5021.221710634857, 5062.240663900445, 4866.172750632471, 4902.485239049991, 4905.337779399735, 5037.92443113361, 5083.644144909968], "value": 4406.015221424824, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [313.69884910485916, 333.85310463396104, 336.91071865955524, 340.5300685054625, 342.3478273888244, 5206.167013277876, 5293.338332708411, 5329.147336426173, 5341.759620817063, 5383.650062745919, 5267.157254839217, 5282.0, 5284.445133261001, 5286.550643195333, 5295.735213239342, 4192.790360481979, 4195.951012246938, 4204.159168166364, 4204.516480604724, 4205.768682722449, 4125.876223713293, 4175.394567787669, 4203.201391735561, 4206.768627725474, 4211.115665710189, 4135.255653982282, 4145.461090058288, 4150.294449943517, 4158.313878210091, 4164.333706606943, 4163.708540402173, 4166.458360413158, 4166.708330416872, 4182.665386769051, 4189.581041895816, 3670.853165873362, 3707.796071216082, 3719.3863012602887, 3727.552693676776, 3742.906427339311, 4920.3111564381015, 5127.769250383742, 5145.794168233266, 5153.330067091254, 5167.534921857051, 4656.604188643969, 4675.509071547473, 4683.531646835323, 4687.367205427257, 4707.105649926503, 5262.316218728438, 5449.3460784706085, 5455.072637651609, 5459.672419654833, 5462.754176062087, 3897.707671924589, 3933.567307596162, 3934.390169523728, 3947.1710940702487, 3949.407588861665, 5373.328333958255, 5510.724463776835, 5627.521660658849, 5645.689487078209, 5647.576431767593, 3898.493195884517, 3899.122697393064, 3906.7069969752383, 3910.0, 3954.7824869632445, 4058.228936502055, 4059.6048331484567, 4079.4696689430184, 4089.2434899543678, 4096.5903409659395, 4608.953910460919, 4609.700369475973, 4633.791479383436, 4652.813887444532, 4666.4633567139535, 5235.214717792285, 5441.6190866639745, 5554.777808887599, 5589.441055894378, 5596.873188188462, 1418.581518452059, 1435.9282035898163, 1438.3671184678708, 1442.9278536073155, 1444.8771854392285, 868.7654333330092, 890.8485557455248, 899.1547944931743, 912.4935660708238, 924.4176169013613, 4736.289556566474, 4744.2446294871115, 4768.737719425465, 4841.975790121027, 4849.151398505247, 5022.648414610942, 5031.7987280509105, 5060.49395060491, 5064.215046667772, 5085.262636917626, 4773.570378665937, 4800.231962885921, 4805.8077676892535, 4821.445533763592, 5025.271335656383, 2979.4636965346444, 3015.381846721417, 3022.5163973764093, 3025.712557307096, 3029.9242518936762, 5848.116822453214, 5870.094303319798, 5896.174535565025, 5905.43898329658, 5919.289685237799, 5540.972295138579, 5776.711164441761, 5798.333191682926, 5804.332501762267, 5812.534997200214, 5838.766449342149, 5852.765889364463, 5869.0, 5884.704965063629, 5888.941110588925, 5413.269208656939, 5646.463585959327, 5671.801486947937, 5687.402822703557, 5702.857428564153, 5633.577481688808, 5637.43625637433, 5649.994252040467, 5664.895345407606, 5680.630759000817, 5639.0, 5740.68426236561, 5795.391483894299, 5872.29532456108, 5879.559033072451, 4075.633193012643, 4082.1427500225286, 4084.9795751021056, 4093.6929730269753, 4098.959010409858, 5723.399043100415, 5724.284464441945, 5729.799457018984, 5731.312242530923, 5736.8239510901, 5389.568834493152, 5523.392426832965, 5580.665160090408, 5603.74783134768, 5618.297712785902, 5551.250581171652, 5554.389017208185, 5586.1062230043, 5588.497035266845, 5589.888202236014, 5275.551578115903, 5553.888922221452, 5559.555235581225, 5561.582881283839, 5583.0787919992745, 5586.217929489793, 5599.272094627672, 5616.38219795814, 5621.578381621476, 5622.606417550732, 5473.534749546174, 5481.697686971402, 5493.2858728366655, 5497.36780270274, 5570.916436253378], "value": 4189.3551733142, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [714.9571025738456, 729.7227053719586, 761.8819083042131, 764.6176911544228, 794.3645083932852, 12861.614151575455, 13370.264635445072, 13441.126326788752, 13451.260180690058, 13460.999999999987, 12550.0, 12625.873741262585, 12702.618921432371, 12705.174163679354, 12710.872891271085, 764.6635480388625, 776.2121446731572, 777.7316825695154, 777.8755399136139, 778.283978739561, 774.0363247756551, 774.8566515194678, 777.5529070784322, 777.7977725791307, 778.2567647896245, 801.3549092980148, 803.1045384396415, 803.3091541274499, 803.3894240377297, 803.4737247103128, 800.083903929997, 803.1887793328722, 803.2971150243537, 804.2359758229646, 804.4489524675616, 588.7821506042749, 592.6651441935293, 593.5666963116905, 594.8661551151, 595.2291782142137, 11512.079033677286, 11512.539498420054, 11524.020458261059, 11528.423578821026, 11529.308241505452, 11107.333559986346, 11303.604373846958, 11365.374904380256, 11917.735630230316, 12016.279023258545, 10207.489625518769, 10220.74448138795, 10328.948355258251, 10389.42858142802, 10874.782504349947, 3572.5355703758605, 3614.9096272593133, 3678.2275722098125, 3792.9620703792884, 3795.6773674237725, 58483.707581462244, 59146.0, 59985.0, 64695.35304646987, 65011.67494162499, 8392.496450213006, 8502.957485212535, 8677.1756683115, 9906.752331191778, 10436.060754532129, 17349.13254337278, 17478.91260543689, 17512.64974700524, 17518.824811751718, 17541.386051488138, 7036.366726994493, 7346.6326683666675, 7351.926480735231, 7633.313001829751, 7791.766247012599, 3972.8609498667406, 4034.435179074932, 4035.9394609080887, 4039.656629186552, 4050.696197785178, 3333.933321333608, 3372.3423932332958, 3376.9662303376654, 3401.6768407001296, 3414.573178352706, 573.8995675756726, 583.9970800146057, 589.9616524925866, 592.2448877680905, 609.704293417692, 621.1025068775576, 636.4081404293959, 648.9772857950044, 660.207750699163, 667.9332066793281, 7491.8501629967095, 7862.764117076496, 7878.448508604342, 7989.920100799034, 8341.374396920255, 608.4432744039243, 621.4438077920236, 638.4381744065192, 649.4057936987604, 660.5376236634376, 3661.2677464506673, 3665.908352291214, 3711.2206436648607, 3728.7762734236035, 3852.4028775539837, 87181.0, 87916.56041719878, 91876.0, 92830.0, 94767.0, 51401.0, 59660.70169649124, 81329.59335203405, 81352.0, 85060.0, 50853.0, 67716.0, 69537.65231173811, 69666.65166674236, 70814.29185708077, 7320.0, 7372.115346158281, 7399.630018499161, 7441.590712510864, 7547.660355284135, 49321.50678493169, 49359.50640493549, 50474.495255048445, 50997.7450112747, 52743.73628131835, 40587.0, 52671.47328526819, 54943.0, 55139.724301378235, 57851.0, 12052.879471205526, 12281.0, 12350.197237179555, 12674.176178548734, 12683.619491415273, 13108.147970381895, 13165.0, 13285.335733213495, 13796.586102416944, 13936.651583710489, 11571.768564628828, 11699.181057325906, 11779.764404712028, 11888.108391870817, 12478.750424991267, 11865.881341186823, 12077.51689932428, 12351.444185011876, 12753.48986040585, 12770.68073298175, 11491.712707182387, 11737.413129343327, 11981.400929953641, 12096.818547721967, 12509.624711258677, 9543.141117299476, 9893.55479003461, 10252.58989640406, 10430.629151429332, 10733.570657173626, 8846.80568123295, 9988.900110998797, 10066.647667331608, 10131.79736405253, 10262.384256944608], "value": 6566.7683883612, "unit": "score"}], "name": "dromaeo_css", "value": 6890.877546832304, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 112.0, 111.0, 111.0, 112.0, 114.0, 111.0, 113.0, 112.0, 111.0], "value": 111.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 122.0, 121.0, 156.0, 128.0, 125.0, 128.0, 127.0, 177.0, 123.0], "value": 136.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 160.0, 159.0, 160.0, 159.0, 159.0, 160.0, 161.0, 161.0], "value": 160.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 77.0, 76.0, 109.0, 76.0, 77.0, 76.0, 77.0, 103.0, 74.0], "value": 81.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 81.0, 112.0, 83.0, 83.0, 82.0, 109.0, 83.0, 83.0, 115.0], "value": 91.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 146.0, 152.0, 146.0, 145.0, 146.0, 145.0, 145.0, 146.0], "value": 146.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 84.0, 84.0, 84.0, 84.0, 85.0, 84.0, 84.0, 85.0], "value": 84.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 54.0, 55.0, 54.0, 55.0, 54.0, 55.0, 54.0, 54.0, 55.0], "value": 54.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 62.0, 61.0, 62.0, 61.0, 62.0, 62.0, 63.0, 63.0], "value": 61.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 80.0, 80.0, 81.0, 80.0, 79.0, 79.0, 79.0, 79.0, 80.0], "value": 80.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 133.0, 127.0, 129.0, 131.0, 137.0, 132.0, 133.0, 175.0, 136.0], "value": 137.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 165.0, 163.0, 163.0, 167.0, 165.0, 166.0, 168.0, 169.0, 164.0], "value": 165.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 65.0, 64.0, 65.0, 68.0, 65.0, 64.0, 65.0, 63.0, 65.0], "value": 64.7, "unit": "score"}], "name": "kraken", "value": 1491.8, "alertThreshold": 2.0}]} 06:19:33 INFO - Return code: 0 06:19:33 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:19:33 INFO - # TBPL SUCCESS # 06:19:33 INFO - Running post-action listener: _resource_record_post_action 06:19:33 INFO - [mozharness: 2016-10-30 13:19:33.680543Z] Finished run-tests step (success) 06:19:33 INFO - Running post-run listener: _resource_record_post_run 06:19:33 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 4096; Write bytes: 398508032; Read time: 4; Write time: 505812 06:19:33 INFO - TinderboxPrint: CPU usage
13.1% 06:19:33 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 4 06:19:33 INFO - TinderboxPrint: I/O write bytes / time
398,508,032 / 505,812 06:19:33 INFO - TinderboxPrint: CPU idle
8,304.6 (86.9%) 06:19:33 INFO - TinderboxPrint: CPU user
1,199.6 (12.5%) 06:19:33 INFO - TinderboxPrint: Swap in / out
0 / 0 06:19:33 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 109314048; Read time: 0; Write time: 132132 06:19:33 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 0; Write bytes: 288817152; Read time: 0; Write time: 373656 06:19:34 INFO - Running post-run listener: _upload_blobber_files 06:19:34 INFO - Blob upload gear active. 06:19:34 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:19:34 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 06:19:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:19:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:19:34 INFO - (blobuploader) - INFO - Open directory for files ... 06:19:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:19:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:19:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:19:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:19:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:19:36 INFO - (blobuploader) - INFO - Done attempting. 06:19:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:19:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:19:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:19:39 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:19:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:19:39 INFO - (blobuploader) - INFO - Done attempting. 06:19:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:19:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:19:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:19:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:19:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:19:40 INFO - (blobuploader) - INFO - Done attempting. 06:19:40 INFO - (blobuploader) - INFO - Iteration through files over. 06:19:40 INFO - Return code: 0 06:19:40 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:19:40 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:19:40 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8860ca9d6e8bbf9a4fd0977f42be338b688b8be2fa2acf4c60ef70e00864a035cf2f3b3b4b24133a89cb4572156ade94d56aeda9a0ffa09ddd4bc48042c035db", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/60704d55821ccf6c4e3792d609fd648acf77424364bb554080e6124779ddae66239325bb1f571976af15cc27624c30b8eab3d755bbfc33360457957ab3152b8c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7dc1147abf2cd14f6abfc2fc1180ef42b0df507ed5dda14cb7e87e3e131b404bbe96a81109a8cb13f32ca7e1ad2612c731788713b906ebaa9f5e7345bca9ce18"} 06:19:40 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:19:40 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:19:40 INFO - Contents: 06:19:40 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8860ca9d6e8bbf9a4fd0977f42be338b688b8be2fa2acf4c60ef70e00864a035cf2f3b3b4b24133a89cb4572156ade94d56aeda9a0ffa09ddd4bc48042c035db", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/60704d55821ccf6c4e3792d609fd648acf77424364bb554080e6124779ddae66239325bb1f571976af15cc27624c30b8eab3d755bbfc33360457957ab3152b8c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7dc1147abf2cd14f6abfc2fc1180ef42b0df507ed5dda14cb7e87e3e131b404bbe96a81109a8cb13f32ca7e1ad2612c731788713b906ebaa9f5e7345bca9ce18"} 06:19:40 INFO - Running post-run listener: copy_logs_to_upload_dir 06:19:40 INFO - Copying logs to upload dir... 06:19:40 INFO - mkdir: /builds/slave/test/build/upload/logs 06:19:40 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1244.962945 ========= master_lag: -0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-10-30 06:19:38.794763) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-30 06:19:38.798031) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1477832331.64917-62864460 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8860ca9d6e8bbf9a4fd0977f42be338b688b8be2fa2acf4c60ef70e00864a035cf2f3b3b4b24133a89cb4572156ade94d56aeda9a0ffa09ddd4bc48042c035db", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/60704d55821ccf6c4e3792d609fd648acf77424364bb554080e6124779ddae66239325bb1f571976af15cc27624c30b8eab3d755bbfc33360457957ab3152b8c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7dc1147abf2cd14f6abfc2fc1180ef42b0df507ed5dda14cb7e87e3e131b404bbe96a81109a8cb13f32ca7e1ad2612c731788713b906ebaa9f5e7345bca9ce18"} build_url:https://queue.taskcluster.net/v1/task/Q8ZWW-SSR0eeW_aR4NU8zQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011391 build_url: 'https://queue.taskcluster.net/v1/task/Q8ZWW-SSR0eeW_aR4NU8zQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8860ca9d6e8bbf9a4fd0977f42be338b688b8be2fa2acf4c60ef70e00864a035cf2f3b3b4b24133a89cb4572156ade94d56aeda9a0ffa09ddd4bc48042c035db", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/60704d55821ccf6c4e3792d609fd648acf77424364bb554080e6124779ddae66239325bb1f571976af15cc27624c30b8eab3d755bbfc33360457957ab3152b8c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7dc1147abf2cd14f6abfc2fc1180ef42b0df507ed5dda14cb7e87e3e131b404bbe96a81109a8cb13f32ca7e1ad2612c731788713b906ebaa9f5e7345bca9ce18"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-30 06:19:38.824208) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-30 06:19:38.824551) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1477832331.64917-62864460 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004470 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-30 06:19:38.906444) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-30 06:19:38.906762) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-30 06:19:38.907054) ========= ========= Total master_lag: 0.15 =========