builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-016 starttime: 1475751205.3 results: success (0) buildid: 20161006030102 builduid: 89cef4394a5a4cb19a90251c4a6e7107 revision: 777fb63db8de8d78b64b8141d1a998397275dd03 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-06 03:53:25.299395) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-06 03:53:25.300223) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-06 03:53:25.300812) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-06 03:53:25.313107) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 03:53:25.313363) ========= 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=00204705a9daa57ed339a427000001b9-1475751204.987020-1913817406 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-06 03:53:25-- 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: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 44.0M=0s 2016-10-06 03:53:25 (44.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.080752 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 03:53:25.405652) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 03:53:25.405975) ========= 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=00204705a9daa57ed339a427000001b9-1475751204.987020-1913817406 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015251 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 03:53:25.455494) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 03:53:25.455844) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 777fb63db8de8d78b64b8141d1a998397275dd03 --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 777fb63db8de8d78b64b8141d1a998397275dd03 --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=00204705a9daa57ed339a427000001b9-1475751204.987020-1913817406 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-06 03:53:25,971 truncating revision to first 12 chars 2016-10-06 03:53:25,971 Setting DEBUG logging. 2016-10-06 03:53:25,971 attempt 1/10 2016-10-06 03:53:25,971 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/777fb63db8de?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-06 03:53:26,419 unpacking tar archive at: mozilla-central-777fb63db8de/testing/mozharness/ program finished with exit code 0 elapsedTime=0.790433 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 03:53:26.260384) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-06 03:53:26.260928) ========= script_repo_revision: 777fb63db8de8d78b64b8141d1a998397275dd03 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-06 03:53:26.261485) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-06 03:53:26.261777) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-06 03:53:26.272539) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-10-06 03:53:26.272832) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 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-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] 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=00204705a9daa57ed339a427000001b9-1475751204.987020-1913817406 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:53:26 INFO - MultiFileLogger online at 20161006 03:53:26 in /builds/slave/test 03:53:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 03:53:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:53:26 INFO - {'append_to_log': False, 03:53:26 INFO - 'base_work_dir': '/builds/slave/test', 03:53:26 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 03:53:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:53:26 INFO - 'branch': 'Firefox-Non-PGO', 03:53:26 INFO - 'buildbot_json_path': 'buildprops.json', 03:53:26 INFO - 'config_files': ('talos/linux_config.py',), 03:53:26 INFO - 'default_actions': ('clobber', 03:53:26 INFO - 'read-buildbot-config', 03:53:26 INFO - 'download-and-extract', 03:53:26 INFO - 'populate-webroot', 03:53:26 INFO - 'create-virtualenv', 03:53:26 INFO - 'install', 03:53:26 INFO - 'run-tests'), 03:53:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:53:26 INFO - 'download_minidump_stackwalk': True, 03:53:26 INFO - 'download_symbols': 'ondemand', 03:53:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:53:26 INFO - 'tooltool.py': '/tools/tooltool.py', 03:53:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:53:26 INFO - '/tools/misc-python/virtualenv.py')}, 03:53:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:53:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:53:26 INFO - 'installer_path': 'installer.exe', 03:53:26 INFO - 'log_level': 'info', 03:53:26 INFO - 'log_name': 'talos', 03:53:26 INFO - 'log_to_console': True, 03:53:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:53:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:53:26 INFO - 'opt_config_files': (), 03:53:26 INFO - 'pip_index': False, 03:53:26 INFO - 'sps_profile': False, 03:53:26 INFO - 'sps_profile_interval': 0, 03:53:26 INFO - 'suite': 'dromaeojs', 03:53:26 INFO - 'system_bits': '32', 03:53:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:53:26 INFO - 'title': 'talos-linux64-ix-016', 03:53:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:53:26 INFO - 'use_talos_json': True, 03:53:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:53:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:53:26 INFO - 'work_dir': 'build'} 03:53:26 INFO - [mozharness: 2016-10-06 10:53:26.890579Z] Running clobber step. 03:53:26 INFO - Running pre-action listener: _resource_record_pre_action 03:53:26 INFO - Running main action method: clobber 03:53:26 INFO - rmtree: /builds/slave/test/build 03:53:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:53:27 INFO - Running post-action listener: _resource_record_post_action 03:53:27 INFO - [mozharness: 2016-10-06 10:53:27.890544Z] Finished clobber step (success) 03:53:27 INFO - [mozharness: 2016-10-06 10:53:27.890644Z] Running read-buildbot-config step. 03:53:27 INFO - Running pre-action listener: _resource_record_pre_action 03:53:27 INFO - Running main action method: read_buildbot_config 03:53:27 INFO - Using buildbot properties: 03:53:27 INFO - { 03:53:27 INFO - "project": "", 03:53:27 INFO - "product": "firefox", 03:53:27 INFO - "script_repo_revision": "production", 03:53:27 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 03:53:27 INFO - "repository": "", 03:53:27 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 03:53:27 INFO - "buildid": "20161006030102", 03:53:27 INFO - "pgo_build": "False", 03:53:27 INFO - "basedir": "/builds/slave/test", 03:53:27 INFO - "buildnumber": 770, 03:53:27 INFO - "slavename": "talos-linux64-ix-016", 03:53:27 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 03:53:27 INFO - "platform": "ubuntu64_hw", 03:53:27 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 03:53:27 INFO - "branch": "mozilla-central", 03:53:27 INFO - "repo_path": "mozilla-central", 03:53:27 INFO - "revision": "777fb63db8de8d78b64b8141d1a998397275dd03", 03:53:27 INFO - "stage_platform": "linux64", 03:53:27 INFO - "builduid": "89cef4394a5a4cb19a90251c4a6e7107", 03:53:27 INFO - "slavebuilddir": "test" 03:53:27 INFO - } 03:53:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/MYIqc5asTL6ees4tNlhFvA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 03:53:27 INFO - Running post-action listener: _resource_record_post_action 03:53:27 INFO - [mozharness: 2016-10-06 10:53:27.893110Z] Finished read-buildbot-config step (success) 03:53:27 INFO - [mozharness: 2016-10-06 10:53:27.893198Z] Running download-and-extract step. 03:53:27 INFO - Running pre-action listener: _resource_record_pre_action 03:53:27 INFO - Running main action method: download_and_extract 03:53:27 INFO - mkdir: /builds/slave/test/build/tests 03:53: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')]} 03:53:27 INFO - trying https://queue.taskcluster.net/v1/task/MYIqc5asTL6ees4tNlhFvA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 03:53:27 INFO - Downloading https://queue.taskcluster.net/v1/task/MYIqc5asTL6ees4tNlhFvA/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 03:53:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MYIqc5asTL6ees4tNlhFvA/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 03:53:28 INFO - Downloaded 1361 bytes. 03:53:28 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 03:53:28 INFO - Using the following test package requirements: 03:53:28 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 03:53:28 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 03:53:28 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 03:53:28 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 03:53:28 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 03:53:28 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 03:53:28 INFO - u'jsshell-linux-x86_64.zip'], 03:53:28 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 03:53:28 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 03:53:28 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 03:53:28 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 03:53:28 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 03:53:28 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 03:53:28 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 03:53:28 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 03:53:28 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 03:53:28 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 03:53:28 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 03:53:28 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:53:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MYIqc5asTL6ees4tNlhFvA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 03:53:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MYIqc5asTL6ees4tNlhFvA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:53:28 INFO - Fetch https://queue.taskcluster.net/v1/task/MYIqc5asTL6ees4tNlhFvA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 03:53:29 INFO - Http code: 200 03:53:29 INFO - via: 1.1 d8f42fc9558e3e49ebfdf8834baeb756.cloudfront.net (CloudFront) 03:53:29 INFO - x-amz-cf-id: 0UW8c5OcpjTNvZjL-YBV7TKLS0IIx8s33qha4LRi3VGx50ZbQUVE-g== 03:53:29 INFO - x-amz-version-id: KmdH9._CX30SzYV0ub.z23YS.2xMWV8F 03:53:29 INFO - Expected file size: 20445658 03:53:29 INFO - Obtained file size: 20445658 03:53:33 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 03:53:33 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MYIqc5asTL6ees4tNlhFvA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 03:53:33 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MYIqc5asTL6ees4tNlhFvA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:53:33 INFO - Fetch https://queue.taskcluster.net/v1/task/MYIqc5asTL6ees4tNlhFvA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 03:53:34 INFO - Http code: 200 03:53:34 INFO - via: 1.1 ccaa055c9a26ce13da709353563e04a5.cloudfront.net (CloudFront) 03:53:34 INFO - x-amz-cf-id: erat4WpxJWV4ynFXK6EpfabqX_H2VtB8Z-PpjiO1TB8sv9du1w5G0Q== 03:53:34 INFO - x-amz-version-id: KmdH9._CX30SzYV0ub.z23YS.2xMWV8F 03:53:34 INFO - Expected file size: 20445658 03:53:34 INFO - Obtained file size: 20445658 03:53:38 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MYIqc5asTL6ees4tNlhFvA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 03:53:38 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MYIqc5asTL6ees4tNlhFvA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 03:53:38 INFO - Fetch https://queue.taskcluster.net/v1/task/MYIqc5asTL6ees4tNlhFvA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 03:53:39 INFO - Http code: 200 03:53:39 INFO - via: 1.1 f1a40337a32137e1c23ceffead6a50d5.cloudfront.net (CloudFront) 03:53:39 INFO - x-amz-cf-id: 0wajaJMD8XmwKeBylN574rKyRzx6oxSfwvS_8Sgt9VJGYnU_OnXW1w== 03:53:39 INFO - x-amz-version-id: g.MYLsm5aEge8Jri6UYkIqx6u5DoucfU 03:53:39 INFO - Expected file size: 14409006 03:53:39 INFO - Obtained file size: 14409006 03:53:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:53:40 INFO - trying https://queue.taskcluster.net/v1/task/MYIqc5asTL6ees4tNlhFvA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 03:53:40 INFO - Downloading https://queue.taskcluster.net/v1/task/MYIqc5asTL6ees4tNlhFvA/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 03:53:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MYIqc5asTL6ees4tNlhFvA/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 03:53:41 INFO - Downloaded 55806501 bytes. 03:53:41 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/MYIqc5asTL6ees4tNlhFvA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 03:53:41 INFO - mkdir: /builds/slave/test/properties 03:53:41 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:53:41 INFO - Writing to file /builds/slave/test/properties/build_url 03:53:41 INFO - Contents: 03:53:41 INFO - build_url:https://queue.taskcluster.net/v1/task/MYIqc5asTL6ees4tNlhFvA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 03:53:42 INFO - Running post-action listener: _resource_record_post_action 03:53:42 INFO - Running post-action listener: set_extra_try_arguments 03:53:42 INFO - [mozharness: 2016-10-06 10:53:42.128767Z] Finished download-and-extract step (success) 03:53:42 INFO - [mozharness: 2016-10-06 10:53:42.128993Z] Running populate-webroot step. 03:53:42 INFO - Running pre-action listener: _resource_record_pre_action 03:53:42 INFO - Running main action method: populate_webroot 03:53:42 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:53:42 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:53:42 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:53:42 INFO - '--tppagecycles', 03:53:42 INFO - '7'], 03:53:42 INFO - 'tests': ['tsvgm']}}, 03:53:42 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:53:42 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:53:42 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:53:42 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:53:42 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:53:42 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:53:42 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:53:42 INFO - 'talos_options': ['--disable-e10s'], 03:53:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:53:42 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:53:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:53:42 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:53:42 INFO - 'talos_options': ['--disable-e10s'], 03:53:42 INFO - 'tests': ['damp', 'tps']}, 03:53:42 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:53:42 INFO - 'tests': ['damp', 'tps']}, 03:53:42 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:53:42 INFO - 'tests': ['dromaeo_dom']}, 03:53:42 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:53:42 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:53:42 INFO - 'tests': ['basic_compositor_video']}, 03:53:42 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:53:42 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:53:42 INFO - 'tests': ['a11yr', 03:53:42 INFO - 'ts_paint', 03:53:42 INFO - 'tpaint', 03:53:42 INFO - 'sessionrestore', 03:53:42 INFO - 'sessionrestore_no_auto_restore', 03:53:42 INFO - 'tabpaint']}, 03:53:42 INFO - 'other-e10s': {'tests': ['a11yr', 03:53:42 INFO - 'ts_paint', 03:53:42 INFO - 'tpaint', 03:53:42 INFO - 'sessionrestore', 03:53:42 INFO - 'sessionrestore_no_auto_restore', 03:53:42 INFO - 'tabpaint']}, 03:53:42 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:53:42 INFO - 'ts_paint', 03:53:42 INFO - 'tpaint', 03:53:42 INFO - 'sessionrestore', 03:53:42 INFO - 'sessionrestore_no_auto_restore', 03:53:42 INFO - 'tabpaint']}, 03:53:42 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:53:42 INFO - 'ts_paint', 03:53:42 INFO - 'tpaint', 03:53:42 INFO - 'sessionrestore', 03:53:42 INFO - 'sessionrestore_no_auto_restore', 03:53:42 INFO - 'tabpaint']}, 03:53:42 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:53:42 INFO - 'tests': ['a11yr', 03:53:42 INFO - 'ts_paint', 03:53:42 INFO - 'tpaint', 03:53:42 INFO - 'sessionrestore', 03:53:42 INFO - 'sessionrestore_no_auto_restore', 03:53:42 INFO - 'tabpaint']}, 03:53:42 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:53:42 INFO - 'tests': ['a11yr', 03:53:42 INFO - 'ts_paint', 03:53:42 INFO - 'tpaint', 03:53:42 INFO - 'sessionrestore', 03:53:42 INFO - 'sessionrestore_no_auto_restore', 03:53:42 INFO - 'tabpaint']}, 03:53:42 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:53:42 INFO - 'tests': ['tsvgx', 03:53:42 INFO - 'tsvgr_opacity', 03:53:42 INFO - 'tart', 03:53:42 INFO - 'tscrollx', 03:53:42 INFO - 'cart']}, 03:53:42 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:53:42 INFO - 'tsvgr_opacity', 03:53:42 INFO - 'tart', 03:53:42 INFO - 'tscrollx', 03:53:42 INFO - 'cart']}, 03:53:42 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:53:42 INFO - 'talos_options': ['--disable-e10s'], 03:53:42 INFO - 'tests': ['tp5o']}, 03:53:42 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:53:42 INFO - 'tests': ['tp5o']}, 03:53:42 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:53:42 INFO - 'talos_options': ['--disable-e10s', 03:53:42 INFO - '--xperf_path', 03:53:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:53:42 INFO - 'tests': ['tp5n']}, 03:53:42 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:53:42 INFO - 'talos_options': ['--xperf_path', 03:53:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:53:42 INFO - 'tests': ['tp5n']}}, 03:53:42 INFO - 'talos.zip': {'path': '', 03:53:42 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:53:42 INFO - Running post-action listener: _resource_record_post_action 03:53:42 INFO - [mozharness: 2016-10-06 10:53:42.147611Z] Finished populate-webroot step (success) 03:53:42 INFO - [mozharness: 2016-10-06 10:53:42.147698Z] Running create-virtualenv step. 03:53:42 INFO - Running pre-action listener: _resource_record_pre_action 03:53:42 INFO - Running main action method: create_virtualenv 03:53:42 INFO - Creating virtualenv /builds/slave/test/build/venv 03:53:42 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 03:53:42 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:53:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:53:42 INFO - Using real prefix '/usr' 03:53:42 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:53:42 INFO - Installing distribute.............................................................................................................................................................................................done. 03:53:44 INFO - Installing pip.................done. 03:53:44 INFO - Return code: 0 03:53:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:53:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:53:44 INFO - Reading from file tmpfile_stdout 03:53:44 INFO - Output received: 03:53:44 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) 03:53:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:53:44 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')]} 03:53:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:53:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:53:44 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')]} 03:53:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:53:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:53:44 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 0x7f9eafb01f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc678a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd34ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd31f60>, '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 0xd32d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd331d0>, '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': '00204705a9daa57ed339a427000001b9-1475751204.987020-1913817406', '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 03:53:44 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 03:53:44 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 03:53:44 INFO - Using env: {'DISPLAY': ':0', 03:53:44 INFO - 'HOME': '/home/cltbld', 03:53:44 INFO - 'LANG': 'en_US.UTF-8', 03:53:44 INFO - 'LANGUAGE': 'en_US:en', 03:53:44 INFO - 'LOGNAME': 'cltbld', 03:53:44 INFO - 'MAIL': '/var/mail/cltbld', 03:53:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:53:44 INFO - 'MOZ_NO_REMOTE': '1', 03:53:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:53:44 INFO - 'NO_EM_RESTART': '1', 03:53:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:53:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:53:44 INFO - 'PWD': '/builds/slave/test', 03:53:44 INFO - 'SHELL': '/bin/bash', 03:53:44 INFO - 'SHLVL': '1', 03:53:44 INFO - 'TERM': 'linux', 03:53:44 INFO - 'TMOUT': '86400', 03:53:44 INFO - 'USER': 'cltbld', 03:53:44 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1475751204.987020-1913817406', 03:53:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:53:44 INFO - '_': '/tools/buildbot/bin/python'} 03:53:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:53:45 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 03:53:45 INFO - Cleaning up... 03:53:45 INFO - Return code: 0 03:53:45 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:53:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:53:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:53:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:53:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:53:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:53:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:53:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f9eafb01f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc678a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd34ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd31f60>, '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 0xd32d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd331d0>, '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': '00204705a9daa57ed339a427000001b9-1475751204.987020-1913817406', '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 03:53:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 03:53:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 03:53:45 INFO - Using env: {'DISPLAY': ':0', 03:53:45 INFO - 'HOME': '/home/cltbld', 03:53:45 INFO - 'LANG': 'en_US.UTF-8', 03:53:45 INFO - 'LANGUAGE': 'en_US:en', 03:53:45 INFO - 'LOGNAME': 'cltbld', 03:53:45 INFO - 'MAIL': '/var/mail/cltbld', 03:53:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:53:45 INFO - 'MOZ_NO_REMOTE': '1', 03:53:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:53:45 INFO - 'NO_EM_RESTART': '1', 03:53:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:53:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:53:45 INFO - 'PWD': '/builds/slave/test', 03:53:45 INFO - 'SHELL': '/bin/bash', 03:53:45 INFO - 'SHLVL': '1', 03:53:45 INFO - 'TERM': 'linux', 03:53:45 INFO - 'TMOUT': '86400', 03:53:45 INFO - 'USER': 'cltbld', 03:53:45 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1475751204.987020-1913817406', 03:53:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:53:45 INFO - '_': '/tools/buildbot/bin/python'} 03:53:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:53:45 INFO - Downloading/unpacking psutil>=3.1.1 03:53:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:53:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:53:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:53:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:53:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:53:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:53:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:53:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:53:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:53:47 INFO - Installing collected packages: psutil 03:53:47 INFO - Running setup.py install for psutil 03:53:47 INFO - building 'psutil._psutil_linux' extension 03:53:47 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 03:53:47 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 03:53:47 INFO - building 'psutil._psutil_posix' extension 03:53:47 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 03:53:47 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 03:53:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:53:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:53:47 INFO - Successfully installed psutil 03:53:47 INFO - Cleaning up... 03:53:47 INFO - Return code: 0 03:53:47 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:53:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:53:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:53:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:53:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:53:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:53:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:53:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9eafb01f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc678a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd34ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd31f60>, '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 0xd32d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd331d0>, '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': '00204705a9daa57ed339a427000001b9-1475751204.987020-1913817406', '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 03:53:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03:53:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 03:53:47 INFO - Using env: {'DISPLAY': ':0', 03:53:47 INFO - 'HOME': '/home/cltbld', 03:53:47 INFO - 'LANG': 'en_US.UTF-8', 03:53:47 INFO - 'LANGUAGE': 'en_US:en', 03:53:47 INFO - 'LOGNAME': 'cltbld', 03:53:47 INFO - 'MAIL': '/var/mail/cltbld', 03:53:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:53:47 INFO - 'MOZ_NO_REMOTE': '1', 03:53:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:53:47 INFO - 'NO_EM_RESTART': '1', 03:53:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:53:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:53:47 INFO - 'PWD': '/builds/slave/test', 03:53:47 INFO - 'SHELL': '/bin/bash', 03:53:47 INFO - 'SHLVL': '1', 03:53:47 INFO - 'TERM': 'linux', 03:53:47 INFO - 'TMOUT': '86400', 03:53:47 INFO - 'USER': 'cltbld', 03:53:47 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1475751204.987020-1913817406', 03:53:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:53:47 INFO - '_': '/tools/buildbot/bin/python'} 03:53:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:53:48 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:53:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:53:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:53:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:53:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:53:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:53:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:53:50 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:53:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:53:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:53:50 INFO - Installing collected packages: mozsystemmonitor 03:53:50 INFO - Running setup.py install for mozsystemmonitor 03:53:50 INFO - Successfully installed mozsystemmonitor 03:53:50 INFO - Cleaning up... 03:53:50 INFO - Return code: 0 03:53:50 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:53:50 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')]} 03:53:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:53:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:53:50 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')]} 03:53:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:53:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:53:50 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 0x7f9eafb01f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc678a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd34ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd31f60>, '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 0xd32d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd331d0>, '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': '00204705a9daa57ed339a427000001b9-1475751204.987020-1913817406', '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 03:53:50 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 03:53:50 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 03:53:50 INFO - Using env: {'DISPLAY': ':0', 03:53:50 INFO - 'HOME': '/home/cltbld', 03:53:50 INFO - 'LANG': 'en_US.UTF-8', 03:53:50 INFO - 'LANGUAGE': 'en_US:en', 03:53:50 INFO - 'LOGNAME': 'cltbld', 03:53:50 INFO - 'MAIL': '/var/mail/cltbld', 03:53:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:53:50 INFO - 'MOZ_NO_REMOTE': '1', 03:53:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:53:50 INFO - 'NO_EM_RESTART': '1', 03:53:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:53:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:53:50 INFO - 'PWD': '/builds/slave/test', 03:53:50 INFO - 'SHELL': '/bin/bash', 03:53:50 INFO - 'SHLVL': '1', 03:53:50 INFO - 'TERM': 'linux', 03:53:50 INFO - 'TMOUT': '86400', 03:53:50 INFO - 'USER': 'cltbld', 03:53:50 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1475751204.987020-1913817406', 03:53:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:53:50 INFO - '_': '/tools/buildbot/bin/python'} 03:53:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:53:50 INFO - Downloading/unpacking jsonschema==2.5.1 03:53:50 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 03:53:50 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 03:53:50 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 03:53:50 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 03:53:50 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 03:53:50 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 03:53:52 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:53:52 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:53:52 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 03:53:52 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 03:53:52 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 03:53:52 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 03:53:52 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 03:53:52 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 03:53:52 INFO - Downloading functools32-3.2.3-2.tar.gz 03:53:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:53:52 INFO - warning: no files found matching '*.txt' 03:53:52 INFO - no previously-included directories found matching 'build' 03:53:52 INFO - no previously-included directories found matching 'dist' 03:53:52 INFO - no previously-included directories found matching '.git*' 03:53:52 INFO - Installing collected packages: jsonschema, functools32 03:53:52 INFO - Running setup.py install for functools32 03:53:52 INFO - warning: no files found matching '*.txt' 03:53:52 INFO - no previously-included directories found matching 'build' 03:53:52 INFO - no previously-included directories found matching 'dist' 03:53:52 INFO - no previously-included directories found matching '.git*' 03:53:52 INFO - Successfully installed jsonschema functools32 03:53:52 INFO - Cleaning up... 03:53:52 INFO - Return code: 0 03:53:52 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:53: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')]} 03:53:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:53:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:53: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')]} 03:53:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:53:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:53:52 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 0x7f9eafb01f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc678a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd34ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd31f60>, '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 0xd32d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd331d0>, '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': '00204705a9daa57ed339a427000001b9-1475751204.987020-1913817406', '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 03:53:52 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 03:53:52 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 03:53:52 INFO - Using env: {'DISPLAY': ':0', 03:53:52 INFO - 'HOME': '/home/cltbld', 03:53:52 INFO - 'LANG': 'en_US.UTF-8', 03:53:52 INFO - 'LANGUAGE': 'en_US:en', 03:53:52 INFO - 'LOGNAME': 'cltbld', 03:53:52 INFO - 'MAIL': '/var/mail/cltbld', 03:53:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:53:52 INFO - 'MOZ_NO_REMOTE': '1', 03:53:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:53:52 INFO - 'NO_EM_RESTART': '1', 03:53:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:53:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:53:52 INFO - 'PWD': '/builds/slave/test', 03:53:52 INFO - 'SHELL': '/bin/bash', 03:53:52 INFO - 'SHLVL': '1', 03:53:52 INFO - 'TERM': 'linux', 03:53:52 INFO - 'TMOUT': '86400', 03:53:52 INFO - 'USER': 'cltbld', 03:53:52 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1475751204.987020-1913817406', 03:53:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:53:52 INFO - '_': '/tools/buildbot/bin/python'} 03:53:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:53:53 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:53:53 INFO - Cleaning up... 03:53:53 INFO - Return code: 0 03:53:53 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:53:53 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')]} 03:53:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:53:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:53:53 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')]} 03:53:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:53:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:53:53 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 0x7f9eafb01f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc678a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd34ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd31f60>, '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 0xd32d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd331d0>, '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': '00204705a9daa57ed339a427000001b9-1475751204.987020-1913817406', '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 03:53:53 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 03:53:53 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 03:53:53 INFO - Using env: {'DISPLAY': ':0', 03:53:53 INFO - 'HOME': '/home/cltbld', 03:53:53 INFO - 'LANG': 'en_US.UTF-8', 03:53:53 INFO - 'LANGUAGE': 'en_US:en', 03:53:53 INFO - 'LOGNAME': 'cltbld', 03:53:53 INFO - 'MAIL': '/var/mail/cltbld', 03:53:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:53:53 INFO - 'MOZ_NO_REMOTE': '1', 03:53:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:53:53 INFO - 'NO_EM_RESTART': '1', 03:53:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:53:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:53:53 INFO - 'PWD': '/builds/slave/test', 03:53:53 INFO - 'SHELL': '/bin/bash', 03:53:53 INFO - 'SHLVL': '1', 03:53:53 INFO - 'TERM': 'linux', 03:53:53 INFO - 'TMOUT': '86400', 03:53:53 INFO - 'USER': 'cltbld', 03:53:53 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1475751204.987020-1913817406', 03:53:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:53:53 INFO - '_': '/tools/buildbot/bin/python'} 03:53:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:53:53 INFO - Downloading/unpacking blobuploader==1.2.4 03:53:53 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 03:53:53 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 03:53:53 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 03:53:53 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 03:53:53 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 03:53:53 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 03:53:55 INFO - Downloading blobuploader-1.2.4.tar.gz 03:53:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:53:55 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:53:55 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 03:53:55 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 03:53:55 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 03:53:55 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 03:53:55 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 03:53:55 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 03:53:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:53:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:53:55 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 03:53:55 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 03:53:55 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 03:53:55 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 03:53:55 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 03:53:55 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 03:53:55 INFO - Downloading docopt-0.6.1.tar.gz 03:53:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:53:55 INFO - Installing collected packages: blobuploader, requests, docopt 03:53:55 INFO - Running setup.py install for blobuploader 03:53:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:53:56 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:53:56 INFO - Running setup.py install for requests 03:53:56 INFO - Running setup.py install for docopt 03:53:56 INFO - Successfully installed blobuploader requests docopt 03:53:56 INFO - Cleaning up... 03:53:56 INFO - Return code: 0 03:53:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:53:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:53:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:53:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:53:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:53:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:53:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:53:56 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 0x7f9eafb01f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc678a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd34ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd31f60>, '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 0xd32d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd331d0>, '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': '00204705a9daa57ed339a427000001b9-1475751204.987020-1913817406', '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 03:53:56 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 03:53:56 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 03:53:56 INFO - Using env: {'DISPLAY': ':0', 03:53:56 INFO - 'HOME': '/home/cltbld', 03:53:56 INFO - 'LANG': 'en_US.UTF-8', 03:53:56 INFO - 'LANGUAGE': 'en_US:en', 03:53:56 INFO - 'LOGNAME': 'cltbld', 03:53:56 INFO - 'MAIL': '/var/mail/cltbld', 03:53:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:53:56 INFO - 'MOZ_NO_REMOTE': '1', 03:53:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:53:56 INFO - 'NO_EM_RESTART': '1', 03:53:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:53:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:53:56 INFO - 'PWD': '/builds/slave/test', 03:53:56 INFO - 'SHELL': '/bin/bash', 03:53:56 INFO - 'SHLVL': '1', 03:53:56 INFO - 'TERM': 'linux', 03:53:56 INFO - 'TMOUT': '86400', 03:53:56 INFO - 'USER': 'cltbld', 03:53:56 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1475751204.987020-1913817406', 03:53:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:53:56 INFO - '_': '/tools/buildbot/bin/python'} 03:53:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:53:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:53:56 INFO - Running setup.py (path:/tmp/pip-lA1qjt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:53:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:53:56 INFO - Running setup.py (path:/tmp/pip-JGQ5hk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:53:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:53:56 INFO - Running setup.py (path:/tmp/pip-gc5grK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:53:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:53:57 INFO - Running setup.py (path:/tmp/pip-lkF5JI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:53:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:53:57 INFO - Running setup.py (path:/tmp/pip-4sMF1K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:53:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:53:57 INFO - Running setup.py (path:/tmp/pip-Pl2ndl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:53:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:53:57 INFO - Running setup.py (path:/tmp/pip-sbUNzc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:53:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:53:57 INFO - Running setup.py (path:/tmp/pip-o1RJ0X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:53:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:53:57 INFO - Running setup.py (path:/tmp/pip-H7sWJO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:53:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:53:57 INFO - Running setup.py (path:/tmp/pip-X47o__-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:53:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:53:57 INFO - Running setup.py (path:/tmp/pip-B_ZEbL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:53:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:53:57 INFO - Running setup.py (path:/tmp/pip-i_U6B_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:53:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:53:57 INFO - Running setup.py (path:/tmp/pip-gb44TE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:53:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:53:57 INFO - Running setup.py (path:/tmp/pip-Du5sd5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:53:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:53:57 INFO - Running setup.py (path:/tmp/pip-4Jwv56-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:53:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:53:57 INFO - Running setup.py (path:/tmp/pip-v09rUw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:53:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:53:57 INFO - Running setup.py (path:/tmp/pip-Yn1DGX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:53:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:53:58 INFO - Running setup.py install for manifestparser 03:53:58 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:53:58 INFO - Running setup.py install for mozcrash 03:53:58 INFO - Running setup.py install for mozdebug 03:53:58 INFO - Running setup.py install for mozdevice 03:53:58 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:53:58 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:53:58 INFO - Running setup.py install for mozfile 03:53:58 INFO - Running setup.py install for mozhttpd 03:53:58 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:53:58 INFO - Running setup.py install for mozinfo 03:53:58 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:53:58 INFO - Running setup.py install for mozInstall 03:53:58 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:53:58 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:53:58 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:53:58 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:53:58 INFO - Running setup.py install for mozleak 03:53:58 INFO - Running setup.py install for mozlog 03:53:59 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:53:59 INFO - Running setup.py install for moznetwork 03:53:59 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:53:59 INFO - Running setup.py install for mozprocess 03:53:59 INFO - Running setup.py install for mozprofile 03:53:59 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:53:59 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:53:59 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:53:59 INFO - Running setup.py install for mozrunner 03:53:59 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:53:59 INFO - Running setup.py install for mozscreenshot 03:53:59 INFO - Running setup.py install for moztest 03:53:59 INFO - Running setup.py install for mozversion 03:53:59 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:53:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:53:59 INFO - Cleaning up... 03:53:59 INFO - Return code: 0 03:53:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:53:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:53:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:53:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:53:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:53:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:53:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:53:59 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 0x7f9eafb01f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc678a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd34ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd31f60>, '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 0xd32d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd331d0>, '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': '00204705a9daa57ed339a427000001b9-1475751204.987020-1913817406', '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 03:53:59 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 03:53:59 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 03:53:59 INFO - Using env: {'DISPLAY': ':0', 03:53:59 INFO - 'HOME': '/home/cltbld', 03:53:59 INFO - 'LANG': 'en_US.UTF-8', 03:53:59 INFO - 'LANGUAGE': 'en_US:en', 03:53:59 INFO - 'LOGNAME': 'cltbld', 03:53:59 INFO - 'MAIL': '/var/mail/cltbld', 03:53:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:53:59 INFO - 'MOZ_NO_REMOTE': '1', 03:53:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:53:59 INFO - 'NO_EM_RESTART': '1', 03:53:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:53:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:53:59 INFO - 'PWD': '/builds/slave/test', 03:53:59 INFO - 'SHELL': '/bin/bash', 03:53:59 INFO - 'SHLVL': '1', 03:53:59 INFO - 'TERM': 'linux', 03:53:59 INFO - 'TMOUT': '86400', 03:53:59 INFO - 'USER': 'cltbld', 03:53:59 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1475751204.987020-1913817406', 03:53:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:53:59 INFO - '_': '/tools/buildbot/bin/python'} 03:54:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:54:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:54:00 INFO - Running setup.py (path:/tmp/pip-rPvAKQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:54:00 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)) 03:54:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:54:00 INFO - Running setup.py (path:/tmp/pip-6dcH3N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:54:00 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)) 03:54:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:54:00 INFO - Running setup.py (path:/tmp/pip-ZUtRFt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:54:00 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)) 03:54:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:54:00 INFO - Running setup.py (path:/tmp/pip-z9hecI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:54:00 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)) 03:54:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:54:00 INFO - Running setup.py (path:/tmp/pip-lvpB7H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:54:00 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)) 03:54:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:54:00 INFO - Running setup.py (path:/tmp/pip-5yx8sj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:54:00 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)) 03:54:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:54:00 INFO - Running setup.py (path:/tmp/pip-KoNd8a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:54:00 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)) 03:54:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:54:00 INFO - Running setup.py (path:/tmp/pip-456j4i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:54:00 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)) 03:54:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:54:00 INFO - Running setup.py (path:/tmp/pip-98h1Bk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:54:00 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)) 03:54:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:54:00 INFO - Running setup.py (path:/tmp/pip-rKDeEu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:54:00 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)) 03:54:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:54:00 INFO - Running setup.py (path:/tmp/pip-ZIFm7V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:54:00 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)) 03:54:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:54:00 INFO - Running setup.py (path:/tmp/pip-p732AB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:54:00 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)) 03:54:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:54:00 INFO - Running setup.py (path:/tmp/pip-7YRxou-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:54:01 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)) 03:54:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:54:01 INFO - Running setup.py (path:/tmp/pip-Hr9pvO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:54:01 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)) 03:54:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:54:01 INFO - Running setup.py (path:/tmp/pip-s_zkmZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:54:01 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)) 03:54:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:54:01 INFO - Running setup.py (path:/tmp/pip-BzHJ5h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:54:01 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)) 03:54:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:54:01 INFO - Running setup.py (path:/tmp/pip-iql19j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:54:01 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)) 03:54:01 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)) 03:54:01 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)) 03:54:01 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)) 03:54:01 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)) 03:54:01 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)) 03:54:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:54:01 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 03:54:01 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 03:54:01 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 03:54:01 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 03:54:01 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 03:54:01 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 03:54:03 INFO - Downloading blessings-1.6.tar.gz 03:54:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:54:03 INFO - Installing collected packages: blessings 03:54:03 INFO - Running setup.py install for blessings 03:54:03 INFO - Successfully installed blessings 03:54:03 INFO - Cleaning up... 03:54:03 INFO - Return code: 0 03:54:03 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:54:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:54:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:54:03 INFO - Reading from file tmpfile_stdout 03:54:03 INFO - Current package versions: 03:54:03 INFO - argparse == 1.2.1 03:54:03 INFO - blessings == 1.6 03:54:03 INFO - blobuploader == 1.2.4 03:54:03 INFO - docopt == 0.6.1 03:54:03 INFO - functools32 == 3.2.3-2 03:54:03 INFO - jsonschema == 2.5.1 03:54:03 INFO - manifestparser == 1.1 03:54:03 INFO - mozInstall == 1.12 03:54:03 INFO - mozcrash == 0.17 03:54:03 INFO - mozdebug == 0.1 03:54:03 INFO - mozdevice == 0.48 03:54:03 INFO - mozfile == 1.2 03:54:03 INFO - mozhttpd == 0.7 03:54:03 INFO - mozinfo == 0.9 03:54:03 INFO - mozleak == 0.1 03:54:03 INFO - mozlog == 3.4 03:54:03 INFO - moznetwork == 0.27 03:54:03 INFO - mozprocess == 0.23 03:54:03 INFO - mozprofile == 0.28 03:54:03 INFO - mozrunner == 6.12 03:54:03 INFO - mozscreenshot == 0.1 03:54:03 INFO - mozsystemmonitor == 0.3 03:54:03 INFO - moztest == 0.7 03:54:03 INFO - mozversion == 1.4 03:54:03 INFO - psutil == 3.1.1 03:54:03 INFO - requests == 1.2.3 03:54:03 INFO - wsgiref == 0.1.2 03:54:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:54:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:54:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:54:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:54:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:54:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:54:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:54:03 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 0x7f9eafb01f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc678a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd34ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd31f60>, '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 0xd32d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd331d0>, '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': '00204705a9daa57ed339a427000001b9-1475751204.987020-1913817406', '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 03:54:03 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 03:54:03 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 03:54:03 INFO - Using env: {'DISPLAY': ':0', 03:54:03 INFO - 'HOME': '/home/cltbld', 03:54:03 INFO - 'LANG': 'en_US.UTF-8', 03:54:03 INFO - 'LANGUAGE': 'en_US:en', 03:54:03 INFO - 'LOGNAME': 'cltbld', 03:54:03 INFO - 'MAIL': '/var/mail/cltbld', 03:54:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:54:03 INFO - 'MOZ_NO_REMOTE': '1', 03:54:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:54:03 INFO - 'NO_EM_RESTART': '1', 03:54:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:54:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:54:03 INFO - 'PWD': '/builds/slave/test', 03:54:03 INFO - 'SHELL': '/bin/bash', 03:54:03 INFO - 'SHLVL': '1', 03:54:03 INFO - 'TERM': 'linux', 03:54:03 INFO - 'TMOUT': '86400', 03:54:03 INFO - 'USER': 'cltbld', 03:54:03 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1475751204.987020-1913817406', 03:54:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:54:03 INFO - '_': '/tools/buildbot/bin/python'} 03:54:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:54:03 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)) 03:54:03 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)) 03:54:03 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)) 03:54:03 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)) 03:54:03 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)) 03:54:03 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)) 03:54:03 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)) 03:54:03 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)) 03:54:03 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)) 03:54:03 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)) 03:54:03 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)) 03:54:03 INFO - Cleaning up... 03:54:03 INFO - Return code: 0 03:54:03 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:54:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:54:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:54:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:54:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:54:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:54:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:54:03 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 0x7f9eafb01f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc678a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd34ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd31f60>, '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 0xd32d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd331d0>, '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': '00204705a9daa57ed339a427000001b9-1475751204.987020-1913817406', '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 03:54:03 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 03:54:03 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 03:54:03 INFO - Using env: {'DISPLAY': ':0', 03:54:03 INFO - 'HOME': '/home/cltbld', 03:54:03 INFO - 'LANG': 'en_US.UTF-8', 03:54:03 INFO - 'LANGUAGE': 'en_US:en', 03:54:03 INFO - 'LOGNAME': 'cltbld', 03:54:03 INFO - 'MAIL': '/var/mail/cltbld', 03:54:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:54:03 INFO - 'MOZ_NO_REMOTE': '1', 03:54:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:54:03 INFO - 'NO_EM_RESTART': '1', 03:54:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:54:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:54:03 INFO - 'PWD': '/builds/slave/test', 03:54:03 INFO - 'SHELL': '/bin/bash', 03:54:03 INFO - 'SHLVL': '1', 03:54:03 INFO - 'TERM': 'linux', 03:54:03 INFO - 'TMOUT': '86400', 03:54:03 INFO - 'USER': 'cltbld', 03:54:03 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1475751204.987020-1913817406', 03:54:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:54:03 INFO - '_': '/tools/buildbot/bin/python'} 03:54:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:54:04 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:54:04 INFO - Cleaning up... 03:54:04 INFO - Return code: 0 03:54:04 INFO - Running post-action listener: _resource_record_post_action 03:54:04 INFO - Running post-action listener: _start_resource_monitoring 03:54:04 INFO - Starting resource monitoring. 03:54:04 INFO - [mozharness: 2016-10-06 10:54:04.171415Z] Finished create-virtualenv step (success) 03:54:04 INFO - [mozharness: 2016-10-06 10:54:04.171922Z] Running install step. 03:54:04 INFO - Running pre-action listener: _resource_record_pre_action 03:54:04 INFO - Running main action method: install 03:54:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:54:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:54:04 INFO - Reading from file tmpfile_stdout 03:54:04 INFO - Detecting whether we're running mozinstall >=1.0... 03:54:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:54:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:54:04 INFO - Reading from file tmpfile_stdout 03:54:04 INFO - Output received: 03:54:04 INFO - Usage: mozinstall [options] installer 03:54:04 INFO - Options: 03:54:04 INFO - -h, --help show this help message and exit 03:54:04 INFO - -d DEST, --destination=DEST 03:54:04 INFO - Directory to install application into. [default: 03:54:04 INFO - "/builds/slave/test"] 03:54:04 INFO - --app=APP Application being installed. [default: firefox] 03:54:04 INFO - mkdir: /builds/slave/test/build/application 03:54:04 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'] 03:54:04 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 03:54:20 INFO - Reading from file tmpfile_stdout 03:54:20 INFO - Output received: 03:54:20 INFO - /builds/slave/test/build/application/firefox/firefox 03:54:20 INFO - Running post-action listener: _resource_record_post_action 03:54:20 INFO - [mozharness: 2016-10-06 10:54:20.595470Z] Finished install step (success) 03:54:20 INFO - [mozharness: 2016-10-06 10:54:20.595717Z] Running run-tests step. 03:54:20 INFO - Running pre-action listener: _resource_record_pre_action 03:54:20 INFO - Running main action method: run_tests 03:54:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:54:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:54:20 INFO - Python 2.7.3 03:54:20 INFO - Return code: 0 03:54:20 INFO - grabbing minidump binary from tooltool 03:54:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:54:20 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 0xd31f60>, '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 0xd32d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd331d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:54:20 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 03:54:20 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 03:54:20 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 03:54:20 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:54:20 INFO - Return code: 0 03:54:20 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:54:20 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:54:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:54:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:54:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:54:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MYIqc5asTL6ees4tNlhFvA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-016', '--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 03:54:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/MYIqc5asTL6ees4tNlhFvA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-016 --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 03:54:20 INFO - Using env: {'DISPLAY': ':0', 03:54:20 INFO - 'HOME': '/home/cltbld', 03:54:20 INFO - 'LANG': 'en_US.UTF-8', 03:54:20 INFO - 'LANGUAGE': 'en_US:en', 03:54:20 INFO - 'LOGNAME': 'cltbld', 03:54:20 INFO - 'MAIL': '/var/mail/cltbld', 03:54:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:54:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:54:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:54:20 INFO - 'MOZ_NO_REMOTE': '1', 03:54:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:54:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:54:20 INFO - 'NO_EM_RESTART': '1', 03:54:20 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:54:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:54:20 INFO - 'PWD': '/builds/slave/test', 03:54:20 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:54:20 INFO - 'SHELL': '/bin/bash', 03:54:20 INFO - 'SHLVL': '1', 03:54:20 INFO - 'TERM': 'linux', 03:54:20 INFO - 'TMOUT': '86400', 03:54:20 INFO - 'USER': 'cltbld', 03:54:20 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1475751204.987020-1913817406', 03:54:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:54:20 INFO - '_': '/tools/buildbot/bin/python'} 03:54:20 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MYIqc5asTL6ees4tNlhFvA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-016', '--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 03:54:20 INFO - mozversion application_buildid: 20161006030102 03:54:20 INFO - mozversion application_changeset: 777fb63db8de8d78b64b8141d1a998397275dd03 03:54:20 INFO - mozversion application_display_name: Nightly 03:54:20 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:54:20 INFO - mozversion application_name: Firefox 03:54:20 INFO - mozversion application_remotingname: firefox 03:54:20 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:54:20 INFO - mozversion application_vendor: Mozilla 03:54:20 INFO - mozversion application_version: 52.0a1 03:54:20 INFO - mozversion platform_buildid: 20161006030102 03:54:20 INFO - mozversion platform_changeset: 777fb63db8de8d78b64b8141d1a998397275dd03 03:54:20 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:54:20 INFO - mozversion platform_version: 52.0a1 03:54:20 INFO - using testdate: 1475751260 03:54:20 INFO - actual date: 1475751260 03:54:20 INFO - starting webserver on 'localhost:60976' 03:54:20 INFO - SUITE-START | Running 2 tests 03:54:20 INFO - TEST-START | dromaeo_css 03:54:20 INFO - operating with platform_type : linux_ 03:54:20 INFO - Initialising browser for dromaeo_css test... 03:54:20 INFO - TEST-INFO | started process 370 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpi3jQmx/profile http://localhost:60976/getInfo.html) 03:54:25 INFO - PROCESS | 370 | __metrics Screen width/height:1600/1200 03:54:25 INFO - PROCESS | 370 | colorDepth:24 03:54:25 INFO - PROCESS | 370 | Browser inner width/height: 1024/697 03:54:25 INFO - PROCESS | 370 | __metrics 03:54:25 INFO - PROCESS | 370 | 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" 03:54:25 INFO - PROCESS | 370 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:54:26 INFO - PROCESS | 370 | console.error: PushService: 03:54:26 INFO - PROCESS | 370 | stateChangeProcessEnqueue: Error transitioning state 03:54:26 INFO - PROCESS | 370 | UnknownError 03:54:27 INFO - TEST-INFO | 370: exit 0 03:54:27 INFO - Browser initialized. 03:54:27 INFO - Running cycle 1/1 for dromaeo_css test... 03:54:27 INFO - TEST-INFO | started process 455 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpi3jQmx/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:54:39 INFO - PROCESS | 455 | RSS: Main: 175345664 03:54:39 INFO - PROCESS | 455 | 03:55:30 INFO - PROCESS | 455 | 1475751330303 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] 03:57:43 INFO - PROCESS | 455 | Cycle 1(1): loaded http://localhost:60976/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60976/tests/dromaeo/cssquery-ext.html) 03:57:45 INFO - PROCESS | 455 | RSS: Main: 341450752 03:57:45 INFO - PROCESS | 455 | 04:00:48 INFO - PROCESS | 455 | Cycle 1(1): loaded http://localhost:60976/tests/dromaeo/cssquery-ext.html (next: http://localhost:60976/tests/dromaeo/cssquery-jquery.html) 04:00:48 INFO - PROCESS | 455 | RSS: Main: 275689472 04:00:48 INFO - PROCESS | 455 | 04:03:50 INFO - PROCESS | 455 | Cycle 1(1): loaded http://localhost:60976/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60976/tests/dromaeo/cssquery-mootools.html) 04:03:51 INFO - PROCESS | 455 | RSS: Main: 221081600 04:03:51 INFO - PROCESS | 455 | 04:06:53 INFO - PROCESS | 455 | Cycle 1(1): loaded http://localhost:60976/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60976/tests/dromaeo/cssquery-prototype.html) 04:06:54 INFO - PROCESS | 455 | RSS: Main: 231616512 04:06:54 INFO - PROCESS | 455 | 04:09:57 INFO - PROCESS | 455 | Cycle 1(1): loaded http://localhost:60976/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60976/tests/dromaeo/cssquery-yui.html) 04:09:58 INFO - PROCESS | 455 | RSS: Main: 221671424 04:09:58 INFO - PROCESS | 455 | 04:13:00 INFO - PROCESS | 455 | Cycle 1(1): loaded http://localhost:60976/tests/dromaeo/cssquery-yui.html (next: http://localhost:60976/tests/dromaeo/cssquery-dojo.html) 04:13:01 INFO - PROCESS | 455 | RSS: Main: 281530368 04:13:01 INFO - PROCESS | 455 | 04:13:01 INFO - PROCESS | 455 | __start_tp_report 04:13:01 INFO - PROCESS | 455 | _x_x_mozilla_page_load 04:13:01 INFO - PROCESS | 455 | _x_x_mozilla_page_load_details 04:13:01 INFO - PROCESS | 455 | |i|pagename|runs| 04:13:01 INFO - PROCESS | 455 | |0;dojo.html;2558.833675811072;2615.2546524240597;2633.6181253718205;2639.2610069180623;2656.1633085578055;4599.7010194337345;4676.485586585472;4692.741899195543;4723.409573803275;4723.90552188956;4715.740634265114;4721.952780472203;4723.622110231182;4725;4727.8818029549275;4290.935635965455;4302.225599392108;4316.07204451043;4344.674149438789;4371.3661519079715;4327.0480494291205;4354.08564201518;4369.431973843396;4395.274779661352;4441.777911104448;4416.6245869101;4418.447694038246;4456.55434456555;4470.664700147486;4472.575105364985;242.75719065448044;4421.756803375813;4423.469183697961;4423.712458690191;4446.310821822591;4265.637420819203;4271.658267338606;4282.721623094489;4311.504177019651;4317.956820431787;4647.140279048387;4709.317149013408;4733.733684053813;4734.786934587952;4787.16224660683;5095.898082038376;5100.336956195708;5100.719460429675;5101.923471147936;5169.663971841818;4860.05228980349;4956.727379994135;4967;5037.874053148664;5061.620378471593;4672.462666793363;4679.859604211879;4688;4707.5057119002695;4769.093872164243;5213.661112027782;5217.843464696065;5220.112580861262;5223.9477605223465;5274.024305503494;4786.880327991758;4840.854774356775;4911.68074075184;4994.126027945168;5064.215046667772;5057.671251368649;5083.38999320084;5084.059449001947;5086.338775959101;5152.252923326097;4999.725015124131;5053.69677819332;5058.570021548209;5116.258142569307;5116.872078198;4830.589399900978;4886.560209581155;4890.926636100461;5029.321041659402;5032.7735251913755;4277.465316835395;4284.871453856389;4325.134973005412;4325.178216138924;4382.101669157815;3749.4750734897134;3765.585785563586;3768.09565704229;3807.562130354989;3812.4853144825647;4262.339337402707;4351.4995775485595;4359.847405340798;4359.912801743947;4414.073044660593;4983.526564976321;5017.899642007213;5027.421846487628;5029.119904016782;5111.080005598954;4352.434183556117;4354.6951713380395;4365.541618130051;4403.031333106712;4412.227860124465;4571.405717256735;4574.794134263966;4575.405197324393;4585.518520555293;4636.559526844944;4586.334981427608;4646.6747327686735;4697.976510117427;4733.763311834464;4781.450133234723;5086.64393492452;5091.592672586258;5100.515451032146;5139.2291156325355;5159.638825282194;4760.500147484603;4766.904661906812;4767.73777442244;4773.9045219096115;4823;4782.115308667769;4858.854234372974;4926.285688575065;4985.476524964826;5018.04657115147;5067.594592432522;5083.262926875508;5091.109055915274;5139.665921715076;5148.948510514847;4945.431275403231;4948.579370753382;4955.207166853286;4956.058348913695;4984.252362145708;4786.712797232177;4838.467768545527;4938.48145944685;4939.160342741814;5006.474320196473;4773.260144677581;4800.495947925418;4802.831900883452;4811.398575178103;4837.975810120927;4924.212126059813;4936.679115857458;4939.876503087452;4943.134951383421;4998.975005124951;4691.249400096105;4749.952500474951;4750.477447480705;4809.278608208797;4823.686460380064 04:13:01 INFO - PROCESS | 455 | |1;ext.html;579.672485045949;584.6346033728919;584.6813486649778;584.9853753656156;588.3645662684302;27110.186694399174;36624.26751464969;37551.80809631181;37771;41647.167056658924;39257.60742392575;39637.8018109909;39655.801720991425;39683;39716.40425393614;7229.1325040995025;7380.114386273654;7389.039424874759;7389.926100739004;7393.297636724503;7588.810279742996;7663.808404789897;7670.156282808886;7670.194629563899;7677.270659287359;7676.309132178103;7713.382929365637;7721.266479684421;7732.381409487228;7737.497062690935;7663.770086897402;7675.385969122457;7702.114256860421;7705.383569314497;7706.807329816744;7596.3163315301335;7669.463137580372;7685.538867667958;7688.1927397623;7693.269139431745;35803.4629480558;36048.27903441943;36065.45901811475;36096.81951590251;36100.819495902615;2574.3435423966766;2755.9035433759723;2765.847878366689;2801.845898475583;2876.525373313422;26828;26914.730852691417;27514.312142196406;27705.168844934684;28314;3321.3025264694443;3357.4257425742576;3362.36115138123;3376.8818091366684;3380.154961259685;174101;174223.12888435603;174669.1266543672;174939.99999999872;174948;49375;49399.25901111486;49743.25385119226;49745;49861.25208121881;31935.68064319327;32736.672633273363;32790.34419311648;52227.47772522302;52394.738026310384;12876;12992.610221693365;13103.803442948363;13110.147840390344;13146.07977441589;9565.282603804742;9669.371490853073;9677.225821934227;9712.805743885083;9734.075262850018;17123.65752684964;17134.40029598958;17193.914030430016;17207.483775486755;17325.393611223797;6562.5406221564035;6579.80260592183;6606;6666.966665166643;6787.898181527281;776.926192011758;850.8043150075517;921.6175287255713;950.7385468996082;990.1583055516733;26200;27054;27567.724322756516;27830.3042423941;27898.721012790018;923.4182465046978;923.4459324405437;957.1959553974694;973.6300205921705;979.911807937289;13877.514286999907;14602.634934126732;14799.482018129314;14809.851901480848;15033.473828415952;358588;365263;366381;366450;367860;48524.514754851996;49116.263256051185;49138.754306228955;49217;49332.04007759546;1125.8930401611833;1164.0803765025535;1168.4099529737427;1174.770919670656;1180.5395895600723;25516.362090947874;26146.86926565431;26357.431119525227;26801.463970720088;26944.191674249803;40926.181476370904;41088.178236434505;41105.1778964425;41206.793966029974;41229.793851030554;286646;287984;289317;290144;291306;24753.381165471008;24908.37729056788;25198.496030078928;25248.242552723448;25373;40973;40983.59016409798;41486.377704333856;41976.790116049226;42208.788956055025;34759.82620086883;34788.652113479555;34973.65026349704;35117.29765404729;35413;34495.655043449246;34809.65190348064;34924.30151397009;35105.64894351126;35268.29463410769;34451;34877.82561087178;35133.472997904544;35178.29643407066;35722.285554288246;26441.735582643927;28810.7118928808;28953.420931581673;29111.166625031226;29295.267618309714;24232.151874684303;24564.263072107864;24897.25308240756;24982.875085624455;25291 04:13:01 INFO - PROCESS | 455 | |2;jquery.html;345.79252448530866;362.5395747400801;367.9760815546991;368.9944650830237;392.41921955505853;12722.618321450349;15920;16535.17324133793;17694.1152942353;17939.461816145504;15819.446319378823;16088.83911160891;16212.51362459125;16307.83692163078;16389.91805040976;4813.614910807127;4958.975205123969;5066.645334826564;5165.328507294046;5228.686278823283;3367.882124125656;3543.255916257589;5306.52241298285;5341.599380046493;5343.786248550054;5669.121286200645;5955.731992060368;5976;6049.153118563405;6050.455459008688;5275.103232450492;5281.419043905167;5309.442508536626;6033.306169790464;6037.969810150943;5147.124988751922;5147.996140752554;5154.716490593016;5158;5159.613029022838;11577.247478913843;11685.88314116865;11766.117541184445;11781;11913.166078374517;1895.2419032387018;1906.075553356621;1966.9508262293414;2019.5556977464935;2140.0048977225665;8663.523506207157;8755.299576033902;8777.122287771235;9178.541072946326;9256.768580785467;1614.77393164957;1719.4927496388596;1721.500764778213;1738.3220543987854;1749.335252604015;63925;68181.65909170471;68369.65815170942;69837.3016269836;70280;9499.440268671076;9723.15935205604;9911;9969.451680157516;10026;13467.461301547828;13475.797863032063;13507.392167352493;13586.048976571545;13617;6559.934400656028;6682.766103186365;6788.389044985975;6905.274946130584;6952.582845029315;6359.459445947054;6364.268109167412;6558.213014438298;6564.376384243489;6595.208574970939;4117.197146556393;4208.642265407475;4213.69375493598;4299;4343.891402714894;1702.3445973300368;1759.2171483689635;1794.4975406886092;1795.838374546297;1810.9275628974694;824.1017291152673;842.5071333269983;844;853.4111463090447;898.3711402018613;16300.592485187964;16599.585010374838;17035.318587256617;17125.400610978555;17596.912015440095;815.176671561727;829.4774292195877;861.3539845116163;878.5252687691752;893.5301429149014;9243.630254789867;9342.766430839283;9535.38020028696;9833.803323933624;9959.601615935426;344842;361879;361954;363730;365414;72061.27938720546;73149.63425182841;74207.62896185592;74699;75785.9999999989;806.846699127164;833.2708879730236;863.3222920007889;863.6286396849415;864.1358641358642;14500.534387194843;14953.476628317956;15467.303971321542;15513.922430387776;15722.76415853786;38739.80630096832;38900.41649375205;39272.21455570815;39692.404613931394;39734.60265397309;53633.46366536285;54542.18186727282;54648.453515465924;55288.44711552833;56469;6853.4859885507785;7307.67115479794;7520.774376768706;7524.322810947041;7647.120581133018;10840.728981775519;11553.653390398302;11716.472758726048;11720.589779357682;11780.408310171748;9797.167240784613;10178.898211017795;10293.948530257301;10551.155907527225;10596.31123976939;10222.131118854682;10241.385516869012;10310.123639490726;10377.792444151226;10603;9861.359011664219;10176.135028522658;10178.949105254427;10444.843327350247;10808;6758.797236082925;6961.79114626562;7125.465590080868;7131.465140114408;7140.393066589398;8467.83064338722;10166.288359814742;10312;10335.689929302132;10651.57393704243 04:13:01 INFO - PROCESS | 455 | |3;mootools.html;1205.499717617189;1340.9664758381036;1361.380571839813;1421.943122275109;1646.81061677907;6611.636360000198;7219.0976127984;7473.215312392202;7505.362044226241;7650.4262180336555;7474.925250747491;7599.164091949895;7603.201663825302;7608.695652173907;7618;2013.7784843667184;2037.2258541754113;2039.4085715142664;2040.3062958594076;2045.8670186437907;2048.0476578391044;2090.4042347930845;2099.0659156675288;2117.7035215069905;2121.6711409731515;1918.213532451695;1926.3257859749046;1926.8747531410484;1927.469945764912;1959.2652755216793;2024.5647185855112;2041.7447819022623;2043.2031507712004;2047.938561843147;2049.108637742572;1972.6745087060617;1988.6420444320017;2022.1506967073865;2028.239410221167;2028.9086991085437;7051.083359163327;7250.927490725078;7501;7631.885521717179;7634.541927484369;4178.707490475668;4308.138372325548;4318.913621727579;4321.675874309408;4328.2209202343565;2650.8542030188332;2711.4170453352426;2786.70739572344;2793.5949287353424;2802.1593521943337;856.9117221129194;864.4381152251087;870.4907629037021;1779.9377021804305;1832.7159290310024;10190.745231369201;10298.794024119476;10302.587896484132;10338.896611033868;10338.896611033868;3781.111438811877;3839.4432807242792;3942.8422863085157;3949.1311911379453;3989.501312335958;8097.2712455879255;8107.797305067303;8109.43233973628;8115.959420202979;8131.430799843954;4192.350185721218;4202.222588821078;4209.5790420957655;4209.663226941837;4217.704760666786;3479.321532301177;3588.085038315213;3731.6454936781506;3848.3073046851837;3856.4793752843007;3171.413288541627;3211.4701074322943;3282.7537934654997;3303.4549299365335;3319.2365755876285;984.1634610580949;999.2163987282665;1003.8243307421172;1009.3287963504334;1029.341221618165;711.9715211391486;727.8107692000118;730.2879692300071;745.2584678245181;769.6498093367504;4726.385569875894;5046.9747651261505;5126.487351264844;5259.15853463444;5277.736113194402;779.4465929190338;794.9665434934562;801.939854510914;804.7505273365275;846.7967687754895;3213.2770126721766;3345.4480010798434;3357.1607098225445;3357.772713762052;3492.1444246159854;8582.656693732306;8962.596683149273;9033.548322583845;9297.116773906468;9316.95341523288;9246.815063698688;9262.073792620818;9263.76840578991;9264.25885929124;9281.628734850665;6602.3397660233595;7001.859962800715;7022.262662420474;7042.154941406961;7042.859142817218;5156.3690319110965;5227.085260079547;5254.527092561688;5377.166539186433;5460.208269800936;8689.30485561141;8703.86944195825;8721.91278087211;8794.340424468062;8812.515311657664;8417.494950303002;8670.78323041929;8860.113988601346;8917.509536975529;8979.955100224457;5701.4298570142655;6377.649229292433;6455.160829092376;6459.903101453576;6496.512761542997;6378.043293506012;6864;7058.576485410892;7117.928820711727;7287.380572651172;6368.363163683594;6427;6571.817072926728;6617.073609694743;6676.065350850788;6243.594166379171;6261.092141639528;6263.342349053284;6266.091416744455;6337.366263373626;5737.168110624019;5810.477057064715;5821.854453638523;5833.649981001154;5839.649621022752;4138.172365526846;4195.202911446815;4268.701190916606;4289.292266775947;4303.859477238597;4143.482064741907;4154.459920210354;4181.498220213472;4218.409422680888;4239.300515414922 04:13:01 INFO - PROCESS | 455 | |4;prototype.html;283.07716843091526;291.9386928744963;297.4304207442747;298.2469265105608;302.20972157807324;4609.262517997113;4782.808687652489;4809;4852.5147485251455;4855.223164293714;4572.2455794793905;4697.5772180503745;4725.078609671115;4725.3148293497425;4765.380500534934;3768.8492460301554;3776.1126135358236;3780.3951367781024;3781.1492414206723;3781.773093614392;3559;3581.856725730968;3661.231141460283;3783.375743002415;3829.0235989822554;3690.335739566877;3694.7967861767593;3698.352788262057;3699.907502312437;3704.703353826166;3690.8892733218045;3691.9261614767825;3692.667659910621;3698.9260214795554;3706.4625629283605;3255.9186020349443;3267.8235835099345;3273.770836041478;3292.226326813197;3312.685294896981;4613.423322084739;4625.1443482955765;4637.956459796553;4646.326282689025;4651.651126165551;4213.852515161954;4238.41059602649;4240.512341080785;4250.744955302692;4253.829846806124;4979.253112033188;4987.950120498785;4994.425641051253;5027.798888044474;5031.974840125813;3461.7403694723;3564.1446052947367;3567.6967457766123;3575.6781889629797;3580.803055831954;5196.168613021899;5213.791448342062;5222.582193424517;5226.921596176022;5283.841484755425;3632.8183590820354;3645.872394466234;3647.1429214134655;3647.9270414592092;3652.5251717276583;3688.354537955847;3724.4413337999517;3725.2177042820767;3725.515682961198;3732.869349572752;4086.0806318578675;4194.580541945781;4202.453681021448;4204.768737719455;4228.471441069866;4978.054169707744;4981.327520784647;4981.775820088033;5018.272350509155;5042.747862606855;1219.9508422756423;1249.244207254616;1252.824604555363;1284.319310765296;1289.1362786932777;847.8897743293455;865.6926790989108;881.2377293641083;895.3553441522093;906.4923642760075;4406.27296496081;4413.0361988915265;4418.911621767546;4468.17338792318;4470.24005918988;5148.6910785353;5150.639455238097;5161.716105614228;5164;5176.275321454999;4316.848910288125;4502.3921770560555;4510.2783554631105;4547.886302842456;4549.54504549549;2736.931576710558;2739.808213425081;2746.5168808843;2748.477789220042;2770.7695305279444;4791.616670666338;4902.117618828645;4914;4919.605472224154;4948.975255123702;5305.196233280626;5322.54758345545;5324.8136315228785;5328.307320048369;5345.01117293302;4887.486813884562;4887.706737595756;4889.046635906036;4894.4827103598;4935.605151587936;4958.983408401197;5164.579740571373;5189.273501709839;5204.531592156724;5220.1647736362;5091.439941606346;5112.693238405707;5114.74426278692;5118.795248190031;5121.795128194831;4887.315775791463;4892.241702536113;4895.877603059952;4930.852074437773;4936.160852654985;3494.161401263628;3653.83557739897;3660.1398671312754;3663.816809159478;3667.3582123127812;5149.819756308511;5157.045946499909;5157.277981082577;5179.533841954242;5190.247414124855;5006.724630145377;5017.297578339108;5041.42023667283;5066.493350664904;5075.365579302587;4901.730404827768;4993;5029.773660185374;5046.84859454217;5052.873678158076;4648.628109751279;4789.3055506952;4795.784189711541;4899.4365647950945;4917.680350777331;5028.296038554532;5030.76746197184;5051;5061.493850614909;5062.265971434195;4901.58336541398;4907.656464047483;4919.253664948892;4919.483454237254;4920.901581968269 04:13:01 INFO - PROCESS | 455 | |5;yui.html;571.4770984549137;596.5525855608294;601.2244204975582;607.8298076538568;659.6833519910443;11039.503222354993;11743.823842642345;11796.999999999989;11885.4057297135;11892.881071189286;11523.827142592867;11785.646430607074;11822.172447928648;11896.167268291223;11898.286102833836;735.5292612727845;748.6967778049899;755.493819141174;756.4855897989365;756.8902509136173;741.1735914455397;743.0563184755357;743.7768669399186;744.0401881572765;744.0773440933231;791.9722809701661;793.218679600593;794.8608993426127;795.3478147918709;796.0924546017544;778.996105019477;779.3687113438104;779.4543819326437;779.6530543907963;779.7777633374518;575.7581815637442;579.8898209340254;580.4659713063949;580.7589850212157;580.8286555466148;12462.12765106443;12531.561395351118;12587.433565489575;12599.93700031503;12606;13401.66495837612;13454.596362109152;13504.594862154152;13595.388207530685;13757.518486852912;10312.89687103127;10431.843522347172;10469.476526173738;10515.05364517197;10635.202359823044;3201.439748044106;3205.1987003249187;3253.0240927721825;3289.111939776271;3359.496075588657;65413.67293163504;65435;65522.12017738164;65624.99999999952;66529.33470665329;9991.100800927952;10237.43694096817;10253.58985640581;10359.274850760525;10610.257281990187;17798.46604601864;18151.63696726058;18267.817321826613;18288.359907403177;18656.440306790817;6186.969065154645;6326.114343991845;6342.714577843916;6415.294317625057;6484.319146489551;3553.964460355415;3585.462180672868;3620.2035552178477;3639.6906262967946;3669.43123815809;2696.9865150674123;2825.4349130174046;2833.107571115092;3107.875684972621;3251.8048917065053;541.228749032627;542.5930552085936;548.1777333999001;551.7213807027425;565.951894089007;510.99233511497357;517.8058228164439;526.7734874004215;530.6126527634848;536.7557761218715;7006.824829379204;7061.187963384174;7087;7499.437542184249;7990.280874721303;522.5897670328774;531.5189753273294;534.671177226011;540.3974568356255;543.1391244876835;3522.542069530996;3601.549806274216;3675.246574452231;3677.6690097890782;3734.402495600691;96476.51761741287;97945.5308170378;104235.95764042414;104764.47617762015;104895;48182.518174818506;65138.67430662911;78875.60562197152;84321;84814;42419;72213.63893180396;73021.6348918252;73097.63451182816;75117.24882751211;7892.6053697313755;8395.790105247417;8419.915800842158;8456.577171141294;8647.135286471303;29482.262943426587;37039;43458.56541434545;43512.34731478967;44537.554624454635;46588.53411465978;57379.42620573908;58763.70618146882;59117.704411477665;60266.39733602608;10916.454177291262;10981.780364392507;11046;11318.26431281964;11698.94150529242;12211.938940305241;12342;12369.257844529357;12656.810147847606;12731.108822382344;11880.168388213087;11951.282923024299;11994.940025299818;12185.51257949672;12788.488460461478;10862.402567858844;10878.564857405616;11128.332300062022;11331.467373137395;11521.930350646024;11371;11449.942750286194;11830.822537662114;12168.513259469522;12790.744185116431;8844.778880528038;9392.624295028123;9647.083527064917;9840;9955.352902061633;10081.949590252001;10130.696287195016;10290.3825770454;10358.378497290187;10407.635732749317 04:13:01 INFO - PROCESS | 455 | __end_tp_report 04:13:01 INFO - PROCESS | 455 | __start_cc_report 04:13:01 INFO - PROCESS | 455 | _x_x_mozilla_cycle_collect,1859 04:13:01 INFO - PROCESS | 455 | __end_cc_report 04:13:01 INFO - PROCESS | 455 | __startTimestamp1475752381167__endTimestamp 04:13:01 INFO - PROCESS | 455 | 04:13:01 INFO - PROCESS | 455 | ------- Summary: start ------- 04:13:01 INFO - PROCESS | 455 | Number of tests: 6 04:13:01 INFO - PROCESS | 455 | 04:13:01 INFO - PROCESS | 455 | [#0] dojo.html Cycles:165 Average:4643.95 Median:4767.74 stddev:595.59 (12.5%) stddev-sans-first:574.51 04:13:01 INFO - PROCESS | 455 | Values: 2558.8 2615.3 2633.6 2639.3 2656.2 4599.7 4676.5 4692.7 4723.4 4723.9 4715.7 4722.0 4723.6 4725.0 4727.9 4290.9 4302.2 4316.1 4344.7 4371.4 4327.0 4354.1 4369.4 4395.3 4441.8 4416.6 4418.4 4456.6 4470.7 4472.6 242.8 4421.8 4423.5 4423.7 4446.3 4265.6 4271.7 4282.7 4311.5 4318.0 4647.1 4709.3 4733.7 4734.8 4787.2 5095.9 5100.3 5100.7 5101.9 5169.7 4860.1 4956.7 4967.0 5037.9 5061.6 4672.5 4679.9 4688.0 4707.5 4769.1 5213.7 5217.8 5220.1 5223.9 5274.0 4786.9 4840.9 4911.7 4994.1 5064.2 5057.7 5083.4 5084.1 5086.3 5152.3 4999.7 5053.7 5058.6 5116.3 5116.9 4830.6 4886.6 4890.9 5029.3 5032.8 4277.5 4284.9 4325.1 4325.2 4382.1 3749.5 3765.6 3768.1 3807.6 3812.5 4262.3 4351.5 4359.8 4359.9 4414.1 4983.5 5017.9 5027.4 5029.1 5111.1 4352.4 4354.7 4365.5 4403.0 4412.2 4571.4 4574.8 4575.4 4585.5 4636.6 4586.3 4646.7 4698.0 4733.8 4781.5 5086.6 5091.6 5100.5 5139.2 5159.6 4760.5 4766.9 4767.7 4773.9 4823.0 4782.1 4858.9 4926.3 4985.5 5018.0 5067.6 5083.3 5091.1 5139.7 5148.9 4945.4 4948.6 4955.2 4956.1 4984.3 4786.7 4838.5 4938.5 4939.2 5006.5 4773.3 4800.5 4802.8 4811.4 4838.0 4924.2 4936.7 4939.9 4943.1 4999.0 4691.2 4750.0 4750.5 4809.3 4823.7 04:13:01 INFO - PROCESS | 455 | 04:13:01 INFO - PROCESS | 455 | [#1] ext.html Cycles:180 Average:42654.77 Median:197318.14 stddev:75668.99 (38.3%) stddev-sans-first:75815.32 04:13:01 INFO - PROCESS | 455 | Values: 579.7 584.6 584.7 585.0 588.4 27110.2 36624.3 37551.8 37771.0 41647.2 39257.6 39637.8 39655.8 39683.0 39716.4 7229.1 7380.1 7389.0 7389.9 7393.3 7588.8 7663.8 7670.2 7670.2 7677.3 7676.3 7713.4 7721.3 7732.4 7737.5 7663.8 7675.4 7702.1 7705.4 7706.8 7596.3 7669.5 7685.5 7688.2 7693.3 35803.5 36048.3 36065.5 36096.8 36100.8 2574.3 2755.9 2765.8 2801.8 2876.5 26828.0 26914.7 27514.3 27705.2 28314.0 3321.3 3357.4 3362.4 3376.9 3380.2 174101.0 174223.1 174669.1 174940.0 174948.0 49375.0 49399.3 49743.3 49745.0 49861.3 31935.7 32736.7 32790.3 52227.5 52394.7 12876.0 12992.6 13103.8 13110.1 13146.1 9565.3 9669.4 9677.2 9712.8 9734.1 17123.7 17134.4 17193.9 17207.5 17325.4 6562.5 6579.8 6606.0 6667.0 6787.9 776.9 850.8 921.6 950.7 990.2 26200.0 27054.0 27567.7 27830.3 27898.7 923.4 923.4 957.2 973.6 979.9 13877.5 14602.6 14799.5 14809.9 15033.5 358588.0 365263.0 366381.0 366450.0 367860.0 48524.5 49116.3 49138.8 49217.0 49332.0 1125.9 1164.1 1168.4 1174.8 1180.5 25516.4 26146.9 26357.4 26801.5 26944.2 40926.2 41088.2 41105.2 41206.8 41229.8 286646.0 287984.0 289317.0 290144.0 291306.0 24753.4 24908.4 25198.5 25248.2 25373.0 40973.0 40983.6 41486.4 41976.8 42208.8 34759.8 34788.7 34973.7 35117.3 35413.0 34495.7 34809.7 34924.3 35105.6 35268.3 34451.0 34877.8 35133.5 35178.3 35722.3 26441.7 28810.7 28953.4 29111.2 29295.3 24232.2 24564.3 24897.3 24982.9 25291.0 04:13:01 INFO - PROCESS | 455 | 04:13:01 INFO - PROCESS | 455 | [#2] jquery.html Cycles:180 Average:23138.28 Median:4886.30 stddev:59630.25 (1220.4%) stddev-sans-first:59772.97 04:13:01 INFO - PROCESS | 455 | Values: 345.8 362.5 368.0 369.0 392.4 12722.6 15920.0 16535.2 17694.1 17939.5 15819.4 16088.8 16212.5 16307.8 16389.9 4813.6 4959.0 5066.6 5165.3 5228.7 3367.9 3543.3 5306.5 5341.6 5343.8 5669.1 5955.7 5976.0 6049.2 6050.5 5275.1 5281.4 5309.4 6033.3 6038.0 5147.1 5148.0 5154.7 5158.0 5159.6 11577.2 11685.9 11766.1 11781.0 11913.2 1895.2 1906.1 1967.0 2019.6 2140.0 8663.5 8755.3 8777.1 9178.5 9256.8 1614.8 1719.5 1721.5 1738.3 1749.3 63925.0 68181.7 68369.7 69837.3 70280.0 9499.4 9723.2 9911.0 9969.5 10026.0 13467.5 13475.8 13507.4 13586.0 13617.0 6559.9 6682.8 6788.4 6905.3 6952.6 6359.5 6364.3 6558.2 6564.4 6595.2 4117.2 4208.6 4213.7 4299.0 4343.9 1702.3 1759.2 1794.5 1795.8 1810.9 824.1 842.5 844.0 853.4 898.4 16300.6 16599.6 17035.3 17125.4 17596.9 815.2 829.5 861.4 878.5 893.5 9243.6 9342.8 9535.4 9833.8 9959.6 344842.0 361879.0 361954.0 363730.0 365414.0 72061.3 73149.6 74207.6 74699.0 75786.0 806.8 833.3 863.3 863.6 864.1 14500.5 14953.5 15467.3 15513.9 15722.8 38739.8 38900.4 39272.2 39692.4 39734.6 53633.5 54542.2 54648.5 55288.4 56469.0 6853.5 7307.7 7520.8 7524.3 7647.1 10840.7 11553.7 11716.5 11720.6 11780.4 9797.2 10178.9 10293.9 10551.2 10596.3 10222.1 10241.4 10310.1 10377.8 10603.0 9861.4 10176.1 10178.9 10444.8 10808.0 6758.8 6961.8 7125.5 7131.5 7140.4 8467.8 10166.3 10312.0 10335.7 10651.6 04:13:01 INFO - PROCESS | 455 | 04:13:01 INFO - PROCESS | 455 | [#3] mootools.html Cycles:180 Average:4857.45 Median:5256.84 stddev:2754.10 (52.4%) stddev-sans-first:2748.15 04:13:01 INFO - PROCESS | 455 | Values: 1205.5 1341.0 1361.4 1421.9 1646.8 6611.6 7219.1 7473.2 7505.4 7650.4 7474.9 7599.2 7603.2 7608.7 7618.0 2013.8 2037.2 2039.4 2040.3 2045.9 2048.0 2090.4 2099.1 2117.7 2121.7 1918.2 1926.3 1926.9 1927.5 1959.3 2024.6 2041.7 2043.2 2047.9 2049.1 1972.7 1988.6 2022.2 2028.2 2028.9 7051.1 7250.9 7501.0 7631.9 7634.5 4178.7 4308.1 4318.9 4321.7 4328.2 2650.9 2711.4 2786.7 2793.6 2802.2 856.9 864.4 870.5 1779.9 1832.7 10190.7 10298.8 10302.6 10338.9 10338.9 3781.1 3839.4 3942.8 3949.1 3989.5 8097.3 8107.8 8109.4 8116.0 8131.4 4192.4 4202.2 4209.6 4209.7 4217.7 3479.3 3588.1 3731.6 3848.3 3856.5 3171.4 3211.5 3282.8 3303.5 3319.2 984.2 999.2 1003.8 1009.3 1029.3 712.0 727.8 730.3 745.3 769.6 4726.4 5047.0 5126.5 5259.2 5277.7 779.4 795.0 801.9 804.8 846.8 3213.3 3345.4 3357.2 3357.8 3492.1 8582.7 8962.6 9033.5 9297.1 9317.0 9246.8 9262.1 9263.8 9264.3 9281.6 6602.3 7001.9 7022.3 7042.2 7042.9 5156.4 5227.1 5254.5 5377.2 5460.2 8689.3 8703.9 8721.9 8794.3 8812.5 8417.5 8670.8 8860.1 8917.5 8980.0 5701.4 6377.6 6455.2 6459.9 6496.5 6378.0 6864.0 7058.6 7117.9 7287.4 6368.4 6427.0 6571.8 6617.1 6676.1 6243.6 6261.1 6263.3 6266.1 6337.4 5737.2 5810.5 5821.9 5833.6 5839.6 4138.2 4195.2 4268.7 4289.3 4303.9 4143.5 4154.5 4181.5 4218.4 4239.3 04:13:01 INFO - PROCESS | 455 | 04:13:01 INFO - PROCESS | 455 | [#4] prototype.html Cycles:180 Average:4166.13 Median:4745.35 stddev:1213.19 (25.6%) stddev-sans-first:1181.07 04:13:01 INFO - PROCESS | 455 | Values: 283.1 291.9 297.4 298.2 302.2 4609.3 4782.8 4809.0 4852.5 4855.2 4572.2 4697.6 4725.1 4725.3 4765.4 3768.8 3776.1 3780.4 3781.1 3781.8 3559.0 3581.9 3661.2 3783.4 3829.0 3690.3 3694.8 3698.4 3699.9 3704.7 3690.9 3691.9 3692.7 3698.9 3706.5 3255.9 3267.8 3273.8 3292.2 3312.7 4613.4 4625.1 4638.0 4646.3 4651.7 4213.9 4238.4 4240.5 4250.7 4253.8 4979.3 4988.0 4994.4 5027.8 5032.0 3461.7 3564.1 3567.7 3575.7 3580.8 5196.2 5213.8 5222.6 5226.9 5283.8 3632.8 3645.9 3647.1 3647.9 3652.5 3688.4 3724.4 3725.2 3725.5 3732.9 4086.1 4194.6 4202.5 4204.8 4228.5 4978.1 4981.3 4981.8 5018.3 5042.7 1220.0 1249.2 1252.8 1284.3 1289.1 847.9 865.7 881.2 895.4 906.5 4406.3 4413.0 4418.9 4468.2 4470.2 5148.7 5150.6 5161.7 5164.0 5176.3 4316.8 4502.4 4510.3 4547.9 4549.5 2736.9 2739.8 2746.5 2748.5 2770.8 4791.6 4902.1 4914.0 4919.6 4949.0 5305.2 5322.5 5324.8 5328.3 5345.0 4887.5 4887.7 4889.0 4894.5 4935.6 4959.0 5164.6 5189.3 5204.5 5220.2 5091.4 5112.7 5114.7 5118.8 5121.8 4887.3 4892.2 4895.9 4930.9 4936.2 3494.2 3653.8 3660.1 3663.8 3667.4 5149.8 5157.0 5157.3 5179.5 5190.2 5006.7 5017.3 5041.4 5066.5 5075.4 4901.7 4993.0 5029.8 5046.8 5052.9 4648.6 4789.3 4795.8 4899.4 4917.7 5028.3 5030.8 5051.0 5061.5 5062.3 4901.6 4907.7 4919.3 4919.5 4920.9 04:13:01 INFO - PROCESS | 455 | 04:13:01 INFO - PROCESS | 455 | [#5] yui.html Cycles:180 Average:16984.12 Median:43485.46 stddev:24475.40 (56.3%) stddev-sans-first:24513.04 04:13:01 INFO - PROCESS | 455 | Values: 571.5 596.6 601.2 607.8 659.7 11039.5 11743.8 11797.0 11885.4 11892.9 11523.8 11785.6 11822.2 11896.2 11898.3 735.5 748.7 755.5 756.5 756.9 741.2 743.1 743.8 744.0 744.1 792.0 793.2 794.9 795.3 796.1 779.0 779.4 779.5 779.7 779.8 575.8 579.9 580.5 580.8 580.8 12462.1 12531.6 12587.4 12599.9 12606.0 13401.7 13454.6 13504.6 13595.4 13757.5 10312.9 10431.8 10469.5 10515.1 10635.2 3201.4 3205.2 3253.0 3289.1 3359.5 65413.7 65435.0 65522.1 65625.0 66529.3 9991.1 10237.4 10253.6 10359.3 10610.3 17798.5 18151.6 18267.8 18288.4 18656.4 6187.0 6326.1 6342.7 6415.3 6484.3 3554.0 3585.5 3620.2 3639.7 3669.4 2697.0 2825.4 2833.1 3107.9 3251.8 541.2 542.6 548.2 551.7 566.0 511.0 517.8 526.8 530.6 536.8 7006.8 7061.2 7087.0 7499.4 7990.3 522.6 531.5 534.7 540.4 543.1 3522.5 3601.5 3675.2 3677.7 3734.4 96476.5 97945.5 104236.0 104764.5 104895.0 48182.5 65138.7 78875.6 84321.0 84814.0 42419.0 72213.6 73021.6 73097.6 75117.2 7892.6 8395.8 8419.9 8456.6 8647.1 29482.3 37039.0 43458.6 43512.3 44537.6 46588.5 57379.4 58763.7 59117.7 60266.4 10916.5 10981.8 11046.0 11318.3 11698.9 12211.9 12342.0 12369.3 12656.8 12731.1 11880.2 11951.3 11994.9 12185.5 12788.5 10862.4 10878.6 11128.3 11331.5 11521.9 11371.0 11449.9 11830.8 12168.5 12790.7 8844.8 9392.6 9647.1 9840.0 9955.4 10081.9 10130.7 10290.4 10358.4 10407.6 04:13:01 INFO - PROCESS | 455 | -------- Summary: end -------- 04:13:01 INFO - PROCESS | 455 | 04:13:02 INFO - TEST-INFO | 455: exit 0 04:13:02 INFO - TEST-OK | dromaeo_css | took 1121304ms 04:13:02 INFO - TEST-START | kraken 04:13:02 INFO - operating with platform_type : linux_ 04:13:02 INFO - Initialising browser for kraken test... 04:13:02 INFO - TEST-INFO | started process 764 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHT8wgu/profile http://localhost:60976/getInfo.html) 04:13:06 INFO - PROCESS | 764 | __metrics Screen width/height:1600/1200 04:13:06 INFO - PROCESS | 764 | colorDepth:24 04:13:06 INFO - PROCESS | 764 | Browser inner width/height: 1024/697 04:13:06 INFO - PROCESS | 764 | __metrics 04:13:07 INFO - PROCESS | 764 | 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" 04:13:07 INFO - PROCESS | 764 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:13:07 INFO - PROCESS | 764 | console.error: PushService: 04:13:07 INFO - PROCESS | 764 | stateChangeProcessEnqueue: Error transitioning state 04:13:07 INFO - PROCESS | 764 | UnknownError 04:13:08 INFO - TEST-INFO | 764: exit 0 04:13:08 INFO - Browser initialized. 04:13:08 INFO - Running cycle 1/1 for kraken test... 04:13:08 INFO - TEST-INFO | started process 852 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHT8wgu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:13:20 INFO - PROCESS | 852 | RSS: Main: 174882816 04:13:20 INFO - PROCESS | 852 | 04:13:23 INFO - PROCESS | 852 | Cycle 1(1): loaded http://localhost:60976/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60976/tests/kraken/driver.html?testName=audio-beat-detection) 04:13:24 INFO - PROCESS | 852 | RSS: Main: 242171904 04:13:24 INFO - PROCESS | 852 | 04:13:27 INFO - PROCESS | 852 | Cycle 1(1): loaded http://localhost:60976/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60976/tests/kraken/driver.html?testName=audio-dft) 04:13:27 INFO - PROCESS | 852 | RSS: Main: 220151808 04:13:27 INFO - PROCESS | 852 | 04:13:31 INFO - PROCESS | 852 | Cycle 1(1): loaded http://localhost:60976/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60976/tests/kraken/driver.html?testName=audio-fft) 04:13:31 INFO - PROCESS | 852 | RSS: Main: 301772800 04:13:31 INFO - PROCESS | 852 | 04:13:33 INFO - PROCESS | 852 | Cycle 1(1): loaded http://localhost:60976/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60976/tests/kraken/driver.html?testName=audio-oscillator) 04:13:34 INFO - PROCESS | 852 | RSS: Main: 212512768 04:13:34 INFO - PROCESS | 852 | 04:13:36 INFO - PROCESS | 852 | Cycle 1(1): loaded http://localhost:60976/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60976/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:13:37 INFO - PROCESS | 852 | RSS: Main: 214740992 04:13:37 INFO - PROCESS | 852 | 04:13:40 INFO - PROCESS | 852 | Cycle 1(1): loaded http://localhost:60976/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60976/tests/kraken/driver.html?testName=imaging-darkroom) 04:13:41 INFO - PROCESS | 852 | RSS: Main: 251203584 04:13:41 INFO - PROCESS | 852 | 04:13:44 INFO - PROCESS | 852 | Cycle 1(1): loaded http://localhost:60976/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60976/tests/kraken/driver.html?testName=imaging-desaturate) 04:13:45 INFO - PROCESS | 852 | RSS: Main: 245317632 04:13:45 INFO - PROCESS | 852 | 04:13:48 INFO - PROCESS | 852 | Cycle 1(1): loaded http://localhost:60976/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60976/tests/kraken/driver.html?testName=json-parse-financial) 04:13:48 INFO - PROCESS | 852 | RSS: Main: 248459264 04:13:48 INFO - PROCESS | 852 | 04:13:50 INFO - PROCESS | 852 | Cycle 1(1): loaded http://localhost:60976/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60976/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:13:51 INFO - PROCESS | 852 | RSS: Main: 211460096 04:13:51 INFO - PROCESS | 852 | 04:13:53 INFO - PROCESS | 852 | Cycle 1(1): loaded http://localhost:60976/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60976/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:13:53 INFO - PROCESS | 852 | RSS: Main: 217804800 04:13:53 INFO - PROCESS | 852 | 04:13:55 INFO - PROCESS | 852 | Cycle 1(1): loaded http://localhost:60976/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60976/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:13:56 INFO - PROCESS | 852 | RSS: Main: 228294656 04:13:56 INFO - PROCESS | 852 | 04:13:59 INFO - PROCESS | 852 | Cycle 1(1): loaded http://localhost:60976/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60976/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:14:00 INFO - PROCESS | 852 | RSS: Main: 236498944 04:14:00 INFO - PROCESS | 852 | 04:14:03 INFO - PROCESS | 852 | Cycle 1(1): loaded http://localhost:60976/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60976/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:14:03 INFO - PROCESS | 852 | RSS: Main: 233746432 04:14:03 INFO - PROCESS | 852 | 04:14:05 INFO - PROCESS | 852 | Cycle 1(1): loaded http://localhost:60976/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60976/tests/kraken/driver.html?testName=ai-astar) 04:14:05 INFO - PROCESS | 852 | RSS: Main: 284868608 04:14:05 INFO - PROCESS | 852 | 04:14:05 INFO - PROCESS | 852 | __start_tp_report 04:14:05 INFO - PROCESS | 852 | _x_x_mozilla_page_load 04:14:05 INFO - PROCESS | 852 | _x_x_mozilla_page_load_details 04:14:05 INFO - PROCESS | 852 | |i|pagename|runs| 04:14:05 INFO - PROCESS | 852 | |0;ai-astar;111;114;114;115;114;116;114;113;115;115 04:14:05 INFO - PROCESS | 852 | |1;audio-beat-detection;153;136;126;177;129;128;127;125;160;125 04:14:05 INFO - PROCESS | 852 | |2;audio-dft;162;161;163;162;161;163;161;161;161;161 04:14:05 INFO - PROCESS | 852 | |3;audio-fft;77;76;77;106;76;77;77;76;106;76 04:14:05 INFO - PROCESS | 852 | |4;audio-oscillator;84;83;117;83;85;84;112;84;84;120 04:14:05 INFO - PROCESS | 852 | |5;imaging-gaussian-blur;117;117;118;118;117;117;118;118;118;121 04:14:05 INFO - PROCESS | 852 | |6;imaging-darkroom;147;146;147;147;148;147;147;146;147;148 04:14:05 INFO - PROCESS | 852 | |7;imaging-desaturate;95;95;95;95;94;95;94;96;95;94 04:14:05 INFO - PROCESS | 852 | |8;json-parse-financial;66;64;64;63;64;66;66;64;66;65 04:14:05 INFO - PROCESS | 852 | |9;json-stringify-tinderbox;66;66;66;66;66;66;67;67;66;66 04:14:05 INFO - PROCESS | 852 | |10;stanford-crypto-aes;84;84;82;83;83;101;83;92;83;87 04:14:05 INFO - PROCESS | 852 | |11;stanford-crypto-ccm;137;141;151;140;141;150;140;138;179;145 04:14:05 INFO - PROCESS | 852 | |12;stanford-crypto-pbkdf2;179;181;177;176;179;178;174;177;177;176 04:14:05 INFO - PROCESS | 852 | |13;stanford-crypto-sha256-iterative;73;72;71;70;70;71;69;72;71;70 04:14:05 INFO - PROCESS | 852 | __end_tp_report 04:14:05 INFO - PROCESS | 852 | __start_cc_report 04:14:05 INFO - PROCESS | 852 | _x_x_mozilla_cycle_collect,1959 04:14:05 INFO - PROCESS | 852 | __end_cc_report 04:14:05 INFO - PROCESS | 852 | __startTimestamp1475752445848__endTimestamp 04:14:05 INFO - PROCESS | 852 | 04:14:05 INFO - PROCESS | 852 | ------- Summary: start ------- 04:14:05 INFO - PROCESS | 852 | Number of tests: 14 04:14:05 INFO - PROCESS | 852 | 04:14:05 INFO - PROCESS | 852 | [#0] ai-astar Cycles:10 Average:114.10 Median:114.50 stddev:1.37 (1.2%) stddev-sans-first:0.88 04:14:05 INFO - PROCESS | 852 | Values: 111.0 114.0 114.0 115.0 114.0 116.0 114.0 113.0 115.0 115.0 04:14:05 INFO - PROCESS | 852 | 04:14:05 INFO - PROCESS | 852 | [#1] audio-beat-detection Cycles:10 Average:138.60 Median:132.50 stddev:18.30 (13.8%) stddev-sans-first:18.65 04:14:05 INFO - PROCESS | 852 | Values: 153.0 136.0 126.0 177.0 129.0 128.0 127.0 125.0 160.0 125.0 04:14:05 INFO - PROCESS | 852 | 04:14:05 INFO - PROCESS | 852 | [#2] audio-dft Cycles:10 Average:161.60 Median:161.50 stddev:0.84 (0.5%) stddev-sans-first:0.88 04:14:05 INFO - PROCESS | 852 | Values: 162.0 161.0 163.0 162.0 161.0 163.0 161.0 161.0 161.0 161.0 04:14:05 INFO - PROCESS | 852 | 04:14:05 INFO - PROCESS | 852 | [#3] audio-fft Cycles:10 Average:82.40 Median:76.50 stddev:12.45 (16.3%) stddev-sans-first:13.05 04:14:05 INFO - PROCESS | 852 | Values: 77.0 76.0 77.0 106.0 76.0 77.0 77.0 76.0 106.0 76.0 04:14:05 INFO - PROCESS | 852 | 04:14:05 INFO - PROCESS | 852 | [#4] audio-oscillator Cycles:10 Average:93.60 Median:84.00 stddev:15.81 (18.8%) stddev-sans-first:16.39 04:14:05 INFO - PROCESS | 852 | Values: 84.0 83.0 117.0 83.0 85.0 84.0 112.0 84.0 84.0 120.0 04:14:05 INFO - PROCESS | 852 | 04:14:05 INFO - PROCESS | 852 | [#5] imaging-gaussian-blur Cycles:10 Average:117.90 Median:118.00 stddev:1.20 (1.0%) stddev-sans-first:1.22 04:14:05 INFO - PROCESS | 852 | Values: 117.0 117.0 118.0 118.0 117.0 117.0 118.0 118.0 118.0 121.0 04:14:05 INFO - PROCESS | 852 | 04:14:05 INFO - PROCESS | 852 | [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 04:14:05 INFO - PROCESS | 852 | Values: 147.0 146.0 147.0 147.0 148.0 147.0 147.0 146.0 147.0 148.0 04:14:05 INFO - PROCESS | 852 | 04:14:05 INFO - PROCESS | 852 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 04:14:05 INFO - PROCESS | 852 | Values: 95.0 95.0 95.0 95.0 94.0 95.0 94.0 96.0 95.0 94.0 04:14:05 INFO - PROCESS | 852 | 04:14:05 INFO - PROCESS | 852 | [#8] json-parse-financial Cycles:10 Average:64.80 Median:65.50 stddev:1.14 (1.7%) stddev-sans-first:1.12 04:14:05 INFO - PROCESS | 852 | Values: 66.0 64.0 64.0 63.0 64.0 66.0 66.0 64.0 66.0 65.0 04:14:05 INFO - PROCESS | 852 | 04:14:05 INFO - PROCESS | 852 | [#9] json-stringify-tinderbox Cycles:10 Average:66.20 Median:66.00 stddev:0.42 (0.6%) stddev-sans-first:0.44 04:14:05 INFO - PROCESS | 852 | Values: 66.0 66.0 66.0 66.0 66.0 66.0 67.0 67.0 66.0 66.0 04:14:05 INFO - PROCESS | 852 | 04:14:05 INFO - PROCESS | 852 | [#10] stanford-crypto-aes Cycles:10 Average:86.20 Median:83.50 stddev:5.98 (7.2%) stddev-sans-first:6.29 04:14:05 INFO - PROCESS | 852 | Values: 84.0 84.0 82.0 83.0 83.0 101.0 83.0 92.0 83.0 87.0 04:14:05 INFO - PROCESS | 852 | 04:14:05 INFO - PROCESS | 852 | [#11] stanford-crypto-ccm Cycles:10 Average:146.20 Median:143.00 stddev:12.46 (8.7%) stddev-sans-first:12.76 04:14:05 INFO - PROCESS | 852 | Values: 137.0 141.0 151.0 140.0 141.0 150.0 140.0 138.0 179.0 145.0 04:14:05 INFO - PROCESS | 852 | 04:14:05 INFO - PROCESS | 852 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:177.40 Median:177.50 stddev:1.96 (1.1%) stddev-sans-first:1.99 04:14:05 INFO - PROCESS | 852 | Values: 179.0 181.0 177.0 176.0 179.0 178.0 174.0 177.0 177.0 176.0 04:14:05 INFO - PROCESS | 852 | 04:14:05 INFO - PROCESS | 852 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.90 Median:71.00 stddev:1.20 (1.7%) stddev-sans-first:1.00 04:14:05 INFO - PROCESS | 852 | Values: 73.0 72.0 71.0 70.0 70.0 71.0 69.0 72.0 71.0 70.0 04:14:05 INFO - PROCESS | 852 | -------- Summary: end -------- 04:14:05 INFO - PROCESS | 852 | 04:14:07 INFO - TEST-INFO | 852: exit 0 04:14:07 INFO - TEST-OK | kraken | took 64955ms 04:14:07 INFO - SUITE-END | took 1186s 04:14:07 INFO - Completed test suite (00:19:46) 04:14:07 INFO - javascript benchmark 04:14:07 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2558.833675811072, 2615.2546524240597, 2633.6181253718205, 2639.2610069180623, 2656.1633085578055, 4599.7010194337345, 4676.485586585472, 4692.741899195543, 4723.409573803275, 4723.90552188956, 4715.740634265114, 4721.952780472203, 4723.622110231182, 4725.0, 4727.8818029549275, 4290.935635965455, 4302.225599392108, 4316.07204451043, 4344.674149438789, 4371.3661519079715, 4327.0480494291205, 4354.08564201518, 4369.431973843396, 4395.274779661352, 4441.777911104448, 4416.6245869101, 4418.447694038246, 4456.55434456555, 4470.664700147486, 4472.575105364985, 242.75719065448044, 4421.756803375813, 4423.469183697961, 4423.712458690191, 4446.310821822591, 4265.637420819203, 4271.658267338606, 4282.721623094489, 4311.504177019651, 4317.956820431787, 4647.140279048387, 4709.317149013408, 4733.733684053813, 4734.786934587952, 4787.16224660683, 5095.898082038376, 5100.336956195708, 5100.719460429675, 5101.923471147936, 5169.663971841818, 4860.05228980349, 4956.727379994135, 4967.0, 5037.874053148664, 5061.620378471593, 4672.462666793363, 4679.859604211879, 4688.0, 4707.5057119002695, 4769.093872164243, 5213.661112027782, 5217.843464696065, 5220.112580861262, 5223.9477605223465, 5274.024305503494, 4786.880327991758, 4840.854774356775, 4911.68074075184, 4994.126027945168, 5064.215046667772, 5057.671251368649, 5083.38999320084, 5084.059449001947, 5086.338775959101, 5152.252923326097, 4999.725015124131, 5053.69677819332, 5058.570021548209, 5116.258142569307, 5116.872078198, 4830.589399900978, 4886.560209581155, 4890.926636100461, 5029.321041659402, 5032.7735251913755, 4277.465316835395, 4284.871453856389, 4325.134973005412, 4325.178216138924, 4382.101669157815, 3749.4750734897134, 3765.585785563586, 3768.09565704229, 3807.562130354989, 3812.4853144825647, 4262.339337402707, 4351.4995775485595, 4359.847405340798, 4359.912801743947, 4414.073044660593, 4983.526564976321, 5017.899642007213, 5027.421846487628, 5029.119904016782, 5111.080005598954, 4352.434183556117, 4354.6951713380395, 4365.541618130051, 4403.031333106712, 4412.227860124465, 4571.405717256735, 4574.794134263966, 4575.405197324393, 4585.518520555293, 4636.559526844944, 4586.334981427608, 4646.6747327686735, 4697.976510117427, 4733.763311834464, 4781.450133234723, 5086.64393492452, 5091.592672586258, 5100.515451032146, 5139.2291156325355, 5159.638825282194, 4760.500147484603, 4766.904661906812, 4767.73777442244, 4773.9045219096115, 4823.0, 4782.115308667769, 4858.854234372974, 4926.285688575065, 4985.476524964826, 5018.04657115147, 5067.594592432522, 5083.262926875508, 5091.109055915274, 5139.665921715076, 5148.948510514847, 4945.431275403231, 4948.579370753382, 4955.207166853286, 4956.058348913695, 4984.252362145708, 4786.712797232177, 4838.467768545527, 4938.48145944685, 4939.160342741814, 5006.474320196473, 4773.260144677581, 4800.495947925418, 4802.831900883452, 4811.398575178103, 4837.975810120927, 4924.212126059813, 4936.679115857458, 4939.876503087452, 4943.134951383421, 4998.975005124951, 4691.249400096105, 4749.952500474951, 4750.477447480705, 4809.278608208797, 4823.686460380064], "value": 4608.956385061607, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [579.672485045949, 584.6346033728919, 584.6813486649778, 584.9853753656156, 588.3645662684302, 27110.186694399174, 36624.26751464969, 37551.80809631181, 37771.0, 41647.167056658924, 39257.60742392575, 39637.8018109909, 39655.801720991425, 39683.0, 39716.40425393614, 7229.1325040995025, 7380.114386273654, 7389.039424874759, 7389.926100739004, 7393.297636724503, 7588.810279742996, 7663.808404789897, 7670.156282808886, 7670.194629563899, 7677.270659287359, 7676.309132178103, 7713.382929365637, 7721.266479684421, 7732.381409487228, 7737.497062690935, 7663.770086897402, 7675.385969122457, 7702.114256860421, 7705.383569314497, 7706.807329816744, 7596.3163315301335, 7669.463137580372, 7685.538867667958, 7688.1927397623, 7693.269139431745, 35803.4629480558, 36048.27903441943, 36065.45901811475, 36096.81951590251, 36100.819495902615, 2574.3435423966766, 2755.9035433759723, 2765.847878366689, 2801.845898475583, 2876.525373313422, 26828.0, 26914.730852691417, 27514.312142196406, 27705.168844934684, 28314.0, 3321.3025264694443, 3357.4257425742576, 3362.36115138123, 3376.8818091366684, 3380.154961259685, 174101.0, 174223.12888435603, 174669.1266543672, 174939.99999999872, 174948.0, 49375.0, 49399.25901111486, 49743.25385119226, 49745.0, 49861.25208121881, 31935.68064319327, 32736.672633273363, 32790.34419311648, 52227.47772522302, 52394.738026310384, 12876.0, 12992.610221693365, 13103.803442948363, 13110.147840390344, 13146.07977441589, 9565.282603804742, 9669.371490853073, 9677.225821934227, 9712.805743885083, 9734.075262850018, 17123.65752684964, 17134.40029598958, 17193.914030430016, 17207.483775486755, 17325.393611223797, 6562.5406221564035, 6579.80260592183, 6606.0, 6666.966665166643, 6787.898181527281, 776.926192011758, 850.8043150075517, 921.6175287255713, 950.7385468996082, 990.1583055516733, 26200.0, 27054.0, 27567.724322756516, 27830.3042423941, 27898.721012790018, 923.4182465046978, 923.4459324405437, 957.1959553974694, 973.6300205921705, 979.911807937289, 13877.514286999907, 14602.634934126732, 14799.482018129314, 14809.851901480848, 15033.473828415952, 358588.0, 365263.0, 366381.0, 366450.0, 367860.0, 48524.514754851996, 49116.263256051185, 49138.754306228955, 49217.0, 49332.04007759546, 1125.8930401611833, 1164.0803765025535, 1168.4099529737427, 1174.770919670656, 1180.5395895600723, 25516.362090947874, 26146.86926565431, 26357.431119525227, 26801.463970720088, 26944.191674249803, 40926.181476370904, 41088.178236434505, 41105.1778964425, 41206.793966029974, 41229.793851030554, 286646.0, 287984.0, 289317.0, 290144.0, 291306.0, 24753.381165471008, 24908.37729056788, 25198.496030078928, 25248.242552723448, 25373.0, 40973.0, 40983.59016409798, 41486.377704333856, 41976.790116049226, 42208.788956055025, 34759.82620086883, 34788.652113479555, 34973.65026349704, 35117.29765404729, 35413.0, 34495.655043449246, 34809.65190348064, 34924.30151397009, 35105.64894351126, 35268.29463410769, 34451.0, 34877.82561087178, 35133.472997904544, 35178.29643407066, 35722.285554288246, 26441.735582643927, 28810.7118928808, 28953.420931581673, 29111.166625031226, 29295.267618309714, 24232.151874684303, 24564.263072107864, 24897.25308240756, 24982.875085624455, 25291.0], "value": 16515.956689251267, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [345.79252448530866, 362.5395747400801, 367.9760815546991, 368.9944650830237, 392.41921955505853, 12722.618321450349, 15920.0, 16535.17324133793, 17694.1152942353, 17939.461816145504, 15819.446319378823, 16088.83911160891, 16212.51362459125, 16307.83692163078, 16389.91805040976, 4813.614910807127, 4958.975205123969, 5066.645334826564, 5165.328507294046, 5228.686278823283, 3367.882124125656, 3543.255916257589, 5306.52241298285, 5341.599380046493, 5343.786248550054, 5669.121286200645, 5955.731992060368, 5976.0, 6049.153118563405, 6050.455459008688, 5275.103232450492, 5281.419043905167, 5309.442508536626, 6033.306169790464, 6037.969810150943, 5147.124988751922, 5147.996140752554, 5154.716490593016, 5158.0, 5159.613029022838, 11577.247478913843, 11685.88314116865, 11766.117541184445, 11781.0, 11913.166078374517, 1895.2419032387018, 1906.075553356621, 1966.9508262293414, 2019.5556977464935, 2140.0048977225665, 8663.523506207157, 8755.299576033902, 8777.122287771235, 9178.541072946326, 9256.768580785467, 1614.77393164957, 1719.4927496388596, 1721.500764778213, 1738.3220543987854, 1749.335252604015, 63925.0, 68181.65909170471, 68369.65815170942, 69837.3016269836, 70280.0, 9499.440268671076, 9723.15935205604, 9911.0, 9969.451680157516, 10026.0, 13467.461301547828, 13475.797863032063, 13507.392167352493, 13586.048976571545, 13617.0, 6559.934400656028, 6682.766103186365, 6788.389044985975, 6905.274946130584, 6952.582845029315, 6359.459445947054, 6364.268109167412, 6558.213014438298, 6564.376384243489, 6595.208574970939, 4117.197146556393, 4208.642265407475, 4213.69375493598, 4299.0, 4343.891402714894, 1702.3445973300368, 1759.2171483689635, 1794.4975406886092, 1795.838374546297, 1810.9275628974694, 824.1017291152673, 842.5071333269983, 844.0, 853.4111463090447, 898.3711402018613, 16300.592485187964, 16599.585010374838, 17035.318587256617, 17125.400610978555, 17596.912015440095, 815.176671561727, 829.4774292195877, 861.3539845116163, 878.5252687691752, 893.5301429149014, 9243.630254789867, 9342.766430839283, 9535.38020028696, 9833.803323933624, 9959.601615935426, 344842.0, 361879.0, 361954.0, 363730.0, 365414.0, 72061.27938720546, 73149.63425182841, 74207.62896185592, 74699.0, 75785.9999999989, 806.846699127164, 833.2708879730236, 863.3222920007889, 863.6286396849415, 864.1358641358642, 14500.534387194843, 14953.476628317956, 15467.303971321542, 15513.922430387776, 15722.76415853786, 38739.80630096832, 38900.41649375205, 39272.21455570815, 39692.404613931394, 39734.60265397309, 53633.46366536285, 54542.18186727282, 54648.453515465924, 55288.44711552833, 56469.0, 6853.4859885507785, 7307.67115479794, 7520.774376768706, 7524.322810947041, 7647.120581133018, 10840.728981775519, 11553.653390398302, 11716.472758726048, 11720.589779357682, 11780.408310171748, 9797.167240784613, 10178.898211017795, 10293.948530257301, 10551.155907527225, 10596.31123976939, 10222.131118854682, 10241.385516869012, 10310.123639490726, 10377.792444151226, 10603.0, 9861.359011664219, 10176.135028522658, 10178.949105254427, 10444.843327350247, 10808.0, 6758.797236082925, 6961.79114626562, 7125.465590080868, 7131.465140114408, 7140.393066589398, 8467.83064338722, 10166.288359814742, 10312.0, 10335.689929302132, 10651.57393704243], "value": 7925.9089517606535, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1205.499717617189, 1340.9664758381036, 1361.380571839813, 1421.943122275109, 1646.81061677907, 6611.636360000198, 7219.0976127984, 7473.215312392202, 7505.362044226241, 7650.4262180336555, 7474.925250747491, 7599.164091949895, 7603.201663825302, 7608.695652173907, 7618.0, 2013.7784843667184, 2037.2258541754113, 2039.4085715142664, 2040.3062958594076, 2045.8670186437907, 2048.0476578391044, 2090.4042347930845, 2099.0659156675288, 2117.7035215069905, 2121.6711409731515, 1918.213532451695, 1926.3257859749046, 1926.8747531410484, 1927.469945764912, 1959.2652755216793, 2024.5647185855112, 2041.7447819022623, 2043.2031507712004, 2047.938561843147, 2049.108637742572, 1972.6745087060617, 1988.6420444320017, 2022.1506967073865, 2028.239410221167, 2028.9086991085437, 7051.083359163327, 7250.927490725078, 7501.0, 7631.885521717179, 7634.541927484369, 4178.707490475668, 4308.138372325548, 4318.913621727579, 4321.675874309408, 4328.2209202343565, 2650.8542030188332, 2711.4170453352426, 2786.70739572344, 2793.5949287353424, 2802.1593521943337, 856.9117221129194, 864.4381152251087, 870.4907629037021, 1779.9377021804305, 1832.7159290310024, 10190.745231369201, 10298.794024119476, 10302.587896484132, 10338.896611033868, 10338.896611033868, 3781.111438811877, 3839.4432807242792, 3942.8422863085157, 3949.1311911379453, 3989.501312335958, 8097.2712455879255, 8107.797305067303, 8109.43233973628, 8115.959420202979, 8131.430799843954, 4192.350185721218, 4202.222588821078, 4209.5790420957655, 4209.663226941837, 4217.704760666786, 3479.321532301177, 3588.085038315213, 3731.6454936781506, 3848.3073046851837, 3856.4793752843007, 3171.413288541627, 3211.4701074322943, 3282.7537934654997, 3303.4549299365335, 3319.2365755876285, 984.1634610580949, 999.2163987282665, 1003.8243307421172, 1009.3287963504334, 1029.341221618165, 711.9715211391486, 727.8107692000118, 730.2879692300071, 745.2584678245181, 769.6498093367504, 4726.385569875894, 5046.9747651261505, 5126.487351264844, 5259.15853463444, 5277.736113194402, 779.4465929190338, 794.9665434934562, 801.939854510914, 804.7505273365275, 846.7967687754895, 3213.2770126721766, 3345.4480010798434, 3357.1607098225445, 3357.772713762052, 3492.1444246159854, 8582.656693732306, 8962.596683149273, 9033.548322583845, 9297.116773906468, 9316.95341523288, 9246.815063698688, 9262.073792620818, 9263.76840578991, 9264.25885929124, 9281.628734850665, 6602.3397660233595, 7001.859962800715, 7022.262662420474, 7042.154941406961, 7042.859142817218, 5156.3690319110965, 5227.085260079547, 5254.527092561688, 5377.166539186433, 5460.208269800936, 8689.30485561141, 8703.86944195825, 8721.91278087211, 8794.340424468062, 8812.515311657664, 8417.494950303002, 8670.78323041929, 8860.113988601346, 8917.509536975529, 8979.955100224457, 5701.4298570142655, 6377.649229292433, 6455.160829092376, 6459.903101453576, 6496.512761542997, 6378.043293506012, 6864.0, 7058.576485410892, 7117.928820711727, 7287.380572651172, 6368.363163683594, 6427.0, 6571.817072926728, 6617.073609694743, 6676.065350850788, 6243.594166379171, 6261.092141639528, 6263.342349053284, 6266.091416744455, 6337.366263373626, 5737.168110624019, 5810.477057064715, 5821.854453638523, 5833.649981001154, 5839.649621022752, 4138.172365526846, 4195.202911446815, 4268.701190916606, 4289.292266775947, 4303.859477238597, 4143.482064741907, 4154.459920210354, 4181.498220213472, 4218.409422680888, 4239.300515414922], "value": 3909.873868561714, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [283.07716843091526, 291.9386928744963, 297.4304207442747, 298.2469265105608, 302.20972157807324, 4609.262517997113, 4782.808687652489, 4809.0, 4852.5147485251455, 4855.223164293714, 4572.2455794793905, 4697.5772180503745, 4725.078609671115, 4725.3148293497425, 4765.380500534934, 3768.8492460301554, 3776.1126135358236, 3780.3951367781024, 3781.1492414206723, 3781.773093614392, 3559.0, 3581.856725730968, 3661.231141460283, 3783.375743002415, 3829.0235989822554, 3690.335739566877, 3694.7967861767593, 3698.352788262057, 3699.907502312437, 3704.703353826166, 3690.8892733218045, 3691.9261614767825, 3692.667659910621, 3698.9260214795554, 3706.4625629283605, 3255.9186020349443, 3267.8235835099345, 3273.770836041478, 3292.226326813197, 3312.685294896981, 4613.423322084739, 4625.1443482955765, 4637.956459796553, 4646.326282689025, 4651.651126165551, 4213.852515161954, 4238.41059602649, 4240.512341080785, 4250.744955302692, 4253.829846806124, 4979.253112033188, 4987.950120498785, 4994.425641051253, 5027.798888044474, 5031.974840125813, 3461.7403694723, 3564.1446052947367, 3567.6967457766123, 3575.6781889629797, 3580.803055831954, 5196.168613021899, 5213.791448342062, 5222.582193424517, 5226.921596176022, 5283.841484755425, 3632.8183590820354, 3645.872394466234, 3647.1429214134655, 3647.9270414592092, 3652.5251717276583, 3688.354537955847, 3724.4413337999517, 3725.2177042820767, 3725.515682961198, 3732.869349572752, 4086.0806318578675, 4194.580541945781, 4202.453681021448, 4204.768737719455, 4228.471441069866, 4978.054169707744, 4981.327520784647, 4981.775820088033, 5018.272350509155, 5042.747862606855, 1219.9508422756423, 1249.244207254616, 1252.824604555363, 1284.319310765296, 1289.1362786932777, 847.8897743293455, 865.6926790989108, 881.2377293641083, 895.3553441522093, 906.4923642760075, 4406.27296496081, 4413.0361988915265, 4418.911621767546, 4468.17338792318, 4470.24005918988, 5148.6910785353, 5150.639455238097, 5161.716105614228, 5164.0, 5176.275321454999, 4316.848910288125, 4502.3921770560555, 4510.2783554631105, 4547.886302842456, 4549.54504549549, 2736.931576710558, 2739.808213425081, 2746.5168808843, 2748.477789220042, 2770.7695305279444, 4791.616670666338, 4902.117618828645, 4914.0, 4919.605472224154, 4948.975255123702, 5305.196233280626, 5322.54758345545, 5324.8136315228785, 5328.307320048369, 5345.01117293302, 4887.486813884562, 4887.706737595756, 4889.046635906036, 4894.4827103598, 4935.605151587936, 4958.983408401197, 5164.579740571373, 5189.273501709839, 5204.531592156724, 5220.1647736362, 5091.439941606346, 5112.693238405707, 5114.74426278692, 5118.795248190031, 5121.795128194831, 4887.315775791463, 4892.241702536113, 4895.877603059952, 4930.852074437773, 4936.160852654985, 3494.161401263628, 3653.83557739897, 3660.1398671312754, 3663.816809159478, 3667.3582123127812, 5149.819756308511, 5157.045946499909, 5157.277981082577, 5179.533841954242, 5190.247414124855, 5006.724630145377, 5017.297578339108, 5041.42023667283, 5066.493350664904, 5075.365579302587, 4901.730404827768, 4993.0, 5029.773660185374, 5046.84859454217, 5052.873678158076, 4648.628109751279, 4789.3055506952, 4795.784189711541, 4899.4365647950945, 4917.680350777331, 5028.296038554532, 5030.76746197184, 5051.0, 5061.493850614909, 5062.265971434195, 4901.58336541398, 4907.656464047483, 4919.253664948892, 4919.483454237254, 4920.901581968269], "value": 3781.1805098384166, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [571.4770984549137, 596.5525855608294, 601.2244204975582, 607.8298076538568, 659.6833519910443, 11039.503222354993, 11743.823842642345, 11796.999999999989, 11885.4057297135, 11892.881071189286, 11523.827142592867, 11785.646430607074, 11822.172447928648, 11896.167268291223, 11898.286102833836, 735.5292612727845, 748.6967778049899, 755.493819141174, 756.4855897989365, 756.8902509136173, 741.1735914455397, 743.0563184755357, 743.7768669399186, 744.0401881572765, 744.0773440933231, 791.9722809701661, 793.218679600593, 794.8608993426127, 795.3478147918709, 796.0924546017544, 778.996105019477, 779.3687113438104, 779.4543819326437, 779.6530543907963, 779.7777633374518, 575.7581815637442, 579.8898209340254, 580.4659713063949, 580.7589850212157, 580.8286555466148, 12462.12765106443, 12531.561395351118, 12587.433565489575, 12599.93700031503, 12606.0, 13401.66495837612, 13454.596362109152, 13504.594862154152, 13595.388207530685, 13757.518486852912, 10312.89687103127, 10431.843522347172, 10469.476526173738, 10515.05364517197, 10635.202359823044, 3201.439748044106, 3205.1987003249187, 3253.0240927721825, 3289.111939776271, 3359.496075588657, 65413.67293163504, 65435.0, 65522.12017738164, 65624.99999999952, 66529.33470665329, 9991.100800927952, 10237.43694096817, 10253.58985640581, 10359.274850760525, 10610.257281990187, 17798.46604601864, 18151.63696726058, 18267.817321826613, 18288.359907403177, 18656.440306790817, 6186.969065154645, 6326.114343991845, 6342.714577843916, 6415.294317625057, 6484.319146489551, 3553.964460355415, 3585.462180672868, 3620.2035552178477, 3639.6906262967946, 3669.43123815809, 2696.9865150674123, 2825.4349130174046, 2833.107571115092, 3107.875684972621, 3251.8048917065053, 541.228749032627, 542.5930552085936, 548.1777333999001, 551.7213807027425, 565.951894089007, 510.99233511497357, 517.8058228164439, 526.7734874004215, 530.6126527634848, 536.7557761218715, 7006.824829379204, 7061.187963384174, 7087.0, 7499.437542184249, 7990.280874721303, 522.5897670328774, 531.5189753273294, 534.671177226011, 540.3974568356255, 543.1391244876835, 3522.542069530996, 3601.549806274216, 3675.246574452231, 3677.6690097890782, 3734.402495600691, 96476.51761741287, 97945.5308170378, 104235.95764042414, 104764.47617762015, 104895.0, 48182.518174818506, 65138.67430662911, 78875.60562197152, 84321.0, 84814.0, 42419.0, 72213.63893180396, 73021.6348918252, 73097.63451182816, 75117.24882751211, 7892.6053697313755, 8395.790105247417, 8419.915800842158, 8456.577171141294, 8647.135286471303, 29482.262943426587, 37039.0, 43458.56541434545, 43512.34731478967, 44537.554624454635, 46588.53411465978, 57379.42620573908, 58763.70618146882, 59117.704411477665, 60266.39733602608, 10916.454177291262, 10981.780364392507, 11046.0, 11318.26431281964, 11698.94150529242, 12211.938940305241, 12342.0, 12369.257844529357, 12656.810147847606, 12731.108822382344, 11880.168388213087, 11951.282923024299, 11994.940025299818, 12185.51257949672, 12788.488460461478, 10862.402567858844, 10878.564857405616, 11128.332300062022, 11331.467373137395, 11521.930350646024, 11371.0, 11449.942750286194, 11830.822537662114, 12168.513259469522, 12790.744185116431, 8844.778880528038, 9392.624295028123, 9647.083527064917, 9840.0, 9955.352902061633, 10081.949590252001, 10130.696287195016, 10290.3825770454, 10358.378497290187, 10407.635732749317], "value": 6323.826435465329, "unit": "score"}], "name": "dromaeo_css", "value": 6192.924373585993, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 114.0, 114.0, 115.0, 114.0, 116.0, 114.0, 113.0, 115.0, 115.0], "value": 114.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 136.0, 126.0, 177.0, 129.0, 128.0, 127.0, 125.0, 160.0, 125.0], "value": 138.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 163.0, 162.0, 161.0, 163.0, 161.0, 161.0, 161.0, 161.0], "value": 161.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 77.0, 106.0, 76.0, 77.0, 77.0, 76.0, 106.0, 76.0], "value": 82.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 117.0, 83.0, 85.0, 84.0, 112.0, 84.0, 84.0, 120.0], "value": 93.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 118.0, 118.0, 117.0, 117.0, 118.0, 118.0, 118.0, 121.0], "value": 117.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 147.0, 147.0, 148.0, 147.0, 147.0, 146.0, 147.0, 148.0], "value": 147.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 94.0, 96.0, 95.0, 94.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 64.0, 64.0, 63.0, 64.0, 66.0, 66.0, 64.0, 66.0, 65.0], "value": 64.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 66.0, 66.0, 66.0, 66.0, 67.0, 67.0, 66.0, 66.0], "value": 66.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 82.0, 83.0, 83.0, 101.0, 83.0, 92.0, 83.0, 87.0], "value": 86.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 141.0, 151.0, 140.0, 141.0, 150.0, 140.0, 138.0, 179.0, 145.0], "value": 146.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [179.0, 181.0, 177.0, 176.0, 179.0, 178.0, 174.0, 177.0, 177.0, 176.0], "value": 177.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 72.0, 71.0, 70.0, 70.0, 71.0, 69.0, 72.0, 71.0, 70.0], "value": 70.9, "unit": "score"}], "name": "kraken", "value": 1561.7, "alertThreshold": 2.0}]} 04:14:07 INFO - Return code: 0 04:14:07 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:14:07 INFO - # TBPL SUCCESS # 04:14:07 INFO - Running post-action listener: _resource_record_post_action 04:14:07 INFO - [mozharness: 2016-10-06 11:14:07.647612Z] Finished run-tests step (success) 04:14:07 INFO - Running post-run listener: _resource_record_post_run 04:14:07 INFO - Total resource usage - Wall time: 1203s; CPU: 13.0%; Read bytes: 0; Write bytes: 397107200; Read time: 0; Write time: 262556 04:14:07 INFO - TinderboxPrint: CPU usage
13.0% 04:14:07 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 04:14:07 INFO - TinderboxPrint: I/O write bytes / time
397,107,200 / 262,556 04:14:07 INFO - TinderboxPrint: CPU idle
8,347.2 (87.0%) 04:14:07 INFO - TinderboxPrint: CPU user
1,202.8 (12.5%) 04:14:07 INFO - TinderboxPrint: Swap in / out
0 / 0 04:14:07 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 105615360; Read time: 0; Write time: 93732 04:14:07 INFO - run-tests - Wall time: 1187s; CPU: 13.0%; Read bytes: 0; Write bytes: 291491840; Read time: 0; Write time: 168824 04:14:08 INFO - Running post-run listener: _upload_blobber_files 04:14:08 INFO - Blob upload gear active. 04:14:08 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:14:08 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 04:14:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:14:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:14:08 INFO - (blobuploader) - INFO - Open directory for files ... 04:14:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:14:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:14:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:14:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:14:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:14:09 INFO - (blobuploader) - INFO - Done attempting. 04:14:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:14:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:14:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:14:13 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:14:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:14:13 INFO - (blobuploader) - INFO - Done attempting. 04:14:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:14:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:14:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:14:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:14:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:14:14 INFO - (blobuploader) - INFO - Done attempting. 04:14:14 INFO - (blobuploader) - INFO - Iteration through files over. 04:14:14 INFO - Return code: 0 04:14:14 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:14:14 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:14:14 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2f597cbab68e2de8f91553f4c31edea70c2fbc2f7b4cb0b5179cddf54a45e52e423e23afbe886578701c911d325f68cfce1c907fe9669d9bff81c545f1588333", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/588c415083f335b0ef6645f823c4fedc34a0b925edb076e26c89aadaf66ced563f685582aa220961b5ec21f1b383d342f1dd8c822ac6375147563e3444f3dd98", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/adabf1a8bc221f0a961ccc07ad01f20ec01f5401e40856508030c486a0ccbcd314f83ce8fd62112d88d253413142067acdffd3d252e84a277a77b24d74b4a67a"} 04:14:14 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:14:14 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:14:14 INFO - Contents: 04:14:14 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2f597cbab68e2de8f91553f4c31edea70c2fbc2f7b4cb0b5179cddf54a45e52e423e23afbe886578701c911d325f68cfce1c907fe9669d9bff81c545f1588333", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/588c415083f335b0ef6645f823c4fedc34a0b925edb076e26c89aadaf66ced563f685582aa220961b5ec21f1b383d342f1dd8c822ac6375147563e3444f3dd98", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/adabf1a8bc221f0a961ccc07ad01f20ec01f5401e40856508030c486a0ccbcd314f83ce8fd62112d88d253413142067acdffd3d252e84a277a77b24d74b4a67a"} 04:14:14 INFO - Running post-run listener: copy_logs_to_upload_dir 04:14:14 INFO - Copying logs to upload dir... 04:14:14 INFO - mkdir: /builds/slave/test/build/upload/logs 04:14:14 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.867364 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-10-06 04:14:14.160312) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-06 04:14:14.164068) ========= 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=00204705a9daa57ed339a427000001b9-1475751204.987020-1913817406 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-Non-PGO/sha512/2f597cbab68e2de8f91553f4c31edea70c2fbc2f7b4cb0b5179cddf54a45e52e423e23afbe886578701c911d325f68cfce1c907fe9669d9bff81c545f1588333", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/588c415083f335b0ef6645f823c4fedc34a0b925edb076e26c89aadaf66ced563f685582aa220961b5ec21f1b383d342f1dd8c822ac6375147563e3444f3dd98", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/adabf1a8bc221f0a961ccc07ad01f20ec01f5401e40856508030c486a0ccbcd314f83ce8fd62112d88d253413142067acdffd3d252e84a277a77b24d74b4a67a"} build_url:https://queue.taskcluster.net/v1/task/MYIqc5asTL6ees4tNlhFvA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011225 build_url: 'https://queue.taskcluster.net/v1/task/MYIqc5asTL6ees4tNlhFvA/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-Non-PGO/sha512/2f597cbab68e2de8f91553f4c31edea70c2fbc2f7b4cb0b5179cddf54a45e52e423e23afbe886578701c911d325f68cfce1c907fe9669d9bff81c545f1588333", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/588c415083f335b0ef6645f823c4fedc34a0b925edb076e26c89aadaf66ced563f685582aa220961b5ec21f1b383d342f1dd8c822ac6375147563e3444f3dd98", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/adabf1a8bc221f0a961ccc07ad01f20ec01f5401e40856508030c486a0ccbcd314f83ce8fd62112d88d253413142067acdffd3d252e84a277a77b24d74b4a67a"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-06 04:14:14.189140) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 04:14:14.189447) ========= 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=00204705a9daa57ed339a427000001b9-1475751204.987020-1913817406 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004490 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 04:14:14.272421) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-06 04:14:14.272741) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-06 04:14:14.273020) ========= ========= Total master_lag: 0.17 =========