builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-057 starttime: 1479900894.97 results: success (0) buildid: 20161123004021 builduid: 5638487f839f496b8402a9660530a86a revision: 5468cd9ed8e4a4cc32d37135842c04a7df8a58ee ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-23 03:34:54.970714) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-23 03:34:54.971149) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-23 03:34:54.971443) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-23 03:34:54.985710) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-23 03:34:54.985982) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1479900894.392157-1331946887 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-23 03:34:55-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 58.9K=0.2s 2016-11-23 03:34:55 (58.9 KB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.305117 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-23 03:34:55.304752) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-23 03:34:55.305065) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1479900894.392157-1331946887 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020111 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-23 03:34:55.353830) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-23 03:34:55.354155) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 5468cd9ed8e4a4cc32d37135842c04a7df8a58ee --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 5468cd9ed8e4a4cc32d37135842c04a7df8a58ee --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=934fc3100db09dcb9af4d4b6000001ab-1479900894.392157-1331946887 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-23 03:34:55,535 truncating revision to first 12 chars 2016-11-23 03:34:55,535 Setting DEBUG logging. 2016-11-23 03:34:55,535 attempt 1/10 2016-11-23 03:34:55,535 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/5468cd9ed8e4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-23 03:34:55,849 unpacking tar archive at: mozilla-aurora-5468cd9ed8e4/testing/mozharness/ program finished with exit code 0 elapsedTime=0.646983 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-23 03:34:56.014323) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-23 03:34:56.014656) ========= script_repo_revision: 5468cd9ed8e4a4cc32d37135842c04a7df8a58ee ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-23 03:34:56.015061) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-23 03:34:56.015349) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-23 03:34:56.024321) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-11-23 03:34:56.024617) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=934fc3100db09dcb9af4d4b6000001ab-1479900894.392157-1331946887 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:34:56 INFO - MultiFileLogger online at 20161123 03:34:56 in /builds/slave/test 03:34:56 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 03:34:56 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:34:56 INFO - {'append_to_log': False, 03:34:56 INFO - 'base_work_dir': '/builds/slave/test', 03:34:56 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:34:56 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:34:56 INFO - 'branch': 'Mozilla-Aurora', 03:34:56 INFO - 'buildbot_json_path': 'buildprops.json', 03:34:56 INFO - 'config_files': ('talos/linux_config.py',), 03:34:56 INFO - 'default_actions': ('clobber', 03:34:56 INFO - 'read-buildbot-config', 03:34:56 INFO - 'download-and-extract', 03:34:56 INFO - 'populate-webroot', 03:34:56 INFO - 'create-virtualenv', 03:34:56 INFO - 'install', 03:34:56 INFO - 'run-tests'), 03:34:56 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:34:56 INFO - 'download_minidump_stackwalk': True, 03:34:56 INFO - 'download_symbols': 'ondemand', 03:34:56 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:34:56 INFO - 'tooltool.py': '/tools/tooltool.py', 03:34:56 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:34:56 INFO - '/tools/misc-python/virtualenv.py')}, 03:34:56 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:34:56 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:34:56 INFO - 'installer_path': 'installer.exe', 03:34:56 INFO - 'log_level': 'info', 03:34:56 INFO - 'log_name': 'talos', 03:34:56 INFO - 'log_to_console': True, 03:34:56 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:34:56 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:34:56 INFO - 'opt_config_files': (), 03:34:56 INFO - 'pip_index': False, 03:34:56 INFO - 'sps_profile': False, 03:34:56 INFO - 'sps_profile_interval': 0, 03:34:56 INFO - 'suite': 'dromaeojs', 03:34:56 INFO - 'system_bits': '32', 03:34:56 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:34:56 INFO - 'title': 'talos-linux64-ix-057', 03:34:56 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:34:56 INFO - 'use_talos_json': True, 03:34:56 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:34:56 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:34:56 INFO - 'work_dir': 'build'} 03:34:56 INFO - [mozharness: 2016-11-23 11:34:56.307689Z] Running clobber step. 03:34:56 INFO - Running pre-action listener: _resource_record_pre_action 03:34:56 INFO - Running main action method: clobber 03:34:56 INFO - rmtree: /builds/slave/test/build 03:34:56 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:34:56 INFO - Running post-action listener: _resource_record_post_action 03:34:56 INFO - [mozharness: 2016-11-23 11:34:56.757951Z] Finished clobber step (success) 03:34:56 INFO - [mozharness: 2016-11-23 11:34:56.758049Z] Running read-buildbot-config step. 03:34:56 INFO - Running pre-action listener: _resource_record_pre_action 03:34:56 INFO - Running main action method: read_buildbot_config 03:34:56 INFO - Using buildbot properties: 03:34:56 INFO - { 03:34:56 INFO - "project": "", 03:34:56 INFO - "product": "firefox", 03:34:56 INFO - "script_repo_revision": "production", 03:34:56 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 03:34:56 INFO - "repository": "", 03:34:56 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 03:34:56 INFO - "buildid": "20161123004021", 03:34:56 INFO - "stage_platform": "linux64-pgo", 03:34:56 INFO - "basedir": "/builds/slave/test", 03:34:56 INFO - "nightly_build": "True", 03:34:56 INFO - "buildnumber": 636, 03:34:56 INFO - "slavename": "talos-linux64-ix-057", 03:34:56 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 03:34:56 INFO - "platform": "ubuntu64_hw", 03:34:56 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 03:34:56 INFO - "branch": "mozilla-aurora", 03:34:56 INFO - "repo_path": "releases/mozilla-aurora", 03:34:56 INFO - "revision": "5468cd9ed8e4a4cc32d37135842c04a7df8a58ee", 03:34:56 INFO - "pgo_build": "True", 03:34:56 INFO - "builduid": "5638487f839f496b8402a9660530a86a", 03:34:56 INFO - "slavebuilddir": "test" 03:34:56 INFO - } 03:34:56 INFO - Found installer url https://queue.taskcluster.net/v1/task/KpTvQbNwRb-Cf0eQ406vbw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2. 03:34:56 INFO - Running post-action listener: _resource_record_post_action 03:34:56 INFO - [mozharness: 2016-11-23 11:34:56.760522Z] Finished read-buildbot-config step (success) 03:34:56 INFO - [mozharness: 2016-11-23 11:34:56.760610Z] Running download-and-extract step. 03:34:56 INFO - Running pre-action listener: _resource_record_pre_action 03:34:56 INFO - Running main action method: download_and_extract 03:34:56 INFO - mkdir: /builds/slave/test/build/tests 03:34: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:34:56 INFO - trying https://queue.taskcluster.net/v1/task/KpTvQbNwRb-Cf0eQ406vbw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 03:34:56 INFO - Downloading https://queue.taskcluster.net/v1/task/KpTvQbNwRb-Cf0eQ406vbw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 03:34:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KpTvQbNwRb-Cf0eQ406vbw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 03:34:57 INFO - Downloaded 1361 bytes. 03:34:57 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 03:34:57 INFO - Using the following test package requirements: 03:34:57 INFO - {u'common': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 03:34:57 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 03:34:57 INFO - u'firefox-52.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 03:34:57 INFO - u'gtest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 03:34:57 INFO - u'firefox-52.0a2.en-US.linux-x86_64.gtest.tests.zip'], 03:34:57 INFO - u'jittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 03:34:57 INFO - u'jsshell-linux-x86_64.zip'], 03:34:57 INFO - u'mochitest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 03:34:57 INFO - u'firefox-52.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 03:34:57 INFO - u'mozbase': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 03:34:57 INFO - u'reftest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 03:34:57 INFO - u'firefox-52.0a2.en-US.linux-x86_64.reftest.tests.zip'], 03:34:57 INFO - u'talos': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 03:34:57 INFO - u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'], 03:34:57 INFO - u'web-platform': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 03:34:57 INFO - u'firefox-52.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 03:34:57 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 03:34:57 INFO - u'firefox-52.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 03:34:57 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:34:57 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/KpTvQbNwRb-Cf0eQ406vbw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 03:34:57 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KpTvQbNwRb-Cf0eQ406vbw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:34:57 INFO - Fetch https://queue.taskcluster.net/v1/task/KpTvQbNwRb-Cf0eQ406vbw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 03:34:57 INFO - Http code: 200 03:34:57 INFO - via: 1.1 9552af4ceb2e0dd55964a80d1e549fd5.cloudfront.net (CloudFront) 03:34:57 INFO - x-amz-cf-id: SnLmwGaIgA6tieg_LpDfJcehQJtqC2A04EpTHlvEg09GMJKi9-Ev4w== 03:34:57 INFO - x-amz-version-id: oUhnOlE6JF8Ve2A3q_W5s_7tlx40OrpX 03:34:58 INFO - Expected file size: 21949279 03:34:58 INFO - Obtained file size: 21949279 03:35:02 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 03:35:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/KpTvQbNwRb-Cf0eQ406vbw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 03:35:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KpTvQbNwRb-Cf0eQ406vbw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:35:02 INFO - Fetch https://queue.taskcluster.net/v1/task/KpTvQbNwRb-Cf0eQ406vbw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 03:35:02 INFO - Http code: 200 03:35:02 INFO - via: 1.1 20f1c35f343f4b271ae8dcacfd7ea0e9.cloudfront.net (CloudFront) 03:35:02 INFO - x-amz-cf-id: zDmsmZasPQRBU8ILDFbvmUBS7raNQwu0qGhN4R8_mFYsc2zHct5t-w== 03:35:02 INFO - x-amz-version-id: oUhnOlE6JF8Ve2A3q_W5s_7tlx40OrpX 03:35:02 INFO - Expected file size: 21949279 03:35:02 INFO - Obtained file size: 21949279 03:35:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/KpTvQbNwRb-Cf0eQ406vbw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip 03:35:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KpTvQbNwRb-Cf0eQ406vbw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 03:35:07 INFO - Fetch https://queue.taskcluster.net/v1/task/KpTvQbNwRb-Cf0eQ406vbw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip into memory 03:35:07 INFO - Http code: 200 03:35:07 INFO - via: 1.1 73fa5a1ee49cf827e596b502b5927eab.cloudfront.net (CloudFront) 03:35:07 INFO - x-amz-cf-id: F8fo0cEkEWGYPIHe9-n3XBCxfJG6D_BEmdOAkA6fQLe37OL1lBg0bQ== 03:35:07 INFO - x-amz-version-id: ZvPZ8l30FYFFyybsw5esVXgZImGLkwLt 03:35:08 INFO - Expected file size: 14409038 03:35:08 INFO - Obtained file size: 14409038 03:35:08 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:35:08 INFO - trying https://queue.taskcluster.net/v1/task/KpTvQbNwRb-Cf0eQ406vbw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 03:35:08 INFO - Downloading https://queue.taskcluster.net/v1/task/KpTvQbNwRb-Cf0eQ406vbw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 03:35:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KpTvQbNwRb-Cf0eQ406vbw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 03:35:09 INFO - Downloaded 63952982 bytes. 03:35:09 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/KpTvQbNwRb-Cf0eQ406vbw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 03:35:09 INFO - mkdir: /builds/slave/test/properties 03:35:09 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:35:09 INFO - Writing to file /builds/slave/test/properties/build_url 03:35:09 INFO - Contents: 03:35:09 INFO - build_url:https://queue.taskcluster.net/v1/task/KpTvQbNwRb-Cf0eQ406vbw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 03:35:10 INFO - Running post-action listener: _resource_record_post_action 03:35:10 INFO - Running post-action listener: set_extra_try_arguments 03:35:10 INFO - [mozharness: 2016-11-23 11:35:10.139925Z] Finished download-and-extract step (success) 03:35:10 INFO - [mozharness: 2016-11-23 11:35:10.140149Z] Running populate-webroot step. 03:35:10 INFO - Running pre-action listener: _resource_record_pre_action 03:35:10 INFO - Running main action method: populate_webroot 03:35:10 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:35:10 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:35:10 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:35:10 INFO - '--tppagecycles', 03:35:10 INFO - '7'], 03:35:10 INFO - 'tests': ['tsvgm']}}, 03:35:10 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:35:10 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:35:10 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:35:10 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:35:10 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:35:10 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:35:10 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:35:10 INFO - 'talos_options': ['--disable-e10s'], 03:35:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:35:10 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:35:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:35:10 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:35:10 INFO - 'talos_options': ['--disable-e10s'], 03:35:10 INFO - 'tests': ['damp', 'tps']}, 03:35:10 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:35:10 INFO - 'tests': ['damp', 'tps']}, 03:35:10 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:35:10 INFO - 'tests': ['dromaeo_dom']}, 03:35:10 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:35:10 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:35:10 INFO - 'tests': ['basic_compositor_video']}, 03:35:10 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:35:10 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:35:10 INFO - 'tests': ['a11yr', 03:35:10 INFO - 'ts_paint', 03:35:10 INFO - 'tpaint', 03:35:10 INFO - 'sessionrestore', 03:35:10 INFO - 'sessionrestore_no_auto_restore', 03:35:10 INFO - 'tabpaint']}, 03:35:10 INFO - 'other-e10s': {'tests': ['a11yr', 03:35:10 INFO - 'ts_paint', 03:35:10 INFO - 'tpaint', 03:35:10 INFO - 'sessionrestore', 03:35:10 INFO - 'sessionrestore_no_auto_restore', 03:35:10 INFO - 'tabpaint']}, 03:35:10 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:35:10 INFO - 'ts_paint', 03:35:10 INFO - 'tpaint', 03:35:10 INFO - 'sessionrestore', 03:35:10 INFO - 'sessionrestore_no_auto_restore', 03:35:10 INFO - 'tabpaint']}, 03:35:10 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:35:10 INFO - 'ts_paint', 03:35:10 INFO - 'tpaint', 03:35:10 INFO - 'sessionrestore', 03:35:10 INFO - 'sessionrestore_no_auto_restore', 03:35:10 INFO - 'tabpaint']}, 03:35:10 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:35:10 INFO - 'tests': ['a11yr', 03:35:10 INFO - 'ts_paint', 03:35:10 INFO - 'tpaint', 03:35:10 INFO - 'sessionrestore', 03:35:10 INFO - 'sessionrestore_no_auto_restore', 03:35:10 INFO - 'tabpaint']}, 03:35:10 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:35:10 INFO - 'tests': ['a11yr', 03:35:10 INFO - 'ts_paint', 03:35:10 INFO - 'tpaint', 03:35:10 INFO - 'sessionrestore', 03:35:10 INFO - 'sessionrestore_no_auto_restore', 03:35:10 INFO - 'tabpaint']}, 03:35:10 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:35:10 INFO - 'tests': ['tsvgx', 03:35:10 INFO - 'tsvgr_opacity', 03:35:10 INFO - 'tart', 03:35:10 INFO - 'tscrollx', 03:35:10 INFO - 'cart']}, 03:35:10 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:35:10 INFO - 'tsvgr_opacity', 03:35:10 INFO - 'tart', 03:35:10 INFO - 'tscrollx', 03:35:10 INFO - 'cart']}, 03:35:10 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:35:10 INFO - 'talos_options': ['--disable-e10s'], 03:35:10 INFO - 'tests': ['tp5o']}, 03:35:10 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:35:10 INFO - 'tests': ['tp5o']}, 03:35:10 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:35:10 INFO - 'talos_options': ['--disable-e10s', 03:35:10 INFO - '--xperf_path', 03:35:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:35:10 INFO - 'tests': ['tp5n']}, 03:35:10 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:35:10 INFO - 'talos_options': ['--xperf_path', 03:35:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:35:10 INFO - 'tests': ['tp5n']}}, 03:35:10 INFO - 'talos.zip': {'path': '', 03:35:10 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:35:10 INFO - Running post-action listener: _resource_record_post_action 03:35:10 INFO - [mozharness: 2016-11-23 11:35:10.161499Z] Finished populate-webroot step (success) 03:35:10 INFO - [mozharness: 2016-11-23 11:35:10.161586Z] Running create-virtualenv step. 03:35:10 INFO - Running pre-action listener: _resource_record_pre_action 03:35:10 INFO - Running main action method: create_virtualenv 03:35:10 INFO - Creating virtualenv /builds/slave/test/build/venv 03:35:10 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:35:10 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:35:10 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:35:10 INFO - Using real prefix '/usr' 03:35:10 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:35:10 INFO - Installing distribute.............................................................................................................................................................................................done. 03:35:12 INFO - Installing pip.................done. 03:35:12 INFO - Return code: 0 03:35:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:35:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:35:12 INFO - Reading from file tmpfile_stdout 03:35:12 INFO - Output received: 03:35:12 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:35:12 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:35:12 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:35:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:35:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:35:12 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:35:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:35:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:35:12 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 0x7f6c838bff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cd38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1da0ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d9df60>, '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 0x1d9ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d9f1d0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1479900894.392157-1331946887', '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:35:12 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:35:12 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:35:12 INFO - Using env: {'DISPLAY': ':0', 03:35:12 INFO - 'HOME': '/home/cltbld', 03:35:12 INFO - 'LANG': 'en_US.UTF-8', 03:35:12 INFO - 'LANGUAGE': 'en_US:en', 03:35:12 INFO - 'LOGNAME': 'cltbld', 03:35:12 INFO - 'MAIL': '/var/mail/cltbld', 03:35:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:35:12 INFO - 'MOZ_NO_REMOTE': '1', 03:35:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:35:12 INFO - 'NO_EM_RESTART': '1', 03:35:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:35:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:35:12 INFO - 'PWD': '/builds/slave/test', 03:35:12 INFO - 'SHELL': '/bin/bash', 03:35:12 INFO - 'SHLVL': '1', 03:35:12 INFO - 'TERM': 'linux', 03:35:12 INFO - 'TMOUT': '86400', 03:35:12 INFO - 'USER': 'cltbld', 03:35:12 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1479900894.392157-1331946887', 03:35:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:35:12 INFO - '_': '/tools/buildbot/bin/python'} 03:35:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:35:13 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:35:13 INFO - Cleaning up... 03:35:13 INFO - Return code: 0 03:35:13 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:35:13 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:35:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:35:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:35:13 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:35:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:35:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:35:13 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 0x7f6c838bff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cd38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1da0ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d9df60>, '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 0x1d9ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d9f1d0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1479900894.392157-1331946887', '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:35:13 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:35:13 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:35:13 INFO - Using env: {'DISPLAY': ':0', 03:35:13 INFO - 'HOME': '/home/cltbld', 03:35:13 INFO - 'LANG': 'en_US.UTF-8', 03:35:13 INFO - 'LANGUAGE': 'en_US:en', 03:35:13 INFO - 'LOGNAME': 'cltbld', 03:35:13 INFO - 'MAIL': '/var/mail/cltbld', 03:35:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:35:13 INFO - 'MOZ_NO_REMOTE': '1', 03:35:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:35:13 INFO - 'NO_EM_RESTART': '1', 03:35:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:35:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:35:13 INFO - 'PWD': '/builds/slave/test', 03:35:13 INFO - 'SHELL': '/bin/bash', 03:35:13 INFO - 'SHLVL': '1', 03:35:13 INFO - 'TERM': 'linux', 03:35:13 INFO - 'TMOUT': '86400', 03:35:13 INFO - 'USER': 'cltbld', 03:35:13 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1479900894.392157-1331946887', 03:35:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:35:13 INFO - '_': '/tools/buildbot/bin/python'} 03:35:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:35:13 INFO - Downloading/unpacking psutil>=3.1.1 03:35:13 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:35:13 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:35:13 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:35:13 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:35:13 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:35:13 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:35:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:35:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:35:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:35:15 INFO - Installing collected packages: psutil 03:35:15 INFO - Running setup.py install for psutil 03:35:15 INFO - building 'psutil._psutil_linux' extension 03:35:15 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:35:15 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:35:15 INFO - building 'psutil._psutil_posix' extension 03:35:15 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:35:15 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:35:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:35:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:35:15 INFO - Successfully installed psutil 03:35:15 INFO - Cleaning up... 03:35:15 INFO - Return code: 0 03:35:15 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:35:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:35:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:35:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:35:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:35:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:35:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:35:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6c838bff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cd38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1da0ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d9df60>, '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 0x1d9ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d9f1d0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1479900894.392157-1331946887', '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:35:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03:35:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 03:35:15 INFO - Using env: {'DISPLAY': ':0', 03:35:15 INFO - 'HOME': '/home/cltbld', 03:35:15 INFO - 'LANG': 'en_US.UTF-8', 03:35:15 INFO - 'LANGUAGE': 'en_US:en', 03:35:15 INFO - 'LOGNAME': 'cltbld', 03:35:15 INFO - 'MAIL': '/var/mail/cltbld', 03:35:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:35:15 INFO - 'MOZ_NO_REMOTE': '1', 03:35:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:35:15 INFO - 'NO_EM_RESTART': '1', 03:35:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:35:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:35:15 INFO - 'PWD': '/builds/slave/test', 03:35:15 INFO - 'SHELL': '/bin/bash', 03:35:15 INFO - 'SHLVL': '1', 03:35:15 INFO - 'TERM': 'linux', 03:35:15 INFO - 'TMOUT': '86400', 03:35:15 INFO - 'USER': 'cltbld', 03:35:15 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1479900894.392157-1331946887', 03:35:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:35:15 INFO - '_': '/tools/buildbot/bin/python'} 03:35:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:35:16 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:35:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:35:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:35:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:35:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:35:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:35:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:35:18 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:35:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:35:18 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:35:18 INFO - Installing collected packages: mozsystemmonitor 03:35:18 INFO - Running setup.py install for mozsystemmonitor 03:35:18 INFO - Successfully installed mozsystemmonitor 03:35:18 INFO - Cleaning up... 03:35:18 INFO - Return code: 0 03:35:18 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:35:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:35:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:35:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:35:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:35:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:35:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:35:18 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 0x7f6c838bff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cd38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1da0ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d9df60>, '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 0x1d9ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d9f1d0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1479900894.392157-1331946887', '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:35:18 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:35:18 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:35:18 INFO - Using env: {'DISPLAY': ':0', 03:35:18 INFO - 'HOME': '/home/cltbld', 03:35:18 INFO - 'LANG': 'en_US.UTF-8', 03:35:18 INFO - 'LANGUAGE': 'en_US:en', 03:35:18 INFO - 'LOGNAME': 'cltbld', 03:35:18 INFO - 'MAIL': '/var/mail/cltbld', 03:35:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:35:18 INFO - 'MOZ_NO_REMOTE': '1', 03:35:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:35:18 INFO - 'NO_EM_RESTART': '1', 03:35:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:35:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:35:18 INFO - 'PWD': '/builds/slave/test', 03:35:18 INFO - 'SHELL': '/bin/bash', 03:35:18 INFO - 'SHLVL': '1', 03:35:18 INFO - 'TERM': 'linux', 03:35:18 INFO - 'TMOUT': '86400', 03:35:18 INFO - 'USER': 'cltbld', 03:35:18 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1479900894.392157-1331946887', 03:35:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:35:18 INFO - '_': '/tools/buildbot/bin/python'} 03:35:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:35:18 INFO - Downloading/unpacking jsonschema==2.5.1 03:35:18 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:35:18 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:35:18 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:35:18 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:35:18 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:35:18 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:35:20 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:35:20 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:35:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:35:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:35:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:35:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:35:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:35:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:35:20 INFO - Downloading functools32-3.2.3-2.tar.gz 03:35:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:35:20 INFO - warning: no files found matching '*.txt' 03:35:20 INFO - no previously-included directories found matching 'build' 03:35:20 INFO - no previously-included directories found matching 'dist' 03:35:20 INFO - no previously-included directories found matching '.git*' 03:35:20 INFO - Installing collected packages: jsonschema, functools32 03:35:20 INFO - Running setup.py install for functools32 03:35:20 INFO - warning: no files found matching '*.txt' 03:35:20 INFO - no previously-included directories found matching 'build' 03:35:20 INFO - no previously-included directories found matching 'dist' 03:35:20 INFO - no previously-included directories found matching '.git*' 03:35:20 INFO - Successfully installed jsonschema functools32 03:35:20 INFO - Cleaning up... 03:35:20 INFO - Return code: 0 03:35:20 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:35: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:35:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:35:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:35: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:35:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:35:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:35:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f6c838bff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cd38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1da0ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d9df60>, '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 0x1d9ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d9f1d0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1479900894.392157-1331946887', '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:35:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 03:35:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 03:35:20 INFO - Using env: {'DISPLAY': ':0', 03:35:20 INFO - 'HOME': '/home/cltbld', 03:35:20 INFO - 'LANG': 'en_US.UTF-8', 03:35:20 INFO - 'LANGUAGE': 'en_US:en', 03:35:20 INFO - 'LOGNAME': 'cltbld', 03:35:20 INFO - 'MAIL': '/var/mail/cltbld', 03:35:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:35:20 INFO - 'MOZ_NO_REMOTE': '1', 03:35:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:35:20 INFO - 'NO_EM_RESTART': '1', 03:35:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:35:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:35:20 INFO - 'PWD': '/builds/slave/test', 03:35:20 INFO - 'SHELL': '/bin/bash', 03:35:20 INFO - 'SHLVL': '1', 03:35:20 INFO - 'TERM': 'linux', 03:35:20 INFO - 'TMOUT': '86400', 03:35:20 INFO - 'USER': 'cltbld', 03:35:20 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1479900894.392157-1331946887', 03:35:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:35:20 INFO - '_': '/tools/buildbot/bin/python'} 03:35:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:35:21 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:35:21 INFO - Cleaning up... 03:35:21 INFO - Return code: 0 03:35:21 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:35:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:35:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:35:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:35:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:35:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:35:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:35:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f6c838bff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cd38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1da0ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d9df60>, '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 0x1d9ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d9f1d0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1479900894.392157-1331946887', '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:35:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:35:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:35:21 INFO - Using env: {'DISPLAY': ':0', 03:35:21 INFO - 'HOME': '/home/cltbld', 03:35:21 INFO - 'LANG': 'en_US.UTF-8', 03:35:21 INFO - 'LANGUAGE': 'en_US:en', 03:35:21 INFO - 'LOGNAME': 'cltbld', 03:35:21 INFO - 'MAIL': '/var/mail/cltbld', 03:35:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:35:21 INFO - 'MOZ_NO_REMOTE': '1', 03:35:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:35:21 INFO - 'NO_EM_RESTART': '1', 03:35:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:35:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:35:21 INFO - 'PWD': '/builds/slave/test', 03:35:21 INFO - 'SHELL': '/bin/bash', 03:35:21 INFO - 'SHLVL': '1', 03:35:21 INFO - 'TERM': 'linux', 03:35:21 INFO - 'TMOUT': '86400', 03:35:21 INFO - 'USER': 'cltbld', 03:35:21 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1479900894.392157-1331946887', 03:35:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:35:21 INFO - '_': '/tools/buildbot/bin/python'} 03:35:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:35:21 INFO - Downloading/unpacking blobuploader==1.2.4 03:35:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:35:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:35:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:35:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:35:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:35:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:35:23 INFO - Downloading blobuploader-1.2.4.tar.gz 03:35:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:35:23 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:35:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:35:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:35:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:35:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:35:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:35:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:35:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:35:23 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:35:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:35:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:35:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:35:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:35:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:35:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:35:24 INFO - Downloading docopt-0.6.1.tar.gz 03:35:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:35:24 INFO - Installing collected packages: blobuploader, requests, docopt 03:35:24 INFO - Running setup.py install for blobuploader 03:35:24 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:35:24 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:35:24 INFO - Running setup.py install for requests 03:35:24 INFO - Running setup.py install for docopt 03:35:24 INFO - Successfully installed blobuploader requests docopt 03:35:24 INFO - Cleaning up... 03:35:24 INFO - Return code: 0 03:35:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:35:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:35:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:35:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:35:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:35:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:35:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:35:24 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 0x7f6c838bff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cd38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1da0ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d9df60>, '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 0x1d9ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d9f1d0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1479900894.392157-1331946887', '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:35:24 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:35:24 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:35:24 INFO - Using env: {'DISPLAY': ':0', 03:35:24 INFO - 'HOME': '/home/cltbld', 03:35:24 INFO - 'LANG': 'en_US.UTF-8', 03:35:24 INFO - 'LANGUAGE': 'en_US:en', 03:35:24 INFO - 'LOGNAME': 'cltbld', 03:35:24 INFO - 'MAIL': '/var/mail/cltbld', 03:35:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:35:24 INFO - 'MOZ_NO_REMOTE': '1', 03:35:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:35:24 INFO - 'NO_EM_RESTART': '1', 03:35:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:35:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:35:24 INFO - 'PWD': '/builds/slave/test', 03:35:24 INFO - 'SHELL': '/bin/bash', 03:35:24 INFO - 'SHLVL': '1', 03:35:24 INFO - 'TERM': 'linux', 03:35:24 INFO - 'TMOUT': '86400', 03:35:24 INFO - 'USER': 'cltbld', 03:35:24 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1479900894.392157-1331946887', 03:35:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:35:24 INFO - '_': '/tools/buildbot/bin/python'} 03:35:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:35:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:35:24 INFO - Running setup.py (path:/tmp/pip-v8LxKE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:35:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:35:25 INFO - Running setup.py (path:/tmp/pip-MHDxgA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:35:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:35:25 INFO - Running setup.py (path:/tmp/pip-eQthmd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:35:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:35:25 INFO - Running setup.py (path:/tmp/pip-4N__tL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:35:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:35:25 INFO - Running setup.py (path:/tmp/pip-UgeWUN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:35:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:35:25 INFO - Running setup.py (path:/tmp/pip-vauFIf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:35:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:35:25 INFO - Running setup.py (path:/tmp/pip-Kg4Uyp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:35:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:35:25 INFO - Running setup.py (path:/tmp/pip-NljLKL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:35:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:35:25 INFO - Running setup.py (path:/tmp/pip-gBkIdH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:35:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:35:25 INFO - Running setup.py (path:/tmp/pip-HLWHaI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:35:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:35:25 INFO - Running setup.py (path:/tmp/pip-hkjDJU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:35:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:35:25 INFO - Running setup.py (path:/tmp/pip-cVzgHJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:35:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:35:25 INFO - Running setup.py (path:/tmp/pip-W_E1s8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:35:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:35:25 INFO - Running setup.py (path:/tmp/pip-2WRBiT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:35:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:35:25 INFO - Running setup.py (path:/tmp/pip-7lv5Zk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:35:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:35:26 INFO - Running setup.py (path:/tmp/pip-3AeoLp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:35:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:35:26 INFO - Running setup.py (path:/tmp/pip-MTXUJK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:35:26 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:35:26 INFO - Running setup.py install for manifestparser 03:35:26 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:35:26 INFO - Running setup.py install for mozcrash 03:35:26 INFO - Running setup.py install for mozdebug 03:35:26 INFO - Running setup.py install for mozdevice 03:35:26 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:35:26 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:35:26 INFO - Running setup.py install for mozfile 03:35:26 INFO - Running setup.py install for mozhttpd 03:35:26 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:35:26 INFO - Running setup.py install for mozinfo 03:35:26 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:35:26 INFO - Running setup.py install for mozInstall 03:35:26 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:35:26 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:35:26 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:35:26 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:35:26 INFO - Running setup.py install for mozleak 03:35:27 INFO - Running setup.py install for mozlog 03:35:27 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:35:27 INFO - Running setup.py install for moznetwork 03:35:27 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:35:27 INFO - Running setup.py install for mozprocess 03:35:27 INFO - Running setup.py install for mozprofile 03:35:27 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:35:27 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:35:27 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:35:27 INFO - Running setup.py install for mozrunner 03:35:27 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:35:27 INFO - Running setup.py install for mozscreenshot 03:35:27 INFO - Running setup.py install for moztest 03:35:27 INFO - Running setup.py install for mozversion 03:35:27 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:35:27 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:35:27 INFO - Cleaning up... 03:35:27 INFO - Return code: 0 03:35:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:35: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:35:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:35:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:35: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:35:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:35:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:35:27 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 0x7f6c838bff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cd38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1da0ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d9df60>, '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 0x1d9ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d9f1d0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1479900894.392157-1331946887', '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:35:27 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:35:27 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:35:27 INFO - Using env: {'DISPLAY': ':0', 03:35:27 INFO - 'HOME': '/home/cltbld', 03:35:27 INFO - 'LANG': 'en_US.UTF-8', 03:35:27 INFO - 'LANGUAGE': 'en_US:en', 03:35:27 INFO - 'LOGNAME': 'cltbld', 03:35:27 INFO - 'MAIL': '/var/mail/cltbld', 03:35:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:35:27 INFO - 'MOZ_NO_REMOTE': '1', 03:35:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:35:27 INFO - 'NO_EM_RESTART': '1', 03:35:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:35:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:35:27 INFO - 'PWD': '/builds/slave/test', 03:35:27 INFO - 'SHELL': '/bin/bash', 03:35:27 INFO - 'SHLVL': '1', 03:35:27 INFO - 'TERM': 'linux', 03:35:27 INFO - 'TMOUT': '86400', 03:35:27 INFO - 'USER': 'cltbld', 03:35:27 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1479900894.392157-1331946887', 03:35:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:35:27 INFO - '_': '/tools/buildbot/bin/python'} 03:35:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:35:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:35:28 INFO - Running setup.py (path:/tmp/pip-mlfhJ9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:35:28 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:35:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:35:28 INFO - Running setup.py (path:/tmp/pip-XdAfy5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:35:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:35:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:35:28 INFO - Running setup.py (path:/tmp/pip-RhBxnY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:35:28 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:35:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:35:28 INFO - Running setup.py (path:/tmp/pip-rKLwJ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:35:28 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:35:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:35:28 INFO - Running setup.py (path:/tmp/pip-yh4kOb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:35:28 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:35:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:35:28 INFO - Running setup.py (path:/tmp/pip-4ygQMJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:35:28 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:35:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:35:28 INFO - Running setup.py (path:/tmp/pip-q4ro9L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:35:28 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:35:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:35:28 INFO - Running setup.py (path:/tmp/pip-WJ0MIR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:35:28 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:35:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:35:28 INFO - Running setup.py (path:/tmp/pip-AKSSgm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:35:28 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:35:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:35:28 INFO - Running setup.py (path:/tmp/pip-buBazZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:35:28 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:35:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:35:28 INFO - Running setup.py (path:/tmp/pip-z9iMwh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:35:28 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:35:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:35:28 INFO - Running setup.py (path:/tmp/pip-lPqfzv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:35:29 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:35:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:35:29 INFO - Running setup.py (path:/tmp/pip-y5dWPb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:35:29 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:35:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:35:29 INFO - Running setup.py (path:/tmp/pip-AN_pMp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:35:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 03:35:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:35:29 INFO - Running setup.py (path:/tmp/pip-FjRB11-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:35:29 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:35:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:35:29 INFO - Running setup.py (path:/tmp/pip-AL9k8_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:35:29 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:35:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:35:29 INFO - Running setup.py (path:/tmp/pip-emTCdZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:35:29 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:35:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:35:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:35:29 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:35:29 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:35:29 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:35:29 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:35:29 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:35:29 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:35:29 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:35:29 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:35:29 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:35:29 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:35:31 INFO - Downloading blessings-1.6.tar.gz 03:35:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:35:31 INFO - Installing collected packages: blessings 03:35:31 INFO - Running setup.py install for blessings 03:35:31 INFO - Successfully installed blessings 03:35:31 INFO - Cleaning up... 03:35:31 INFO - Return code: 0 03:35:31 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:35:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:35:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:35:31 INFO - Reading from file tmpfile_stdout 03:35:31 INFO - Current package versions: 03:35:31 INFO - argparse == 1.2.1 03:35:31 INFO - blessings == 1.6 03:35:31 INFO - blobuploader == 1.2.4 03:35:31 INFO - docopt == 0.6.1 03:35:31 INFO - functools32 == 3.2.3-2 03:35:31 INFO - jsonschema == 2.5.1 03:35:31 INFO - manifestparser == 1.1 03:35:31 INFO - mozInstall == 1.12 03:35:31 INFO - mozcrash == 1.0 03:35:31 INFO - mozdebug == 0.1 03:35:31 INFO - mozdevice == 0.48 03:35:31 INFO - mozfile == 1.2 03:35:31 INFO - mozhttpd == 0.7 03:35:31 INFO - mozinfo == 0.9 03:35:31 INFO - mozleak == 0.1 03:35:31 INFO - mozlog == 3.4 03:35:31 INFO - moznetwork == 0.27 03:35:31 INFO - mozprocess == 0.23 03:35:31 INFO - mozprofile == 0.28 03:35:31 INFO - mozrunner == 6.13 03:35:31 INFO - mozscreenshot == 0.1 03:35:31 INFO - mozsystemmonitor == 0.3 03:35:31 INFO - moztest == 0.7 03:35:31 INFO - mozversion == 1.4 03:35:31 INFO - psutil == 3.1.1 03:35:31 INFO - requests == 1.2.3 03:35:31 INFO - wsgiref == 0.1.2 03:35:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:35:31 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:35:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:35:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:35:31 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:35:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:35:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:35:31 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 0x7f6c838bff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cd38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1da0ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d9df60>, '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 0x1d9ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d9f1d0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1479900894.392157-1331946887', '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:35:31 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:35:31 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:35:31 INFO - Using env: {'DISPLAY': ':0', 03:35:31 INFO - 'HOME': '/home/cltbld', 03:35:31 INFO - 'LANG': 'en_US.UTF-8', 03:35:31 INFO - 'LANGUAGE': 'en_US:en', 03:35:31 INFO - 'LOGNAME': 'cltbld', 03:35:31 INFO - 'MAIL': '/var/mail/cltbld', 03:35:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:35:31 INFO - 'MOZ_NO_REMOTE': '1', 03:35:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:35:31 INFO - 'NO_EM_RESTART': '1', 03:35:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:35:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:35:31 INFO - 'PWD': '/builds/slave/test', 03:35:31 INFO - 'SHELL': '/bin/bash', 03:35:31 INFO - 'SHLVL': '1', 03:35:31 INFO - 'TERM': 'linux', 03:35:31 INFO - 'TMOUT': '86400', 03:35:31 INFO - 'USER': 'cltbld', 03:35:31 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1479900894.392157-1331946887', 03:35:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:35:31 INFO - '_': '/tools/buildbot/bin/python'} 03:35:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:35:32 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:35:32 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:35:32 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:35:32 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:35:32 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:35:32 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:35:32 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:35:32 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:35:32 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:35:32 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:35:32 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:35:32 INFO - Cleaning up... 03:35:32 INFO - Return code: 0 03:35:32 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:35:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:35:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:35:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:35:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:35:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:35:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:35:32 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 0x7f6c838bff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cd38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1da0ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d9df60>, '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 0x1d9ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d9f1d0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1479900894.392157-1331946887', '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:35:32 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:35:32 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:35:32 INFO - Using env: {'DISPLAY': ':0', 03:35:32 INFO - 'HOME': '/home/cltbld', 03:35:32 INFO - 'LANG': 'en_US.UTF-8', 03:35:32 INFO - 'LANGUAGE': 'en_US:en', 03:35:32 INFO - 'LOGNAME': 'cltbld', 03:35:32 INFO - 'MAIL': '/var/mail/cltbld', 03:35:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:35:32 INFO - 'MOZ_NO_REMOTE': '1', 03:35:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:35:32 INFO - 'NO_EM_RESTART': '1', 03:35:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:35:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:35:32 INFO - 'PWD': '/builds/slave/test', 03:35:32 INFO - 'SHELL': '/bin/bash', 03:35:32 INFO - 'SHLVL': '1', 03:35:32 INFO - 'TERM': 'linux', 03:35:32 INFO - 'TMOUT': '86400', 03:35:32 INFO - 'USER': 'cltbld', 03:35:32 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1479900894.392157-1331946887', 03:35:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:35:32 INFO - '_': '/tools/buildbot/bin/python'} 03:35:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:35:32 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:35:32 INFO - Cleaning up... 03:35:32 INFO - Return code: 0 03:35:32 INFO - Running post-action listener: _resource_record_post_action 03:35:32 INFO - Running post-action listener: _start_resource_monitoring 03:35:32 INFO - Starting resource monitoring. 03:35:32 INFO - [mozharness: 2016-11-23 11:35:32.305904Z] Finished create-virtualenv step (success) 03:35:32 INFO - [mozharness: 2016-11-23 11:35:32.306404Z] Running install step. 03:35:32 INFO - Running pre-action listener: _resource_record_pre_action 03:35:32 INFO - Running main action method: install 03:35:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:35:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:35:32 INFO - Reading from file tmpfile_stdout 03:35:32 INFO - Detecting whether we're running mozinstall >=1.0... 03:35:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:35:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:35:32 INFO - Reading from file tmpfile_stdout 03:35:32 INFO - Output received: 03:35:32 INFO - Usage: mozinstall [options] installer 03:35:32 INFO - Options: 03:35:32 INFO - -h, --help show this help message and exit 03:35:32 INFO - -d DEST, --destination=DEST 03:35:32 INFO - Directory to install application into. [default: 03:35:32 INFO - "/builds/slave/test"] 03:35:32 INFO - --app=APP Application being installed. [default: firefox] 03:35:32 INFO - mkdir: /builds/slave/test/build/application 03:35:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 03:35:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 03:35:48 INFO - Reading from file tmpfile_stdout 03:35:48 INFO - Output received: 03:35:48 INFO - /builds/slave/test/build/application/firefox/firefox 03:35:48 INFO - Running post-action listener: _resource_record_post_action 03:35:48 INFO - [mozharness: 2016-11-23 11:35:48.510063Z] Finished install step (success) 03:35:48 INFO - [mozharness: 2016-11-23 11:35:48.510303Z] Running run-tests step. 03:35:48 INFO - Running pre-action listener: _resource_record_pre_action 03:35:48 INFO - Running main action method: run_tests 03:35:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:35:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:35:48 INFO - Python 2.7.3 03:35:48 INFO - Return code: 0 03:35:48 INFO - grabbing minidump binary from tooltool 03:35:48 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:35:48 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 0x1d9df60>, '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 0x1d9ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d9f1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:35:48 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:35:48 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:35:48 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:35:48 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:35:48 INFO - Return code: 0 03:35:48 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:35:48 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:35:48 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:35:48 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:35:48 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:35:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/KpTvQbNwRb-Cf0eQ406vbw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-057', '--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:35:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/KpTvQbNwRb-Cf0eQ406vbw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-057 --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:35:48 INFO - Using env: {'DISPLAY': ':0', 03:35:48 INFO - 'HOME': '/home/cltbld', 03:35:48 INFO - 'LANG': 'en_US.UTF-8', 03:35:48 INFO - 'LANGUAGE': 'en_US:en', 03:35:48 INFO - 'LOGNAME': 'cltbld', 03:35:48 INFO - 'MAIL': '/var/mail/cltbld', 03:35:48 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:35:48 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:35:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:35:48 INFO - 'MOZ_NO_REMOTE': '1', 03:35:48 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:35:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:35:48 INFO - 'NO_EM_RESTART': '1', 03:35:48 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:35:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:35:48 INFO - 'PWD': '/builds/slave/test', 03:35:48 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:35:48 INFO - 'SHELL': '/bin/bash', 03:35:48 INFO - 'SHLVL': '1', 03:35:48 INFO - 'TERM': 'linux', 03:35:48 INFO - 'TMOUT': '86400', 03:35:48 INFO - 'USER': 'cltbld', 03:35:48 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1479900894.392157-1331946887', 03:35:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:35:48 INFO - '_': '/tools/buildbot/bin/python'} 03:35:48 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/KpTvQbNwRb-Cf0eQ406vbw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-057', '--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:35:48 INFO - mozversion application_buildid: 20161123004021 03:35:48 INFO - mozversion application_changeset: 5468cd9ed8e4a4cc32d37135842c04a7df8a58ee 03:35:48 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:35:48 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:35:48 INFO - mozversion application_name: Firefox 03:35:48 INFO - mozversion application_remotingname: firefox-dev 03:35:48 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:35:48 INFO - mozversion application_vendor: Mozilla 03:35:48 INFO - mozversion application_version: 52.0a2 03:35:48 INFO - mozversion platform_buildid: 20161123004021 03:35:48 INFO - mozversion platform_changeset: 5468cd9ed8e4a4cc32d37135842c04a7df8a58ee 03:35:48 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:35:48 INFO - mozversion platform_version: 52.0a2 03:35:48 INFO - using testdate: 1479900948 03:35:48 INFO - actual date: 1479900948 03:35:48 INFO - starting webserver on 'localhost:47141' 03:35:48 INFO - SUITE-START | Running 2 tests 03:35:48 INFO - TEST-START | dromaeo_css 03:35:48 INFO - operating with platform_type : linux_ 03:35:48 INFO - Initialising browser for dromaeo_css test... 03:35:48 INFO - TEST-INFO | started process 12661 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuAlSCc/profile http://localhost:47141/getInfo.html) 03:35:51 ERROR - PROCESS | 12661 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 5373: TypeError: parent.firstChild is null 03:35:53 INFO - PROCESS | 12661 | __metrics Screen width/height:1600/1200 03:35:53 INFO - PROCESS | 12661 | colorDepth:24 03:35:53 INFO - PROCESS | 12661 | Browser inner width/height: 1024/697 03:35:53 INFO - PROCESS | 12661 | __metrics 03:35:53 INFO - PROCESS | 12661 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 03:35:53 INFO - PROCESS | 12661 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:35:54 INFO - PROCESS | 12661 | console.error: PushService: 03:35:54 INFO - PROCESS | 12661 | stateChangeProcessEnqueue: Error transitioning state 03:35:54 INFO - PROCESS | 12661 | UnknownError 03:35:54 INFO - TEST-INFO | 12661: exit 0 03:35:54 INFO - Browser initialized. 03:35:54 INFO - Running cycle 1/1 for dromaeo_css test... 03:35:54 INFO - TEST-INFO | started process 12753 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuAlSCc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:36:06 INFO - PROCESS | 12753 | RSS: Main: 144572416 03:36:06 INFO - PROCESS | 12753 | 03:36:57 INFO - PROCESS | 12753 | 1479901017949 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:39:07 INFO - PROCESS | 12753 | Cycle 1(1): loaded http://localhost:47141/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47141/tests/dromaeo/cssquery-ext.html) 03:39:09 INFO - PROCESS | 12753 | RSS: Main: 313253888 03:39:09 INFO - PROCESS | 12753 | 03:42:12 INFO - PROCESS | 12753 | Cycle 1(1): loaded http://localhost:47141/tests/dromaeo/cssquery-ext.html (next: http://localhost:47141/tests/dromaeo/cssquery-jquery.html) 03:42:12 INFO - PROCESS | 12753 | RSS: Main: 237879296 03:42:12 INFO - PROCESS | 12753 | 03:45:14 INFO - PROCESS | 12753 | Cycle 1(1): loaded http://localhost:47141/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47141/tests/dromaeo/cssquery-mootools.html) 03:45:15 INFO - PROCESS | 12753 | RSS: Main: 214122496 03:45:15 INFO - PROCESS | 12753 | 03:48:17 INFO - PROCESS | 12753 | Cycle 1(1): loaded http://localhost:47141/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47141/tests/dromaeo/cssquery-prototype.html) 03:48:17 INFO - PROCESS | 12753 | RSS: Main: 216084480 03:48:17 INFO - PROCESS | 12753 | 03:51:20 INFO - PROCESS | 12753 | Cycle 1(1): loaded http://localhost:47141/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47141/tests/dromaeo/cssquery-yui.html) 03:51:21 INFO - PROCESS | 12753 | RSS: Main: 176553984 03:51:21 INFO - PROCESS | 12753 | 03:54:23 INFO - PROCESS | 12753 | Cycle 1(1): loaded http://localhost:47141/tests/dromaeo/cssquery-yui.html (next: http://localhost:47141/tests/dromaeo/cssquery-dojo.html) 03:54:23 INFO - PROCESS | 12753 | RSS: Main: 266719232 03:54:23 INFO - PROCESS | 12753 | 03:54:23 INFO - PROCESS | 12753 | __start_tp_report 03:54:23 INFO - PROCESS | 12753 | _x_x_mozilla_page_load 03:54:23 INFO - PROCESS | 12753 | _x_x_mozilla_page_load_details 03:54:23 INFO - PROCESS | 12753 | |i|pagename|runs| 03:54:23 INFO - PROCESS | 12753 | |0;dojo.html;3236.2880166363398;3276.279218571913;3282.983585082076;3301.620313663929;3326.301476689895;5585.804496842611;5675.829725108243;5679.403662615423;5685.943140568604;5687.118496633018;5613.859653508664;5676.772929082842;5681.176229446728;5688;5717.342505611856;5098.949010509903;5101.515356041179;5108.923366149492;5130.948690513103;5182.974085129569;5017.899642007158;5046.965372098729;5047.47001564836;5201.271821944931;5217.426083130853;5045.117104506697;5167.147420675584;5168.715720635363;5174.327337446127;5180.067587834188;5157.200633901752;5166.483351664841;5192.532672059514;5197.922031169535;5233.293505376763;4973.701577905301;4990.426100998396;5097.617678674077;5107.412647545542;5167.4057483389515;5504.669719816824;5510.779568817243;5519.089350257203;5543.861403464905;5563.527100196488;5964.552658550626;5987.43119403656;6010.429009244159;6067.150598916155;6073.908891366633;6111.2666480022235;6128.050152226412;6130.938690613081;6134.141220229171;6134.570580059398;5529.142982837667;5538.501534861882;5544.861378465571;5553.611247212697;5611.803586874481;6070.575059745775;6083.6349819011;6086.056661217518;6089.695515224221;6092.7562897484495;5840.2991641003355;5845.941540584539;5846.181534585162;5851.795187168429;5860.619059761102;5837.357890632027;5941.197938278364;5963.0459126539545;6016.2479690038745;6017.458428741435;6040.395960404012;6044.848878778066;6049.153118563405;6053.152558641794;6074.848128796815;6003.849903752441;6006.039033754666;6009.639421634716;6010.579259451796;6036.698165091816;4540.77296135192;4573.519780423074;4581.198290299251;4606.286025666027;4650.604698600657;4173.227952828736;4197.769122698281;4202.936955945664;4205.873823785291;4213.346931225665;5811.070228763462;5820.185174075633;5826.242588463472;5831.533477321804;5831.883362332815;5942.82171534846;5943.732532035982;6014.548908831855;6067.211262535842;6146.846328841725;5722.885542289214;5796.913046304308;5817.214676018768;5818.156367326714;5825.24271844666;5252.763625636855;5279.313689220454;5286.36563612369;5286.841394758163;5294.338207724035;6077.6961151943115;6148.631082135086;6356;6364.618122912732;6370;5988.490978266722;6044.637321760709;6047.546434017554;6113.902014424272;6131.988406491147;6289;6290.622562646073;6291.528135389955;6299.622022678654;6338.619682818861;5915.053591425523;5975.671338076448;5984.820455386345;5991.161237426851;6024.397560244116;5804.738786754522;5843.094320380348;5859.619124756877;5925.970370148121;5927.8221653350465;5746.023176060164;5782.653040817564;5788.479036886701;5789.2184555086205;5792.797252096157;5790.7973220937065;5795.072788353843;5796.101604251347;5797.159411885337;5799.594028417971;5785.479306862234;5789.652620842763;5794.855128621818;5818.836232753381;5837.0368889132815;5977.671228082323;5983.970080149571;5990.041593345044;6005.819825405245;6014.6391216527145;5679.091345384719;5802.303723553032;5833.270841144857;5836.358000619844;5837.591368604327 03:54:23 INFO - PROCESS | 12753 | |1;ext.html;558.3104865491118;617.4936552027337;640.8397900524869;663.2306524431657;676.5027704637093;34014.48978265328;43584.782076089614;45073.7746311268;45087;45103.32345014827;45983.080338393214;46418;46476.53523464764;46513.534864651345;46657.766711166485;8125.146859579748;8724.781880452992;8862.202401783838;8866.733997980038;8873.911260887406;8173.918260817375;10333.483325833717;10604.575816967312;10625;10926.071283940875;10763.78472430551;10809.729756756065;10816.78366432671;10823.350598964047;10827.07969822566;10638.148948084136;10686.839697404544;10694.251402401835;10699.946500267526;10713.357198568072;10599.576016959312;10654.307470014503;10680.412577308245;10698.411587362692;10702.197335199891;42565.787171063945;42646.57353426457;42994.14011719779;43060;43062;3365.831708414594;3422.058933793227;3422.6577342265823;3442.122258824009;3465.3935561276676;32056.6794332056;32269.35461290761;32729;32802.6719732802;34533.48199777005;4401.6478681705385;4536.183486972343;4564.5435456454425;4648.163330600491;4733.0533893221145;337219;337355;339003;339323.5169120767;340230.29884850665;37336.25327493435;39114;39200;63658.363416365246;64294.35705642884;41329;41524.79237603793;41532.58467415287;41579.376309355386;41622.79188604037;16456.83543164577;16585.91707041457;16663.16684165787;16743.246553905105;16860.32558697663;12826.67933301675;13139.54011609589;13610;13922.582322530341;14060.08609440383;9340.392874463138;9571.808563828685;9575.760605984768;9648.614055437703;9655.806883862284;3355;3432;3433.5879694436826;3439.6904278615043;3492.109512074405;937.8968313485648;1034.8395998620226;1080.206048554312;1100.6863044032573;1117.5920788912151;33516.83241583825;33740.48167832453;34039.829800850835;34043.14892127667;34283;1125.3641692443744;1137.3119262846024;1152.6887740310237;1199.924695064559;1200.6458094862037;17067.231974561175;17904.55238619019;17934.282628694706;17955;17982.820171798376;539392;617223;629911;633752;872506;61332.69333653303;61544.38455615386;62099.6895015522;62143.6892815533;62177.68911155415;1218.439517821812;1346.347021694497;1349.426493740176;1373.6359864635879;1419.425132821209;27350.452990939673;33054.834725826215;33960.43705918444;36530.8173459131;36860.447093294155;58512.4148758507;59206;59267;59323;59344;478729;479826;482376;485036;485666;26996.1901142966;28327.29181770472;29227.269318267212;31097.68902310948;31510;43074.569254307055;46937.76531117323;47226;47647.5235247657;47976.7601161992;39453.802730986165;39623.40564891471;40312.79843600763;40572.39141412822;41338.58661413468;35754.463683044254;35869.1032724184;36733.26533469369;36843.07892302714;40879.59120408758;42580;43114.353284700126;43415.13169736524;44055;44109.77945110254;32566.674333257313;34414.311713765084;34473.310533789685;34957.47563786596;34989;28112.859435702692;28607;28694;28886.711132888402;29057.273568160967 03:54:23 INFO - PROCESS | 12753 | |2;jquery.html;438.2768432087056;438.5176306063333;444.1450208348928;447.6195234051056;457.20902838090126;18459.446216613505;19602.803971960257;20115.396538103843;20268.493287667814;20458.18167273311;17824.554386140353;19162.179592938683;19239.519012024706;19543;19546.41360759176;5660.99999999999;5965;5965.015772397549;5969.940300596982;5971.193888824996;5706.629069110494;5864.091065884773;5981.282246130449;5981.671008094553;6004.129401236818;6037.124616930542;6040.456358927696;6043.909341359883;6045.7883974060915;6060.696965151725;5878.235829342179;5997.310309314419;6067.211262535886;6071.210742603455;6072.149899014142;5091.363579552556;5889.85275368115;5890.734916928748;5894.911576326359;5896.911546326808;14293;14615.853841461661;14721.779173312409;14764.557063288119;14766.187859667714;2194.8353873459555;2222.111155537798;2255.391044417998;2259.5029093599383;2289.072925465189;10221.693349199535;10428.687139385755;10505.579776808918;10687.679369618923;10746.623868164577;1850.611371611963;1924.201456395594;1955.0908827395328;2007.518195633052;2034.410021093881;84278;85765;85978;88095;88783;11754.941225293818;11862.703432414086;11884.940575297069;11891.405429728478;12010.519579216734;16995.575110622085;17023;17030.57423564396;17046.403375881786;17069.65860682804;8688.869666955;8918.821623567492;8965.462072275554;9113.088691130833;9175.265978721687;8600.483970961763;8603.096674849176;8700.825983480296;8859.64561417536;8875.600597973107;4577;4741.075490279362;4903.632227582945;5126.820561280338;5226.503482169188;1849.306510058728;1956.814102660245;1995.600879824012;2047.273218007586;2051.5281485258474;881.8897637795276;971.7862070344513;974.1914211204684;1007.3603261928728;1055.2402270365324;19318.71021934672;19498.220071196993;19781.60436791285;19827.801721982883;20068.09693563764;912.4114945859883;968.9951550242204;992.7369247149511;1010.5351538292468;1013.8580598716186;9095.408798428214;10900.563977440972;11009.2843965142;11113.722156946142;11208.215424920178;465072;470873;472212;476482;476995;57953.4204657948;58070.7096464515;72137.63931180416;78302;83008.58495707603;984.2224642532462;1056.5668076088766;1056.6671498477954;1063.5586231713753;1065.041462683591;17574.912125439292;18047.5488112793;18054.36809711706;18065;18505.72241416353;41940.580594194886;41958;42143.57856421519;42389.36415953701;42954.140917180855;50737.23894141665;54617.1807422881;57882.421175787706;58276.4172358271;59747.40252597418;8140.75577732669;8174.019117705913;8340.266948329187;8426.15738426177;8807.559622019002;9675.03249675027;13267.336633168496;13381.53164639233;13434.731305373642;14049.719005620034;11898.881011189776;12019.158658894143;12040.638780836589;12083.818742719042;12087.214331068453;11672.591459298883;11910.404479776149;11945.283283003047;12282.385880706108;12374.13381063317;12208.206466579644;12353.197042192229;12440.564580239648;12445.315507647167;12587.24476531411;8106.432549721463;8181.550014749246;8327.500349978778;8499.192576705203;8534.359923005675;9384.95307523458;11484;11730.237534560227;12039.819402708792;12545.247285162919 03:54:23 INFO - PROCESS | 12753 | |3;mootools.html;1455.7306898223828;1495.3569964915087;1645.6626391589725;1742.2072956804654;1828.2686925229907;8451.830963380737;8998.145176208267;9000.144986226314;9015.098490150982;9019.729408117759;7584.810379740509;7771.533707977525;8426.410151289412;8650.437721548094;8895.33285003624;2453.141400509821;2485.1674688979215;2486.428121532049;2489.3900994256433;2497.163450244161;2436.9512609747794;2456.054419048661;2483.3046746910804;2494.1270555305678;2495.0643508684243;2298.161171172518;2319.2810228829035;2319.9188028419007;2344.765523447659;2351.600227961242;2423.3699238198105;2429;2435.281591930385;2438.51229754049;2456.5823809952353;2407.8073754099805;2416.5287768885073;2443.376938880574;2444.4133407982135;2446.107170882633;8791.868121978176;8855.424397414212;8858.911410885938;8904.8664270036;8962.103789620985;5296.708681022542;5389.487998640123;5434.049041417736;5437.34751829783;5438.102713052342;3547.609762926076;3628.582712987987;3639.781613103196;3649.598544160167;3712.3317802795486;1149.4540093455626;1159.7622487390065;1184.5557915781583;1235.9629211123681;1238.7708273969254;12405.813912791225;12435.067369947199;12443.315617641027;12480.687982800411;12492.75014499705;4712.5994290485005;4858.198397264482;4866.148424025781;4938.913439043405;4987.900241995212;10320.793584128276;10328.948355258175;10335.06984371395;10339.276250662531;10342.741431464274;5469.753861076261;5471.644343117685;5472.7263636818;5476.096444086761;5479.232907392969;4454.888627784331;4578.587927086512;4931.013797240495;4974.850754477371;5019.222020586815;4014.2573623879675;4072.717094115344;4149.087200815816;4149.398337241083;4165.625093741578;1378.400395827818;1379.3034517568565;1387.4450219911914;1393.393873664959;1400.8459069502346;717.3973861955877;822.8642274024719;824.9628766705392;826.3926014379426;839.3578912132224;5781.161731548902;5974.701264936736;5982.282126144891;6066.211392519032;6078.1186727924205;448;449.8672891497016;450.8309383981007;451.58905396089403;471.48137049245554;3829.8659546915724;3947.526296844397;3973.1259122992897;3986.740861843971;4030;10283.897161028444;10469;10629.46852657364;10727.356358618508;10975.670729878117;10891.83662245067;10949.671509854717;10954.452277386099;10966.122710183166;10968.067714244378;8206.138355472709;8549;8559.315254779603;8559.572021398904;8574.571271436404;5896.086106653475;6039.365866583946;6086.543509236913;6097.176881120992;6133.50931925436;9917.851232231378;10056.396616203052;10084.193264538966;10130.08829205375;10171.135453486537;10315.948420257851;10431.426271555138;10498.527566259383;10516.789664206826;10527.420991845522;7257.129144502694;7264.963675181802;7416.44376671741;8003.639836207268;8127.2279133482225;8556.27271681914;8765.474071555727;8868.02451730322;8881.245094167069;8895.866562001705;7466.178720340867;7680.615969201629;7775.883361749465;7892.802679933047;8010.719624813337;7565.2812982766545;7612.505187162817;7703.26818952221;7716.7684969451;7833.843323133391;6829.795106146824;6848.14398200225;6944.097267355211;6949.478789090737;6979.4765392594745;5038.647294689483;5144.562712169508;5172.767225474938;5222.060029194781;5222.582193424593;5202.947970520247;5223.2948551945;5258.97370513145;5340.118880384693;5345.01117293302 03:54:23 INFO - PROCESS | 12753 | |4;prototype.html;351.379814627183;351.4903390084377;359.4303029697929;363.7617360628789;367.2214904402667;5530.364008139065;5535.972320138404;5552.500274975251;5591.30108736408;5606.327240731108;5223.843284701456;5307.0015441275655;5343.332083489564;5409.26974858394;5469.453054694539;4330.956690433087;4331.7400955942585;4344.218040752663;4351.260285751414;4358.65130789536;4329.913401731964;4340.56594340565;4359.978200109011;4362.476502819666;4363.214621368168;4172.2698527757675;4256.680429066999;4269.87190384289;4299.118680670455;4320.4599425071865;4268.807903644343;4272.33778764292;4272.5473339064865;4283.700140990132;4292.656587472995;3803.5055442792536;3804.4483549885113;3814.8474061037527;3815.751976121543;3830.7126965477423;5233.293505376763;5330.92003619946;5358.33020872391;5403.378611459654;5461.42655021221;4870.172070747946;4887.022595480882;4903.730294833783;4918.458969513351;4939.876503087452;5657.2928383952;5718.399568045337;5727.799527016535;5731.363572756537;5754.1944127822135;4053.4527838741687;4130.297849365615;4157.293260145782;4168.6039826216465;4189.539150693421;5911.497522710575;5929.8814023719715;5943.791967281124;5948.672822994734;5964.747403045409;4250.277452833026;4263.891388239018;4289.592488713567;4294.162638285567;4295.699301048959;4236.724612900213;4242.324281908629;4282.828686852553;4314.784260786948;4342.174986752507;4805.951940480551;4825.975870120697;4834.178189707758;4845.442774081026;4850.490698476679;5708.429157084342;5752.02215623345;5756.856078597984;5761.567882408836;5771.68255745938;1368.7330970460864;1396.3297617143828;1418.2554159066572;1429.00684024604;1432.7206194792125;934.6868798952291;979.4612962870393;1002.178213864624;1009.2329829329763;1013.5236438873718;5415.510734547952;5476.479734425223;5495.258140151029;5512.228288039678;5526.171074338801;5542.974549708317;5728.169415434739;5740.052891272977;5786.495511167127;5786.652800831964;5403.324584426947;5424.294841670558;5454.618176727591;5456.61803673747;5521;3015.653199881998;3055.114016935064;3064.2492589315316;3068.2789544457037;3073.4775088235056;5836.212111364996;5915.319738230072;5953.576693401225;6192.845178870474;6234.096056071935;6100.48145907594;6116.908246376308;6119.296280927751;6120.326764055951;6133.570650054543;5909.349971503045;6230.850356626956;6258.249010118815;6278.46633036197;6289.496840252768;5886.735096920564;5930.347661757117;6004.309504406874;6007.519398448201;6007.90988135187;5908.675022873783;5942.286925568959;5945.346011938596;5980.312264089512;5982.401759824157;5990.7304171311525;6215.886598556513;6268.404501572343;6274.278457977391;6293.255512969776;4339.956600434081;4351.695381323277;4356.869293921188;4367.039251364822;4379.321205213197;5732.8182858512255;6013.579049466495;6057.727402266997;6066.757329706938;6077.2099627049965;5796.94203057964;5814.418558144152;5825.3883342248455;5826.621269617631;5839.7372118255635;5774.797882074107;5794.69619335663;5795.189333173324;5814.970925145347;5841.620294680833;5444.945550544444;5503.944960550503;5762.683052432157;5784.334801497882;5813.128030795415;5781.8554536136935;5820.592558520862;5829.883402331845;5844.386339434298;5845.561582881216;5581.972090139523;5689.715514224355;5697.772089116389;5712.742926568231;5732.57005724564 03:54:23 INFO - PROCESS | 12753 | |5;yui.html;703.0614130136267;757.2957149850637;763.9923600763991;769.7036640893255;823.1480417767611;13847.446102155915;14639.487617933375;14826;14864.33110510027;14868.702625947475;13292.468301267938;13513.527026554073;14789.40842366304;15786.763198552031;15844.445444409448;825.0923983618018;840.7183593496155;845.1717317029315;845.7166849105557;846.5640195299426;843.7426584891606;844.9619767110495;846.4075147396816;846.5894041389921;847.3856454070811;888.7244954064229;889.6485888074207;890.6660002499062;891.545311890937;891.9197272245497;887.2591386192537;887.4320434921623;887.4941283468426;888.1961824548762;890.496869268861;650.6584043377218;651.062470043141;651.1047309948821;651.2933467188107;651.5829868883918;14993.17537535435;14994.325255363427;15030.924845375812;15040.473583424528;15068.321925513379;14494.275286235646;14698.779518307234;14926.552203433914;14931.701365972729;15002.624934376729;11334.603288884931;11451;11545.538178472934;11569.595064172714;11881.168318217728;3740.083679498513;3751;3764.3224219640456;3810.428435734662;3865.768053916774;54257.45742542603;56035;56838.43161568414;64367.67816160889;65712.671436643;10764.192685548614;10782.67651970442;10886.510107045202;11090.279131856403;12114.81827772584;17643.20605572752;17772.9336239826;19334.709979350322;20714.48213794667;21003.78996210049;8108.75673729789;8154.143814899468;8202.425830191829;8472.19514146155;8518.23335899772;4486.663500237495;4525.570070843265;4558.452985641744;4649.023705021916;4698.859034228979;3314.502824576333;3366.562346894937;3376.4260075787174;3416.145963509123;3856.8650097246464;679.9558028728117;688.4458011300851;690.8963655451722;700.8002719224996;701.421327404893;669.3808227389645;699.8880179171308;720.2653293640458;734.6436978065634;755.8110472381904;9571.37786043905;9662.75843103928;9830.361026533395;9846.359986600992;10100.393976361442;645.4158986117571;669.6317025635881;673.9797806065826;677.9084823548857;723.3706675192511;4781.378420805273;4859.149648811514;4917.213245880642;4947.282644016597;4958.42978057528;62464;83869.58065209635;91684.54157729301;93830;95232.52383738037;75231.62384188153;75990.6200468994;76718.6164069176;77078;77427;69935;70533.2946670537;71266.64366678237;71848.64075679693;74203.62898185475;9255.398399104037;9263.722088337361;9479.857802133112;9585.870949518432;9647.421154730739;41270.793646031576;42265.1546969065;43244;49836.501634983186;51316.97366052733;51643.483565163864;53327.46672533225;61515.692421537606;61724;61777.76444471176;12922.224666519664;12948.741025179632;13000.219986800823;13000.479980800663;13343.199408035549;13713.862861371657;13791;14075.788863167265;14891.925540372229;15194.088354698753;14293.57119286423;14375.28123593837;14446.277686115862;14950.476733314283;15299;13162.276074815976;13413.798793017917;13926.651833704238;13978.860211397756;14226.217558034408;13084.934575327063;13100.672483187996;13490.52783152585;13909.860901391261;14546.563603091925;10987.230893837674;11135.387553684624;11666.650000499998;11694.941525292319;12319.076069294659;10359.533820978224;11514.712132196762;11585;11636.709082273012;11798.764024719287 03:54:23 INFO - PROCESS | 12753 | __end_tp_report 03:54:23 INFO - PROCESS | 12753 | __start_cc_report 03:54:23 INFO - PROCESS | 12753 | _x_x_mozilla_cycle_collect,1649 03:54:23 INFO - PROCESS | 12753 | __end_cc_report 03:54:23 INFO - PROCESS | 12753 | __startTimestamp1479902063723__endTimestamp 03:54:23 INFO - PROCESS | 12753 | 03:54:23 INFO - PROCESS | 12753 | ------- Summary: start ------- 03:54:23 INFO - PROCESS | 12753 | Number of tests: 6 03:54:23 INFO - PROCESS | 12753 | 03:54:23 INFO - PROCESS | 12753 | [#0] dojo.html Cycles:165 Average:5600.33 Median:5804.74 stddev:625.91 (10.8%) stddev-sans-first:599.73 03:54:23 INFO - PROCESS | 12753 | Values: 3236.3 3276.3 3283.0 3301.6 3326.3 5585.8 5675.8 5679.4 5685.9 5687.1 5613.9 5676.8 5681.2 5688.0 5717.3 5098.9 5101.5 5108.9 5130.9 5183.0 5017.9 5047.0 5047.5 5201.3 5217.4 5045.1 5167.1 5168.7 5174.3 5180.1 5157.2 5166.5 5192.5 5197.9 5233.3 4973.7 4990.4 5097.6 5107.4 5167.4 5504.7 5510.8 5519.1 5543.9 5563.5 5964.6 5987.4 6010.4 6067.2 6073.9 6111.3 6128.1 6130.9 6134.1 6134.6 5529.1 5538.5 5544.9 5553.6 5611.8 6070.6 6083.6 6086.1 6089.7 6092.8 5840.3 5845.9 5846.2 5851.8 5860.6 5837.4 5941.2 5963.0 6016.2 6017.5 6040.4 6044.8 6049.2 6053.2 6074.8 6003.8 6006.0 6009.6 6010.6 6036.7 4540.8 4573.5 4581.2 4606.3 4650.6 4173.2 4197.8 4202.9 4205.9 4213.3 5811.1 5820.2 5826.2 5831.5 5831.9 5942.8 5943.7 6014.5 6067.2 6146.8 5722.9 5796.9 5817.2 5818.2 5825.2 5252.8 5279.3 5286.4 5286.8 5294.3 6077.7 6148.6 6356.0 6364.6 6370.0 5988.5 6044.6 6047.5 6113.9 6132.0 6289.0 6290.6 6291.5 6299.6 6338.6 5915.1 5975.7 5984.8 5991.2 6024.4 5804.7 5843.1 5859.6 5926.0 5927.8 5746.0 5782.7 5788.5 5789.2 5792.8 5790.8 5795.1 5796.1 5797.2 5799.6 5785.5 5789.7 5794.9 5818.8 5837.0 5977.7 5984.0 5990.0 6005.8 6014.6 5679.1 5802.3 5833.3 5836.4 5837.6 03:54:23 INFO - PROCESS | 12753 | 03:54:23 INFO - PROCESS | 12753 | [#1] ext.html Cycles:180 Average:64081.50 Median:34973.24 stddev:137612.55 (393.5%) stddev-sans-first:137915.94 03:54:23 INFO - PROCESS | 12753 | Values: 558.3 617.5 640.8 663.2 676.5 34014.5 43584.8 45073.8 45087.0 45103.3 45983.1 46418.0 46476.5 46513.5 46657.8 8125.1 8724.8 8862.2 8866.7 8873.9 8173.9 10333.5 10604.6 10625.0 10926.1 10763.8 10809.7 10816.8 10823.4 10827.1 10638.1 10686.8 10694.3 10699.9 10713.4 10599.6 10654.3 10680.4 10698.4 10702.2 42565.8 42646.6 42994.1 43060.0 43062.0 3365.8 3422.1 3422.7 3442.1 3465.4 32056.7 32269.4 32729.0 32802.7 34533.5 4401.6 4536.2 4564.5 4648.2 4733.1 337219.0 337355.0 339003.0 339323.5 340230.3 37336.3 39114.0 39200.0 63658.4 64294.4 41329.0 41524.8 41532.6 41579.4 41622.8 16456.8 16585.9 16663.2 16743.2 16860.3 12826.7 13139.5 13610.0 13922.6 14060.1 9340.4 9571.8 9575.8 9648.6 9655.8 3355.0 3432.0 3433.6 3439.7 3492.1 937.9 1034.8 1080.2 1100.7 1117.6 33516.8 33740.5 34039.8 34043.1 34283.0 1125.4 1137.3 1152.7 1199.9 1200.6 17067.2 17904.6 17934.3 17955.0 17982.8 539392.0 617223.0 629911.0 633752.0 872506.0 61332.7 61544.4 62099.7 62143.7 62177.7 1218.4 1346.3 1349.4 1373.6 1419.4 27350.5 33054.8 33960.4 36530.8 36860.4 58512.4 59206.0 59267.0 59323.0 59344.0 478729.0 479826.0 482376.0 485036.0 485666.0 26996.2 28327.3 29227.3 31097.7 31510.0 43074.6 46937.8 47226.0 47647.5 47976.8 39453.8 39623.4 40312.8 40572.4 41338.6 35754.5 35869.1 36733.3 36843.1 40879.6 42580.0 43114.4 43415.1 44055.0 44109.8 32566.7 34414.3 34473.3 34957.5 34989.0 28112.9 28607.0 28694.0 28886.7 29057.3 03:54:23 INFO - PROCESS | 12753 | 03:54:23 INFO - PROCESS | 12753 | [#2] jquery.html Cycles:180 Average:27996.67 Median:41949.29 stddev:77664.83 (185.1%) stddev-sans-first:77855.13 03:54:23 INFO - PROCESS | 12753 | Values: 438.3 438.5 444.1 447.6 457.2 18459.4 19602.8 20115.4 20268.5 20458.2 17824.6 19162.2 19239.5 19543.0 19546.4 5661.0 5965.0 5965.0 5969.9 5971.2 5706.6 5864.1 5981.3 5981.7 6004.1 6037.1 6040.5 6043.9 6045.8 6060.7 5878.2 5997.3 6067.2 6071.2 6072.1 5091.4 5889.9 5890.7 5894.9 5896.9 14293.0 14615.9 14721.8 14764.6 14766.2 2194.8 2222.1 2255.4 2259.5 2289.1 10221.7 10428.7 10505.6 10687.7 10746.6 1850.6 1924.2 1955.1 2007.5 2034.4 84278.0 85765.0 85978.0 88095.0 88783.0 11754.9 11862.7 11884.9 11891.4 12010.5 16995.6 17023.0 17030.6 17046.4 17069.7 8688.9 8918.8 8965.5 9113.1 9175.3 8600.5 8603.1 8700.8 8859.6 8875.6 4577.0 4741.1 4903.6 5126.8 5226.5 1849.3 1956.8 1995.6 2047.3 2051.5 881.9 971.8 974.2 1007.4 1055.2 19318.7 19498.2 19781.6 19827.8 20068.1 912.4 969.0 992.7 1010.5 1013.9 9095.4 10900.6 11009.3 11113.7 11208.2 465072.0 470873.0 472212.0 476482.0 476995.0 57953.4 58070.7 72137.6 78302.0 83008.6 984.2 1056.6 1056.7 1063.6 1065.0 17574.9 18047.5 18054.4 18065.0 18505.7 41940.6 41958.0 42143.6 42389.4 42954.1 50737.2 54617.2 57882.4 58276.4 59747.4 8140.8 8174.0 8340.3 8426.2 8807.6 9675.0 13267.3 13381.5 13434.7 14049.7 11898.9 12019.2 12040.6 12083.8 12087.2 11672.6 11910.4 11945.3 12282.4 12374.1 12208.2 12353.2 12440.6 12445.3 12587.2 8106.4 8181.6 8327.5 8499.2 8534.4 9385.0 11484.0 11730.2 12039.8 12545.2 03:54:23 INFO - PROCESS | 12753 | 03:54:23 INFO - PROCESS | 12753 | [#3] mootools.html Cycles:180 Average:5847.16 Median:2592.04 stddev:3302.99 (127.4%) stddev-sans-first:3295.76 03:54:23 INFO - PROCESS | 12753 | Values: 1455.7 1495.4 1645.7 1742.2 1828.3 8451.8 8998.1 9000.1 9015.1 9019.7 7584.8 7771.5 8426.4 8650.4 8895.3 2453.1 2485.2 2486.4 2489.4 2497.2 2437.0 2456.1 2483.3 2494.1 2495.1 2298.2 2319.3 2319.9 2344.8 2351.6 2423.4 2429.0 2435.3 2438.5 2456.6 2407.8 2416.5 2443.4 2444.4 2446.1 8791.9 8855.4 8858.9 8904.9 8962.1 5296.7 5389.5 5434.0 5437.3 5438.1 3547.6 3628.6 3639.8 3649.6 3712.3 1149.5 1159.8 1184.6 1236.0 1238.8 12405.8 12435.1 12443.3 12480.7 12492.8 4712.6 4858.2 4866.1 4938.9 4987.9 10320.8 10328.9 10335.1 10339.3 10342.7 5469.8 5471.6 5472.7 5476.1 5479.2 4454.9 4578.6 4931.0 4974.9 5019.2 4014.3 4072.7 4149.1 4149.4 4165.6 1378.4 1379.3 1387.4 1393.4 1400.8 717.4 822.9 825.0 826.4 839.4 5781.2 5974.7 5982.3 6066.2 6078.1 448.0 449.9 450.8 451.6 471.5 3829.9 3947.5 3973.1 3986.7 4030.0 10283.9 10469.0 10629.5 10727.4 10975.7 10891.8 10949.7 10954.5 10966.1 10968.1 8206.1 8549.0 8559.3 8559.6 8574.6 5896.1 6039.4 6086.5 6097.2 6133.5 9917.9 10056.4 10084.2 10130.1 10171.1 10315.9 10431.4 10498.5 10516.8 10527.4 7257.1 7265.0 7416.4 8003.6 8127.2 8556.3 8765.5 8868.0 8881.2 8895.9 7466.2 7680.6 7775.9 7892.8 8010.7 7565.3 7612.5 7703.3 7716.8 7833.8 6829.8 6848.1 6944.1 6949.5 6979.5 5038.6 5144.6 5172.8 5222.1 5222.6 5202.9 5223.3 5259.0 5340.1 5345.0 03:54:23 INFO - PROCESS | 12753 | 03:54:23 INFO - PROCESS | 12753 | [#4] prototype.html Cycles:180 Average:4867.80 Median:5499.60 stddev:1435.49 (26.1%) stddev-sans-first:1398.92 03:54:23 INFO - PROCESS | 12753 | Values: 351.4 351.5 359.4 363.8 367.2 5530.4 5536.0 5552.5 5591.3 5606.3 5223.8 5307.0 5343.3 5409.3 5469.5 4331.0 4331.7 4344.2 4351.3 4358.7 4329.9 4340.6 4360.0 4362.5 4363.2 4172.3 4256.7 4269.9 4299.1 4320.5 4268.8 4272.3 4272.5 4283.7 4292.7 3803.5 3804.4 3814.8 3815.8 3830.7 5233.3 5330.9 5358.3 5403.4 5461.4 4870.2 4887.0 4903.7 4918.5 4939.9 5657.3 5718.4 5727.8 5731.4 5754.2 4053.5 4130.3 4157.3 4168.6 4189.5 5911.5 5929.9 5943.8 5948.7 5964.7 4250.3 4263.9 4289.6 4294.2 4295.7 4236.7 4242.3 4282.8 4314.8 4342.2 4806.0 4826.0 4834.2 4845.4 4850.5 5708.4 5752.0 5756.9 5761.6 5771.7 1368.7 1396.3 1418.3 1429.0 1432.7 934.7 979.5 1002.2 1009.2 1013.5 5415.5 5476.5 5495.3 5512.2 5526.2 5543.0 5728.2 5740.1 5786.5 5786.7 5403.3 5424.3 5454.6 5456.6 5521.0 3015.7 3055.1 3064.2 3068.3 3073.5 5836.2 5915.3 5953.6 6192.8 6234.1 6100.5 6116.9 6119.3 6120.3 6133.6 5909.3 6230.9 6258.2 6278.5 6289.5 5886.7 5930.3 6004.3 6007.5 6007.9 5908.7 5942.3 5945.3 5980.3 5982.4 5990.7 6215.9 6268.4 6274.3 6293.3 4340.0 4351.7 4356.9 4367.0 4379.3 5732.8 6013.6 6057.7 6066.8 6077.2 5796.9 5814.4 5825.4 5826.6 5839.7 5774.8 5794.7 5795.2 5815.0 5841.6 5444.9 5503.9 5762.7 5784.3 5813.1 5781.9 5820.6 5829.9 5844.4 5845.6 5582.0 5689.7 5697.8 5712.7 5732.6 03:54:23 INFO - PROCESS | 12753 | 03:54:23 INFO - PROCESS | 12753 | [#5] yui.html Cycles:180 Average:17809.71 Median:4888.18 stddev:23098.19 (472.5%) stddev-sans-first:23127.27 03:54:23 INFO - PROCESS | 12753 | Values: 703.1 757.3 764.0 769.7 823.1 13847.4 14639.5 14826.0 14864.3 14868.7 13292.5 13513.5 14789.4 15786.8 15844.4 825.1 840.7 845.2 845.7 846.6 843.7 845.0 846.4 846.6 847.4 888.7 889.6 890.7 891.5 891.9 887.3 887.4 887.5 888.2 890.5 650.7 651.1 651.1 651.3 651.6 14993.2 14994.3 15030.9 15040.5 15068.3 14494.3 14698.8 14926.6 14931.7 15002.6 11334.6 11451.0 11545.5 11569.6 11881.2 3740.1 3751.0 3764.3 3810.4 3865.8 54257.5 56035.0 56838.4 64367.7 65712.7 10764.2 10782.7 10886.5 11090.3 12114.8 17643.2 17772.9 19334.7 20714.5 21003.8 8108.8 8154.1 8202.4 8472.2 8518.2 4486.7 4525.6 4558.5 4649.0 4698.9 3314.5 3366.6 3376.4 3416.1 3856.9 680.0 688.4 690.9 700.8 701.4 669.4 699.9 720.3 734.6 755.8 9571.4 9662.8 9830.4 9846.4 10100.4 645.4 669.6 674.0 677.9 723.4 4781.4 4859.1 4917.2 4947.3 4958.4 62464.0 83869.6 91684.5 93830.0 95232.5 75231.6 75990.6 76718.6 77078.0 77427.0 69935.0 70533.3 71266.6 71848.6 74203.6 9255.4 9263.7 9479.9 9585.9 9647.4 41270.8 42265.2 43244.0 49836.5 51317.0 51643.5 53327.5 61515.7 61724.0 61777.8 12922.2 12948.7 13000.2 13000.5 13343.2 13713.9 13791.0 14075.8 14891.9 15194.1 14293.6 14375.3 14446.3 14950.5 15299.0 13162.3 13413.8 13926.7 13978.9 14226.2 13084.9 13100.7 13490.5 13909.9 14546.6 10987.2 11135.4 11666.7 11694.9 12319.1 10359.5 11514.7 11585.0 11636.7 11798.8 03:54:23 INFO - PROCESS | 12753 | -------- Summary: end -------- 03:54:23 INFO - PROCESS | 12753 | 03:54:24 INFO - TEST-INFO | 12753: exit 0 03:54:24 INFO - TEST-OK | dromaeo_css | took 1115728ms 03:54:24 INFO - TEST-START | kraken 03:54:24 INFO - operating with platform_type : linux_ 03:54:24 INFO - Initialising browser for kraken test... 03:54:24 INFO - TEST-INFO | started process 13073 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHQ1c8a/profile http://localhost:47141/getInfo.html) 03:54:27 ERROR - PROCESS | 13073 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 5373: TypeError: parent.firstChild is null 03:54:28 INFO - PROCESS | 13073 | __metrics Screen width/height:1600/1200 03:54:28 INFO - PROCESS | 13073 | colorDepth:24 03:54:28 INFO - PROCESS | 13073 | Browser inner width/height: 1024/697 03:54:28 INFO - PROCESS | 13073 | __metrics 03:54:29 INFO - PROCESS | 13073 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 03:54:29 INFO - PROCESS | 13073 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:54:29 INFO - PROCESS | 13073 | console.error: PushService: 03:54:29 INFO - PROCESS | 13073 | stateChangeProcessEnqueue: Error transitioning state 03:54:29 INFO - PROCESS | 13073 | UnknownError 03:54:30 INFO - TEST-INFO | 13073: exit 0 03:54:30 INFO - Browser initialized. 03:54:30 INFO - Running cycle 1/1 for kraken test... 03:54:30 INFO - TEST-INFO | started process 13168 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHQ1c8a/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:54:42 INFO - PROCESS | 13168 | RSS: Main: 147816448 03:54:42 INFO - PROCESS | 13168 | 03:54:44 INFO - PROCESS | 13168 | Cycle 1(1): loaded http://localhost:47141/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47141/tests/kraken/driver.html?testName=audio-beat-detection) 03:54:45 INFO - PROCESS | 13168 | RSS: Main: 189009920 03:54:45 INFO - PROCESS | 13168 | 03:54:48 INFO - PROCESS | 13168 | Cycle 1(1): loaded http://localhost:47141/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47141/tests/kraken/driver.html?testName=audio-dft) 03:54:48 INFO - PROCESS | 13168 | RSS: Main: 178774016 03:54:48 INFO - PROCESS | 13168 | 03:54:51 INFO - PROCESS | 13168 | Cycle 1(1): loaded http://localhost:47141/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47141/tests/kraken/driver.html?testName=audio-fft) 03:54:52 INFO - PROCESS | 13168 | RSS: Main: 269733888 03:54:52 INFO - PROCESS | 13168 | 03:54:54 INFO - PROCESS | 13168 | Cycle 1(1): loaded http://localhost:47141/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47141/tests/kraken/driver.html?testName=audio-oscillator) 03:54:54 INFO - PROCESS | 13168 | RSS: Main: 176308224 03:54:54 INFO - PROCESS | 13168 | 03:54:56 INFO - PROCESS | 13168 | Cycle 1(1): loaded http://localhost:47141/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47141/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:54:57 INFO - PROCESS | 13168 | RSS: Main: 178933760 03:54:57 INFO - PROCESS | 13168 | 03:55:00 INFO - PROCESS | 13168 | Cycle 1(1): loaded http://localhost:47141/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47141/tests/kraken/driver.html?testName=imaging-darkroom) 03:55:00 INFO - PROCESS | 13168 | RSS: Main: 217550848 03:55:00 INFO - PROCESS | 13168 | 03:55:04 INFO - PROCESS | 13168 | Cycle 1(1): loaded http://localhost:47141/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47141/tests/kraken/driver.html?testName=imaging-desaturate) 03:55:04 INFO - PROCESS | 13168 | RSS: Main: 215613440 03:55:04 INFO - PROCESS | 13168 | 03:55:07 INFO - PROCESS | 13168 | Cycle 1(1): loaded http://localhost:47141/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47141/tests/kraken/driver.html?testName=json-parse-financial) 03:55:08 INFO - PROCESS | 13168 | RSS: Main: 214491136 03:55:08 INFO - PROCESS | 13168 | 03:55:09 INFO - PROCESS | 13168 | Cycle 1(1): loaded http://localhost:47141/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47141/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:55:10 INFO - PROCESS | 13168 | RSS: Main: 177090560 03:55:10 INFO - PROCESS | 13168 | 03:55:11 INFO - PROCESS | 13168 | Cycle 1(1): loaded http://localhost:47141/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47141/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:55:12 INFO - PROCESS | 13168 | RSS: Main: 184078336 03:55:12 INFO - PROCESS | 13168 | 03:55:14 INFO - PROCESS | 13168 | Cycle 1(1): loaded http://localhost:47141/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47141/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:55:15 INFO - PROCESS | 13168 | RSS: Main: 190627840 03:55:15 INFO - PROCESS | 13168 | 03:55:17 INFO - PROCESS | 13168 | Cycle 1(1): loaded http://localhost:47141/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47141/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:55:18 INFO - PROCESS | 13168 | RSS: Main: 199041024 03:55:18 INFO - PROCESS | 13168 | 03:55:20 INFO - PROCESS | 13168 | Cycle 1(1): loaded http://localhost:47141/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47141/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:55:21 INFO - PROCESS | 13168 | RSS: Main: 195567616 03:55:21 INFO - PROCESS | 13168 | 03:55:23 INFO - PROCESS | 13168 | Cycle 1(1): loaded http://localhost:47141/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47141/tests/kraken/driver.html?testName=ai-astar) 03:55:23 INFO - PROCESS | 13168 | RSS: Main: 248057856 03:55:23 INFO - PROCESS | 13168 | 03:55:23 INFO - PROCESS | 13168 | __start_tp_report 03:55:23 INFO - PROCESS | 13168 | _x_x_mozilla_page_load 03:55:23 INFO - PROCESS | 13168 | _x_x_mozilla_page_load_details 03:55:23 INFO - PROCESS | 13168 | |i|pagename|runs| 03:55:23 INFO - PROCESS | 13168 | |0;ai-astar;109;110;112;110;112;110;109;110;111;111 03:55:23 INFO - PROCESS | 13168 | |1;audio-beat-detection;153;123;125;170;125;124;122;124;153;123 03:55:23 INFO - PROCESS | 13168 | |2;audio-dft;160;160;159;159;161;160;160;159;159;163 03:55:23 INFO - PROCESS | 13168 | |3;audio-fft;75;77;75;107;77;77;75;76;113;75 03:55:23 INFO - PROCESS | 13168 | |4;audio-oscillator;82;81;110;82;82;82;98;83;81;115 03:55:23 INFO - PROCESS | 13168 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;116;116;117 03:55:23 INFO - PROCESS | 13168 | |6;imaging-darkroom;146;146;146;147;146;146;147;146;146;146 03:55:23 INFO - PROCESS | 13168 | |7;imaging-desaturate;84;84;84;84;84;85;85;85;84;84 03:55:23 INFO - PROCESS | 13168 | |8;json-parse-financial;50;52;49;50;52;49;50;49;50;49 03:55:23 INFO - PROCESS | 13168 | |9;json-stringify-tinderbox;59;58;58;59;59;58;59;59;59;60 03:55:23 INFO - PROCESS | 13168 | |10;stanford-crypto-aes;76;76;76;76;76;85;78;76;75;76 03:55:23 INFO - PROCESS | 13168 | |11;stanford-crypto-ccm;126;125;131;137;137;126;122;134;173;136 03:55:23 INFO - PROCESS | 13168 | |12;stanford-crypto-pbkdf2;154;154;157;153;163;158;153;152;155;153 03:55:23 INFO - PROCESS | 13168 | |13;stanford-crypto-sha256-iterative;62;61;63;62;62;61;60;61;61;60 03:55:23 INFO - PROCESS | 13168 | __end_tp_report 03:55:23 INFO - PROCESS | 13168 | __start_cc_report 03:55:23 INFO - PROCESS | 13168 | _x_x_mozilla_cycle_collect,1613 03:55:23 INFO - PROCESS | 13168 | __end_cc_report 03:55:23 INFO - PROCESS | 13168 | __startTimestamp1479902123395__endTimestamp 03:55:23 INFO - PROCESS | 13168 | 03:55:23 INFO - PROCESS | 13168 | ------- Summary: start ------- 03:55:23 INFO - PROCESS | 13168 | Number of tests: 14 03:55:23 INFO - PROCESS | 13168 | 03:55:23 INFO - PROCESS | 13168 | [#0] ai-astar Cycles:10 Average:110.40 Median:110.50 stddev:1.07 (1.0%) stddev-sans-first:1.01 03:55:23 INFO - PROCESS | 13168 | Values: 109.0 110.0 112.0 110.0 112.0 110.0 109.0 110.0 111.0 111.0 03:55:23 INFO - PROCESS | 13168 | 03:55:23 INFO - PROCESS | 13168 | [#1] audio-beat-detection Cycles:10 Average:134.20 Median:125.00 stddev:17.53 (14.0%) stddev-sans-first:17.22 03:55:23 INFO - PROCESS | 13168 | Values: 153.0 123.0 125.0 170.0 125.0 124.0 122.0 124.0 153.0 123.0 03:55:23 INFO - PROCESS | 13168 | 03:55:23 INFO - PROCESS | 13168 | [#2] audio-dft Cycles:10 Average:160.00 Median:160.00 stddev:1.25 (0.8%) stddev-sans-first:1.32 03:55:23 INFO - PROCESS | 13168 | Values: 160.0 160.0 159.0 159.0 161.0 160.0 160.0 159.0 159.0 163.0 03:55:23 INFO - PROCESS | 13168 | 03:55:23 INFO - PROCESS | 13168 | [#3] audio-fft Cycles:10 Average:82.70 Median:75.50 stddev:14.48 (19.2%) stddev-sans-first:15.09 03:55:23 INFO - PROCESS | 13168 | Values: 75.0 77.0 75.0 107.0 77.0 77.0 75.0 76.0 113.0 75.0 03:55:23 INFO - PROCESS | 13168 | 03:55:23 INFO - PROCESS | 13168 | [#4] audio-oscillator Cycles:10 Average:89.60 Median:82.00 stddev:13.14 (16.0%) stddev-sans-first:13.65 03:55:23 INFO - PROCESS | 13168 | Values: 82.0 81.0 110.0 82.0 82.0 82.0 98.0 83.0 81.0 115.0 03:55:23 INFO - PROCESS | 13168 | 03:55:23 INFO - PROCESS | 13168 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 03:55:23 INFO - PROCESS | 13168 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 116.0 116.0 117.0 03:55:23 INFO - PROCESS | 13168 | 03:55:23 INFO - PROCESS | 13168 | [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 03:55:23 INFO - PROCESS | 13168 | Values: 146.0 146.0 146.0 147.0 146.0 146.0 147.0 146.0 146.0 146.0 03:55:23 INFO - PROCESS | 13168 | 03:55:23 INFO - PROCESS | 13168 | [#7] imaging-desaturate Cycles:10 Average:84.30 Median:84.00 stddev:0.48 (0.6%) stddev-sans-first:0.50 03:55:23 INFO - PROCESS | 13168 | Values: 84.0 84.0 84.0 84.0 84.0 85.0 85.0 85.0 84.0 84.0 03:55:23 INFO - PROCESS | 13168 | 03:55:23 INFO - PROCESS | 13168 | [#8] json-parse-financial Cycles:10 Average:50.00 Median:50.00 stddev:1.15 (2.3%) stddev-sans-first:1.22 03:55:23 INFO - PROCESS | 13168 | Values: 50.0 52.0 49.0 50.0 52.0 49.0 50.0 49.0 50.0 49.0 03:55:23 INFO - PROCESS | 13168 | 03:55:23 INFO - PROCESS | 13168 | [#9] json-stringify-tinderbox Cycles:10 Average:58.80 Median:59.00 stddev:0.63 (1.1%) stddev-sans-first:0.67 03:55:23 INFO - PROCESS | 13168 | Values: 59.0 58.0 58.0 59.0 59.0 58.0 59.0 59.0 59.0 60.0 03:55:23 INFO - PROCESS | 13168 | 03:55:23 INFO - PROCESS | 13168 | [#10] stanford-crypto-aes Cycles:10 Average:77.00 Median:76.00 stddev:2.91 (3.8%) stddev-sans-first:3.06 03:55:23 INFO - PROCESS | 13168 | Values: 76.0 76.0 76.0 76.0 76.0 85.0 78.0 76.0 75.0 76.0 03:55:23 INFO - PROCESS | 13168 | 03:55:23 INFO - PROCESS | 13168 | [#11] stanford-crypto-ccm Cycles:10 Average:134.70 Median:135.00 stddev:14.53 (10.8%) stddev-sans-first:15.07 03:55:23 INFO - PROCESS | 13168 | Values: 126.0 125.0 131.0 137.0 137.0 126.0 122.0 134.0 173.0 136.0 03:55:23 INFO - PROCESS | 13168 | 03:55:23 INFO - PROCESS | 13168 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:155.20 Median:154.50 stddev:3.33 (2.2%) stddev-sans-first:3.50 03:55:23 INFO - PROCESS | 13168 | Values: 154.0 154.0 157.0 153.0 163.0 158.0 153.0 152.0 155.0 153.0 03:55:23 INFO - PROCESS | 13168 | 03:55:23 INFO - PROCESS | 13168 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.30 Median:61.50 stddev:0.95 (1.5%) stddev-sans-first:0.97 03:55:23 INFO - PROCESS | 13168 | Values: 62.0 61.0 63.0 62.0 62.0 61.0 60.0 61.0 61.0 60.0 03:55:23 INFO - PROCESS | 13168 | -------- Summary: end -------- 03:55:23 INFO - PROCESS | 13168 | 03:55:24 INFO - TEST-INFO | 13168: exit 0 03:55:24 INFO - TEST-OK | kraken | took 59900ms 03:55:24 INFO - SUITE-END | took 1175s 03:55:24 INFO - Completed test suite (00:19:35) 03:55:24 INFO - javascript benchmark 03:55:24 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3236.2880166363398, 3276.279218571913, 3282.983585082076, 3301.620313663929, 3326.301476689895, 5585.804496842611, 5675.829725108243, 5679.403662615423, 5685.943140568604, 5687.118496633018, 5613.859653508664, 5676.772929082842, 5681.176229446728, 5688.0, 5717.342505611856, 5098.949010509903, 5101.515356041179, 5108.923366149492, 5130.948690513103, 5182.974085129569, 5017.899642007158, 5046.965372098729, 5047.47001564836, 5201.271821944931, 5217.426083130853, 5045.117104506697, 5167.147420675584, 5168.715720635363, 5174.327337446127, 5180.067587834188, 5157.200633901752, 5166.483351664841, 5192.532672059514, 5197.922031169535, 5233.293505376763, 4973.701577905301, 4990.426100998396, 5097.617678674077, 5107.412647545542, 5167.4057483389515, 5504.669719816824, 5510.779568817243, 5519.089350257203, 5543.861403464905, 5563.527100196488, 5964.552658550626, 5987.43119403656, 6010.429009244159, 6067.150598916155, 6073.908891366633, 6111.2666480022235, 6128.050152226412, 6130.938690613081, 6134.141220229171, 6134.570580059398, 5529.142982837667, 5538.501534861882, 5544.861378465571, 5553.611247212697, 5611.803586874481, 6070.575059745775, 6083.6349819011, 6086.056661217518, 6089.695515224221, 6092.7562897484495, 5840.2991641003355, 5845.941540584539, 5846.181534585162, 5851.795187168429, 5860.619059761102, 5837.357890632027, 5941.197938278364, 5963.0459126539545, 6016.2479690038745, 6017.458428741435, 6040.395960404012, 6044.848878778066, 6049.153118563405, 6053.152558641794, 6074.848128796815, 6003.849903752441, 6006.039033754666, 6009.639421634716, 6010.579259451796, 6036.698165091816, 4540.77296135192, 4573.519780423074, 4581.198290299251, 4606.286025666027, 4650.604698600657, 4173.227952828736, 4197.769122698281, 4202.936955945664, 4205.873823785291, 4213.346931225665, 5811.070228763462, 5820.185174075633, 5826.242588463472, 5831.533477321804, 5831.883362332815, 5942.82171534846, 5943.732532035982, 6014.548908831855, 6067.211262535842, 6146.846328841725, 5722.885542289214, 5796.913046304308, 5817.214676018768, 5818.156367326714, 5825.24271844666, 5252.763625636855, 5279.313689220454, 5286.36563612369, 5286.841394758163, 5294.338207724035, 6077.6961151943115, 6148.631082135086, 6356.0, 6364.618122912732, 6370.0, 5988.490978266722, 6044.637321760709, 6047.546434017554, 6113.902014424272, 6131.988406491147, 6289.0, 6290.622562646073, 6291.528135389955, 6299.622022678654, 6338.619682818861, 5915.053591425523, 5975.671338076448, 5984.820455386345, 5991.161237426851, 6024.397560244116, 5804.738786754522, 5843.094320380348, 5859.619124756877, 5925.970370148121, 5927.8221653350465, 5746.023176060164, 5782.653040817564, 5788.479036886701, 5789.2184555086205, 5792.797252096157, 5790.7973220937065, 5795.072788353843, 5796.101604251347, 5797.159411885337, 5799.594028417971, 5785.479306862234, 5789.652620842763, 5794.855128621818, 5818.836232753381, 5837.0368889132815, 5977.671228082323, 5983.970080149571, 5990.041593345044, 6005.819825405245, 6014.6391216527145, 5679.091345384719, 5802.303723553032, 5833.270841144857, 5836.358000619844, 5837.591368604327], "value": 5558.821951322089, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [558.3104865491118, 617.4936552027337, 640.8397900524869, 663.2306524431657, 676.5027704637093, 34014.48978265328, 43584.782076089614, 45073.7746311268, 45087.0, 45103.32345014827, 45983.080338393214, 46418.0, 46476.53523464764, 46513.534864651345, 46657.766711166485, 8125.146859579748, 8724.781880452992, 8862.202401783838, 8866.733997980038, 8873.911260887406, 8173.918260817375, 10333.483325833717, 10604.575816967312, 10625.0, 10926.071283940875, 10763.78472430551, 10809.729756756065, 10816.78366432671, 10823.350598964047, 10827.07969822566, 10638.148948084136, 10686.839697404544, 10694.251402401835, 10699.946500267526, 10713.357198568072, 10599.576016959312, 10654.307470014503, 10680.412577308245, 10698.411587362692, 10702.197335199891, 42565.787171063945, 42646.57353426457, 42994.14011719779, 43060.0, 43062.0, 3365.831708414594, 3422.058933793227, 3422.6577342265823, 3442.122258824009, 3465.3935561276676, 32056.6794332056, 32269.35461290761, 32729.0, 32802.6719732802, 34533.48199777005, 4401.6478681705385, 4536.183486972343, 4564.5435456454425, 4648.163330600491, 4733.0533893221145, 337219.0, 337355.0, 339003.0, 339323.5169120767, 340230.29884850665, 37336.25327493435, 39114.0, 39200.0, 63658.363416365246, 64294.35705642884, 41329.0, 41524.79237603793, 41532.58467415287, 41579.376309355386, 41622.79188604037, 16456.83543164577, 16585.91707041457, 16663.16684165787, 16743.246553905105, 16860.32558697663, 12826.67933301675, 13139.54011609589, 13610.0, 13922.582322530341, 14060.08609440383, 9340.392874463138, 9571.808563828685, 9575.760605984768, 9648.614055437703, 9655.806883862284, 3355.0, 3432.0, 3433.5879694436826, 3439.6904278615043, 3492.109512074405, 937.8968313485648, 1034.8395998620226, 1080.206048554312, 1100.6863044032573, 1117.5920788912151, 33516.83241583825, 33740.48167832453, 34039.829800850835, 34043.14892127667, 34283.0, 1125.3641692443744, 1137.3119262846024, 1152.6887740310237, 1199.924695064559, 1200.6458094862037, 17067.231974561175, 17904.55238619019, 17934.282628694706, 17955.0, 17982.820171798376, 539392.0, 617223.0, 629911.0, 633752.0, 872506.0, 61332.69333653303, 61544.38455615386, 62099.6895015522, 62143.6892815533, 62177.68911155415, 1218.439517821812, 1346.347021694497, 1349.426493740176, 1373.6359864635879, 1419.425132821209, 27350.452990939673, 33054.834725826215, 33960.43705918444, 36530.8173459131, 36860.447093294155, 58512.4148758507, 59206.0, 59267.0, 59323.0, 59344.0, 478729.0, 479826.0, 482376.0, 485036.0, 485666.0, 26996.1901142966, 28327.29181770472, 29227.269318267212, 31097.68902310948, 31510.0, 43074.569254307055, 46937.76531117323, 47226.0, 47647.5235247657, 47976.7601161992, 39453.802730986165, 39623.40564891471, 40312.79843600763, 40572.39141412822, 41338.58661413468, 35754.463683044254, 35869.1032724184, 36733.26533469369, 36843.07892302714, 40879.59120408758, 42580.0, 43114.353284700126, 43415.13169736524, 44055.0, 44109.77945110254, 32566.674333257313, 34414.311713765084, 34473.310533789685, 34957.47563786596, 34989.0, 28112.859435702692, 28607.0, 28694.0, 28886.711132888402, 29057.273568160967], "value": 19839.91698622371, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [438.2768432087056, 438.5176306063333, 444.1450208348928, 447.6195234051056, 457.20902838090126, 18459.446216613505, 19602.803971960257, 20115.396538103843, 20268.493287667814, 20458.18167273311, 17824.554386140353, 19162.179592938683, 19239.519012024706, 19543.0, 19546.41360759176, 5660.99999999999, 5965.0, 5965.015772397549, 5969.940300596982, 5971.193888824996, 5706.629069110494, 5864.091065884773, 5981.282246130449, 5981.671008094553, 6004.129401236818, 6037.124616930542, 6040.456358927696, 6043.909341359883, 6045.7883974060915, 6060.696965151725, 5878.235829342179, 5997.310309314419, 6067.211262535886, 6071.210742603455, 6072.149899014142, 5091.363579552556, 5889.85275368115, 5890.734916928748, 5894.911576326359, 5896.911546326808, 14293.0, 14615.853841461661, 14721.779173312409, 14764.557063288119, 14766.187859667714, 2194.8353873459555, 2222.111155537798, 2255.391044417998, 2259.5029093599383, 2289.072925465189, 10221.693349199535, 10428.687139385755, 10505.579776808918, 10687.679369618923, 10746.623868164577, 1850.611371611963, 1924.201456395594, 1955.0908827395328, 2007.518195633052, 2034.410021093881, 84278.0, 85765.0, 85978.0, 88095.0, 88783.0, 11754.941225293818, 11862.703432414086, 11884.940575297069, 11891.405429728478, 12010.519579216734, 16995.575110622085, 17023.0, 17030.57423564396, 17046.403375881786, 17069.65860682804, 8688.869666955, 8918.821623567492, 8965.462072275554, 9113.088691130833, 9175.265978721687, 8600.483970961763, 8603.096674849176, 8700.825983480296, 8859.64561417536, 8875.600597973107, 4577.0, 4741.075490279362, 4903.632227582945, 5126.820561280338, 5226.503482169188, 1849.306510058728, 1956.814102660245, 1995.600879824012, 2047.273218007586, 2051.5281485258474, 881.8897637795276, 971.7862070344513, 974.1914211204684, 1007.3603261928728, 1055.2402270365324, 19318.71021934672, 19498.220071196993, 19781.60436791285, 19827.801721982883, 20068.09693563764, 912.4114945859883, 968.9951550242204, 992.7369247149511, 1010.5351538292468, 1013.8580598716186, 9095.408798428214, 10900.563977440972, 11009.2843965142, 11113.722156946142, 11208.215424920178, 465072.0, 470873.0, 472212.0, 476482.0, 476995.0, 57953.4204657948, 58070.7096464515, 72137.63931180416, 78302.0, 83008.58495707603, 984.2224642532462, 1056.5668076088766, 1056.6671498477954, 1063.5586231713753, 1065.041462683591, 17574.912125439292, 18047.5488112793, 18054.36809711706, 18065.0, 18505.72241416353, 41940.580594194886, 41958.0, 42143.57856421519, 42389.36415953701, 42954.140917180855, 50737.23894141665, 54617.1807422881, 57882.421175787706, 58276.4172358271, 59747.40252597418, 8140.75577732669, 8174.019117705913, 8340.266948329187, 8426.15738426177, 8807.559622019002, 9675.03249675027, 13267.336633168496, 13381.53164639233, 13434.731305373642, 14049.719005620034, 11898.881011189776, 12019.158658894143, 12040.638780836589, 12083.818742719042, 12087.214331068453, 11672.591459298883, 11910.404479776149, 11945.283283003047, 12282.385880706108, 12374.13381063317, 12208.206466579644, 12353.197042192229, 12440.564580239648, 12445.315507647167, 12587.24476531411, 8106.432549721463, 8181.550014749246, 8327.500349978778, 8499.192576705203, 8534.359923005675, 9384.95307523458, 11484.0, 11730.237534560227, 12039.819402708792, 12545.247285162919], "value": 9249.882243776707, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1455.7306898223828, 1495.3569964915087, 1645.6626391589725, 1742.2072956804654, 1828.2686925229907, 8451.830963380737, 8998.145176208267, 9000.144986226314, 9015.098490150982, 9019.729408117759, 7584.810379740509, 7771.533707977525, 8426.410151289412, 8650.437721548094, 8895.33285003624, 2453.141400509821, 2485.1674688979215, 2486.428121532049, 2489.3900994256433, 2497.163450244161, 2436.9512609747794, 2456.054419048661, 2483.3046746910804, 2494.1270555305678, 2495.0643508684243, 2298.161171172518, 2319.2810228829035, 2319.9188028419007, 2344.765523447659, 2351.600227961242, 2423.3699238198105, 2429.0, 2435.281591930385, 2438.51229754049, 2456.5823809952353, 2407.8073754099805, 2416.5287768885073, 2443.376938880574, 2444.4133407982135, 2446.107170882633, 8791.868121978176, 8855.424397414212, 8858.911410885938, 8904.8664270036, 8962.103789620985, 5296.708681022542, 5389.487998640123, 5434.049041417736, 5437.34751829783, 5438.102713052342, 3547.609762926076, 3628.582712987987, 3639.781613103196, 3649.598544160167, 3712.3317802795486, 1149.4540093455626, 1159.7622487390065, 1184.5557915781583, 1235.9629211123681, 1238.7708273969254, 12405.813912791225, 12435.067369947199, 12443.315617641027, 12480.687982800411, 12492.75014499705, 4712.5994290485005, 4858.198397264482, 4866.148424025781, 4938.913439043405, 4987.900241995212, 10320.793584128276, 10328.948355258175, 10335.06984371395, 10339.276250662531, 10342.741431464274, 5469.753861076261, 5471.644343117685, 5472.7263636818, 5476.096444086761, 5479.232907392969, 4454.888627784331, 4578.587927086512, 4931.013797240495, 4974.850754477371, 5019.222020586815, 4014.2573623879675, 4072.717094115344, 4149.087200815816, 4149.398337241083, 4165.625093741578, 1378.400395827818, 1379.3034517568565, 1387.4450219911914, 1393.393873664959, 1400.8459069502346, 717.3973861955877, 822.8642274024719, 824.9628766705392, 826.3926014379426, 839.3578912132224, 5781.161731548902, 5974.701264936736, 5982.282126144891, 6066.211392519032, 6078.1186727924205, 448.0, 449.8672891497016, 450.8309383981007, 451.58905396089403, 471.48137049245554, 3829.8659546915724, 3947.526296844397, 3973.1259122992897, 3986.740861843971, 4030.0, 10283.897161028444, 10469.0, 10629.46852657364, 10727.356358618508, 10975.670729878117, 10891.83662245067, 10949.671509854717, 10954.452277386099, 10966.122710183166, 10968.067714244378, 8206.138355472709, 8549.0, 8559.315254779603, 8559.572021398904, 8574.571271436404, 5896.086106653475, 6039.365866583946, 6086.543509236913, 6097.176881120992, 6133.50931925436, 9917.851232231378, 10056.396616203052, 10084.193264538966, 10130.08829205375, 10171.135453486537, 10315.948420257851, 10431.426271555138, 10498.527566259383, 10516.789664206826, 10527.420991845522, 7257.129144502694, 7264.963675181802, 7416.44376671741, 8003.639836207268, 8127.2279133482225, 8556.27271681914, 8765.474071555727, 8868.02451730322, 8881.245094167069, 8895.866562001705, 7466.178720340867, 7680.615969201629, 7775.883361749465, 7892.802679933047, 8010.719624813337, 7565.2812982766545, 7612.505187162817, 7703.26818952221, 7716.7684969451, 7833.843323133391, 6829.795106146824, 6848.14398200225, 6944.097267355211, 6949.478789090737, 6979.4765392594745, 5038.647294689483, 5144.562712169508, 5172.767225474938, 5222.060029194781, 5222.582193424593, 5202.947970520247, 5223.2948551945, 5258.97370513145, 5340.118880384693, 5345.01117293302], "value": 4615.147250665729, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [351.379814627183, 351.4903390084377, 359.4303029697929, 363.7617360628789, 367.2214904402667, 5530.364008139065, 5535.972320138404, 5552.500274975251, 5591.30108736408, 5606.327240731108, 5223.843284701456, 5307.0015441275655, 5343.332083489564, 5409.26974858394, 5469.453054694539, 4330.956690433087, 4331.7400955942585, 4344.218040752663, 4351.260285751414, 4358.65130789536, 4329.913401731964, 4340.56594340565, 4359.978200109011, 4362.476502819666, 4363.214621368168, 4172.2698527757675, 4256.680429066999, 4269.87190384289, 4299.118680670455, 4320.4599425071865, 4268.807903644343, 4272.33778764292, 4272.5473339064865, 4283.700140990132, 4292.656587472995, 3803.5055442792536, 3804.4483549885113, 3814.8474061037527, 3815.751976121543, 3830.7126965477423, 5233.293505376763, 5330.92003619946, 5358.33020872391, 5403.378611459654, 5461.42655021221, 4870.172070747946, 4887.022595480882, 4903.730294833783, 4918.458969513351, 4939.876503087452, 5657.2928383952, 5718.399568045337, 5727.799527016535, 5731.363572756537, 5754.1944127822135, 4053.4527838741687, 4130.297849365615, 4157.293260145782, 4168.6039826216465, 4189.539150693421, 5911.497522710575, 5929.8814023719715, 5943.791967281124, 5948.672822994734, 5964.747403045409, 4250.277452833026, 4263.891388239018, 4289.592488713567, 4294.162638285567, 4295.699301048959, 4236.724612900213, 4242.324281908629, 4282.828686852553, 4314.784260786948, 4342.174986752507, 4805.951940480551, 4825.975870120697, 4834.178189707758, 4845.442774081026, 4850.490698476679, 5708.429157084342, 5752.02215623345, 5756.856078597984, 5761.567882408836, 5771.68255745938, 1368.7330970460864, 1396.3297617143828, 1418.2554159066572, 1429.00684024604, 1432.7206194792125, 934.6868798952291, 979.4612962870393, 1002.178213864624, 1009.2329829329763, 1013.5236438873718, 5415.510734547952, 5476.479734425223, 5495.258140151029, 5512.228288039678, 5526.171074338801, 5542.974549708317, 5728.169415434739, 5740.052891272977, 5786.495511167127, 5786.652800831964, 5403.324584426947, 5424.294841670558, 5454.618176727591, 5456.61803673747, 5521.0, 3015.653199881998, 3055.114016935064, 3064.2492589315316, 3068.2789544457037, 3073.4775088235056, 5836.212111364996, 5915.319738230072, 5953.576693401225, 6192.845178870474, 6234.096056071935, 6100.48145907594, 6116.908246376308, 6119.296280927751, 6120.326764055951, 6133.570650054543, 5909.349971503045, 6230.850356626956, 6258.249010118815, 6278.46633036197, 6289.496840252768, 5886.735096920564, 5930.347661757117, 6004.309504406874, 6007.519398448201, 6007.90988135187, 5908.675022873783, 5942.286925568959, 5945.346011938596, 5980.312264089512, 5982.401759824157, 5990.7304171311525, 6215.886598556513, 6268.404501572343, 6274.278457977391, 6293.255512969776, 4339.956600434081, 4351.695381323277, 4356.869293921188, 4367.039251364822, 4379.321205213197, 5732.8182858512255, 6013.579049466495, 6057.727402266997, 6066.757329706938, 6077.2099627049965, 5796.94203057964, 5814.418558144152, 5825.3883342248455, 5826.621269617631, 5839.7372118255635, 5774.797882074107, 5794.69619335663, 5795.189333173324, 5814.970925145347, 5841.620294680833, 5444.945550544444, 5503.944960550503, 5762.683052432157, 5784.334801497882, 5813.128030795415, 5781.8554536136935, 5820.592558520862, 5829.883402331845, 5844.386339434298, 5845.561582881216, 5581.972090139523, 5689.715514224355, 5697.772089116389, 5712.742926568231, 5732.57005724564], "value": 4411.408825371065, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [703.0614130136267, 757.2957149850637, 763.9923600763991, 769.7036640893255, 823.1480417767611, 13847.446102155915, 14639.487617933375, 14826.0, 14864.33110510027, 14868.702625947475, 13292.468301267938, 13513.527026554073, 14789.40842366304, 15786.763198552031, 15844.445444409448, 825.0923983618018, 840.7183593496155, 845.1717317029315, 845.7166849105557, 846.5640195299426, 843.7426584891606, 844.9619767110495, 846.4075147396816, 846.5894041389921, 847.3856454070811, 888.7244954064229, 889.6485888074207, 890.6660002499062, 891.545311890937, 891.9197272245497, 887.2591386192537, 887.4320434921623, 887.4941283468426, 888.1961824548762, 890.496869268861, 650.6584043377218, 651.062470043141, 651.1047309948821, 651.2933467188107, 651.5829868883918, 14993.17537535435, 14994.325255363427, 15030.924845375812, 15040.473583424528, 15068.321925513379, 14494.275286235646, 14698.779518307234, 14926.552203433914, 14931.701365972729, 15002.624934376729, 11334.603288884931, 11451.0, 11545.538178472934, 11569.595064172714, 11881.168318217728, 3740.083679498513, 3751.0, 3764.3224219640456, 3810.428435734662, 3865.768053916774, 54257.45742542603, 56035.0, 56838.43161568414, 64367.67816160889, 65712.671436643, 10764.192685548614, 10782.67651970442, 10886.510107045202, 11090.279131856403, 12114.81827772584, 17643.20605572752, 17772.9336239826, 19334.709979350322, 20714.48213794667, 21003.78996210049, 8108.75673729789, 8154.143814899468, 8202.425830191829, 8472.19514146155, 8518.23335899772, 4486.663500237495, 4525.570070843265, 4558.452985641744, 4649.023705021916, 4698.859034228979, 3314.502824576333, 3366.562346894937, 3376.4260075787174, 3416.145963509123, 3856.8650097246464, 679.9558028728117, 688.4458011300851, 690.8963655451722, 700.8002719224996, 701.421327404893, 669.3808227389645, 699.8880179171308, 720.2653293640458, 734.6436978065634, 755.8110472381904, 9571.37786043905, 9662.75843103928, 9830.361026533395, 9846.359986600992, 10100.393976361442, 645.4158986117571, 669.6317025635881, 673.9797806065826, 677.9084823548857, 723.3706675192511, 4781.378420805273, 4859.149648811514, 4917.213245880642, 4947.282644016597, 4958.42978057528, 62464.0, 83869.58065209635, 91684.54157729301, 93830.0, 95232.52383738037, 75231.62384188153, 75990.6200468994, 76718.6164069176, 77078.0, 77427.0, 69935.0, 70533.2946670537, 71266.64366678237, 71848.64075679693, 74203.62898185475, 9255.398399104037, 9263.722088337361, 9479.857802133112, 9585.870949518432, 9647.421154730739, 41270.793646031576, 42265.1546969065, 43244.0, 49836.501634983186, 51316.97366052733, 51643.483565163864, 53327.46672533225, 61515.692421537606, 61724.0, 61777.76444471176, 12922.224666519664, 12948.741025179632, 13000.219986800823, 13000.479980800663, 13343.199408035549, 13713.862861371657, 13791.0, 14075.788863167265, 14891.925540372229, 15194.088354698753, 14293.57119286423, 14375.28123593837, 14446.277686115862, 14950.476733314283, 15299.0, 13162.276074815976, 13413.798793017917, 13926.651833704238, 13978.860211397756, 14226.217558034408, 13084.934575327063, 13100.672483187996, 13490.52783152585, 13909.860901391261, 14546.563603091925, 10987.230893837674, 11135.387553684624, 11666.650000499998, 11694.941525292319, 12319.076069294659, 10359.533820978224, 11514.712132196762, 11585.0, 11636.709082273012, 11798.764024719287], "value": 7309.182941084953, "unit": "score"}], "name": "dromaeo_css", "value": 7303.910569703657, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 110.0, 112.0, 110.0, 112.0, 110.0, 109.0, 110.0, 111.0, 111.0], "value": 110.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 123.0, 125.0, 170.0, 125.0, 124.0, 122.0, 124.0, 153.0, 123.0], "value": 134.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 159.0, 159.0, 161.0, 160.0, 160.0, 159.0, 159.0, 163.0], "value": 160.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 75.0, 107.0, 77.0, 77.0, 75.0, 76.0, 113.0, 75.0], "value": 82.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 81.0, 110.0, 82.0, 82.0, 82.0, 98.0, 83.0, 81.0, 115.0], "value": 89.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 116.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 147.0, 146.0, 146.0, 147.0, 146.0, 146.0, 146.0], "value": 146.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 84.0, 84.0, 84.0, 85.0, 85.0, 85.0, 84.0, 84.0], "value": 84.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 52.0, 49.0, 50.0, 52.0, 49.0, 50.0, 49.0, 50.0, 49.0], "value": 50.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 58.0, 58.0, 59.0, 59.0, 58.0, 59.0, 59.0, 59.0, 60.0], "value": 58.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 76.0, 76.0, 85.0, 78.0, 76.0, 75.0, 76.0], "value": 77.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 125.0, 131.0, 137.0, 137.0, 126.0, 122.0, 134.0, 173.0, 136.0], "value": 134.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 154.0, 157.0, 153.0, 163.0, 158.0, 153.0, 152.0, 155.0, 153.0], "value": 155.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 61.0, 63.0, 62.0, 62.0, 61.0, 60.0, 61.0, 61.0, 60.0], "value": 61.3, "unit": "score"}], "name": "kraken", "value": 1461.1999999999998, "alertThreshold": 2.0}]} 03:55:24 INFO - Return code: 0 03:55:24 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:55:24 ERROR - # TBPL SUCCESS # 03:55:24 INFO - Running post-action listener: _resource_record_post_action 03:55:24 INFO - [mozharness: 2016-11-23 11:55:24.713080Z] Finished run-tests step (success) 03:55:24 INFO - Running post-run listener: _resource_record_post_run 03:55:24 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 610304; Write bytes: 366489600; Read time: 236; Write time: 238628 03:55:24 INFO - TinderboxPrint: CPU usage
13.0% 03:55:24 INFO - TinderboxPrint: I/O read bytes / time
610,304 / 236 03:55:24 INFO - TinderboxPrint: I/O write bytes / time
366,489,600 / 238,628 03:55:24 INFO - TinderboxPrint: CPU idle
8,280.5 (87.0%) 03:55:24 INFO - TinderboxPrint: CPU user
1,189.3 (12.5%) 03:55:24 INFO - TinderboxPrint: Swap in / out
0 / 0 03:55:24 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 118874112; Read time: 0; Write time: 72480 03:55:24 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 606208; Write bytes: 247054336; Read time: 224; Write time: 166104 03:55:25 INFO - Running post-run listener: _upload_blobber_files 03:55:25 INFO - Blob upload gear active. 03:55:25 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:55:25 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 03:55:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:55:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:55:25 INFO - (blobuploader) - INFO - Open directory for files ... 03:55:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:55:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:55:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:55:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:55:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:55:26 INFO - (blobuploader) - INFO - Done attempting. 03:55:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:55:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:55:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:55:29 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:55:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:55:29 INFO - (blobuploader) - INFO - Done attempting. 03:55:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:55:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:55:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:55:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:55:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:55:30 INFO - (blobuploader) - INFO - Done attempting. 03:55:30 INFO - (blobuploader) - INFO - Iteration through files over. 03:55:30 INFO - Return code: 0 03:55:30 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:55:30 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:55:30 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2935bde1fbb1a1ebe418977c27ce863f2b128c26ab3bb824f30aab0d627952742830857ea8fb8a245541ba576011a8db3c4955d54d35c8b64a58fde3d570e537", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/73b826429e57287f41f457137651070c2bcc6c8bc72d9cf049fb083c43d1c3d0696bd945606c1acf9ce92087edb7e1521a7f2dd75c1718bac60182c58295485e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5f19c6ca3bac90616ba41e624498e3e87e070dafe7399672b546faae0580736f19bbc9b3b2e0ad4180d46064728c808d7b3a0dc1dc7e7fcb7a134258f1bd9fd3"} 03:55:30 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:55:30 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:55:30 INFO - Contents: 03:55:30 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2935bde1fbb1a1ebe418977c27ce863f2b128c26ab3bb824f30aab0d627952742830857ea8fb8a245541ba576011a8db3c4955d54d35c8b64a58fde3d570e537", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/73b826429e57287f41f457137651070c2bcc6c8bc72d9cf049fb083c43d1c3d0696bd945606c1acf9ce92087edb7e1521a7f2dd75c1718bac60182c58295485e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5f19c6ca3bac90616ba41e624498e3e87e070dafe7399672b546faae0580736f19bbc9b3b2e0ad4180d46064728c808d7b3a0dc1dc7e7fcb7a134258f1bd9fd3"} 03:55:30 INFO - Running post-run listener: copy_logs_to_upload_dir 03:55:30 INFO - Copying logs to upload dir... 03:55:30 INFO - mkdir: /builds/slave/test/build/upload/logs 03:55:30 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.619201 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-11-23 03:55:30.659006) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-23 03:55:30.662748) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1479900894.392157-1331946887 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2935bde1fbb1a1ebe418977c27ce863f2b128c26ab3bb824f30aab0d627952742830857ea8fb8a245541ba576011a8db3c4955d54d35c8b64a58fde3d570e537", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/73b826429e57287f41f457137651070c2bcc6c8bc72d9cf049fb083c43d1c3d0696bd945606c1acf9ce92087edb7e1521a7f2dd75c1718bac60182c58295485e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5f19c6ca3bac90616ba41e624498e3e87e070dafe7399672b546faae0580736f19bbc9b3b2e0ad4180d46064728c808d7b3a0dc1dc7e7fcb7a134258f1bd9fd3"} build_url:https://queue.taskcluster.net/v1/task/KpTvQbNwRb-Cf0eQ406vbw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.012029 build_url: 'https://queue.taskcluster.net/v1/task/KpTvQbNwRb-Cf0eQ406vbw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2935bde1fbb1a1ebe418977c27ce863f2b128c26ab3bb824f30aab0d627952742830857ea8fb8a245541ba576011a8db3c4955d54d35c8b64a58fde3d570e537", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/73b826429e57287f41f457137651070c2bcc6c8bc72d9cf049fb083c43d1c3d0696bd945606c1acf9ce92087edb7e1521a7f2dd75c1718bac60182c58295485e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5f19c6ca3bac90616ba41e624498e3e87e070dafe7399672b546faae0580736f19bbc9b3b2e0ad4180d46064728c808d7b3a0dc1dc7e7fcb7a134258f1bd9fd3"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-23 03:55:30.690408) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-23 03:55:30.690795) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1479900894.392157-1331946887 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004404 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-23 03:55:30.772718) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-23 03:55:30.773103) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-23 03:55:30.773474) ========= ========= Total master_lag: 0.16 =========