builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-015 starttime: 1478385271.83 results: success (0) buildid: 20161105132922 builduid: d8fcbde5311b480fbaac85ed62260dc5 revision: 572249b2ffb6ccd84e7fb5ffdf529aceb557ce51 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-05 15:34:31.826930) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-05 15:34:31.827409) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-05 15:34:31.827686) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-05 15:34:31.842687) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-05 15:34:31.843032) ========= 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=20e666a3d4cfbb71505a330e000001b4-1478385271.233659-1212280682 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-05 15:34:32-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 224M=0s 2016-11-05 15:34:32 (224 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.214730 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-05 15:34:32.072289) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-05 15:34:32.072636) ========= 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=20e666a3d4cfbb71505a330e000001b4-1478385271.233659-1212280682 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017349 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-05 15:34:32.123532) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-05 15:34:32.124134) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 572249b2ffb6ccd84e7fb5ffdf529aceb557ce51 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 572249b2ffb6ccd84e7fb5ffdf529aceb557ce51 --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=20e666a3d4cfbb71505a330e000001b4-1478385271.233659-1212280682 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-05 15:34:32,626 truncating revision to first 12 chars 2016-11-05 15:34:32,626 Setting DEBUG logging. 2016-11-05 15:34:32,626 attempt 1/10 2016-11-05 15:34:32,626 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/572249b2ffb6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-05 15:34:33,206 unpacking tar archive at: mozilla-central-572249b2ffb6/testing/mozharness/ program finished with exit code 0 elapsedTime=0.891649 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-05 15:34:33.030618) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-05 15:34:33.031011) ========= script_repo_revision: 572249b2ffb6ccd84e7fb5ffdf529aceb557ce51 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-05 15:34:33.031419) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-05 15:34:33.031682) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-05 15:34:33.040840) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2016-11-05 15:34:33.041298) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=20e666a3d4cfbb71505a330e000001b4-1478385271.233659-1212280682 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:34:33 INFO - MultiFileLogger online at 20161105 15:34:33 in /builds/slave/test 15:34:33 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 15:34:33 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:34:33 INFO - {'append_to_log': False, 15:34:33 INFO - 'base_work_dir': '/builds/slave/test', 15:34:33 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 15:34:33 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:34:33 INFO - 'branch': 'Firefox-Non-PGO', 15:34:33 INFO - 'buildbot_json_path': 'buildprops.json', 15:34:33 INFO - 'config_files': ('talos/linux_config.py',), 15:34:33 INFO - 'default_actions': ('clobber', 15:34:33 INFO - 'read-buildbot-config', 15:34:33 INFO - 'download-and-extract', 15:34:33 INFO - 'populate-webroot', 15:34:33 INFO - 'create-virtualenv', 15:34:33 INFO - 'install', 15:34:33 INFO - 'run-tests'), 15:34:33 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:34:33 INFO - 'download_minidump_stackwalk': True, 15:34:33 INFO - 'download_symbols': 'ondemand', 15:34:33 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:34:33 INFO - 'tooltool.py': '/tools/tooltool.py', 15:34:33 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:34:33 INFO - '/tools/misc-python/virtualenv.py')}, 15:34:33 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:34:33 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:34:33 INFO - 'installer_path': 'installer.exe', 15:34:33 INFO - 'log_level': 'info', 15:34:33 INFO - 'log_name': 'talos', 15:34:33 INFO - 'log_to_console': True, 15:34:33 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:34:33 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:34:33 INFO - 'opt_config_files': (), 15:34:33 INFO - 'pip_index': False, 15:34:33 INFO - 'sps_profile': False, 15:34:33 INFO - 'sps_profile_interval': 0, 15:34:33 INFO - 'suite': 'dromaeojs', 15:34:33 INFO - 'system_bits': '32', 15:34:33 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:34:33 INFO - 'title': 'talos-linux64-ix-015', 15:34:33 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:34:33 INFO - 'use_talos_json': True, 15:34:33 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:34:33 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:34:33 INFO - 'work_dir': 'build'} 15:34:33 INFO - [mozharness: 2016-11-05 22:34:33.714246Z] Running clobber step. 15:34:33 INFO - Running pre-action listener: _resource_record_pre_action 15:34:33 INFO - Running main action method: clobber 15:34:33 INFO - rmtree: /builds/slave/test/build 15:34:33 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:34:34 INFO - Running post-action listener: _resource_record_post_action 15:34:34 INFO - [mozharness: 2016-11-05 22:34:34.134414Z] Finished clobber step (success) 15:34:34 INFO - [mozharness: 2016-11-05 22:34:34.134514Z] Running read-buildbot-config step. 15:34:34 INFO - Running pre-action listener: _resource_record_pre_action 15:34:34 INFO - Running main action method: read_buildbot_config 15:34:34 INFO - Using buildbot properties: 15:34:34 INFO - { 15:34:34 INFO - "project": "", 15:34:34 INFO - "product": "firefox", 15:34:34 INFO - "script_repo_revision": "production", 15:34:34 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 15:34:34 INFO - "repository": "", 15:34:34 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 15:34:34 INFO - "buildid": "20161105132922", 15:34:34 INFO - "pgo_build": "False", 15:34:34 INFO - "basedir": "/builds/slave/test", 15:34:34 INFO - "buildnumber": 286, 15:34:34 INFO - "slavename": "talos-linux64-ix-015", 15:34:34 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 15:34:34 INFO - "platform": "ubuntu64_hw", 15:34:34 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 15:34:34 INFO - "branch": "mozilla-central", 15:34:34 INFO - "repo_path": "mozilla-central", 15:34:34 INFO - "revision": "572249b2ffb6ccd84e7fb5ffdf529aceb557ce51", 15:34:34 INFO - "stage_platform": "linux64", 15:34:34 INFO - "builduid": "d8fcbde5311b480fbaac85ed62260dc5", 15:34:34 INFO - "slavebuilddir": "test" 15:34:34 INFO - } 15:34:34 INFO - Found installer url https://queue.taskcluster.net/v1/task/V8_984PgRWm8O6EMf8KBTQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 15:34:34 INFO - Running post-action listener: _resource_record_post_action 15:34:34 INFO - [mozharness: 2016-11-05 22:34:34.136926Z] Finished read-buildbot-config step (success) 15:34:34 INFO - [mozharness: 2016-11-05 22:34:34.137014Z] Running download-and-extract step. 15:34:34 INFO - Running pre-action listener: _resource_record_pre_action 15:34:34 INFO - Running main action method: download_and_extract 15:34:34 INFO - mkdir: /builds/slave/test/build/tests 15:34:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:34:34 INFO - trying https://queue.taskcluster.net/v1/task/V8_984PgRWm8O6EMf8KBTQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 15:34:34 INFO - Downloading https://queue.taskcluster.net/v1/task/V8_984PgRWm8O6EMf8KBTQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 15:34:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/V8_984PgRWm8O6EMf8KBTQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 15:34:34 INFO - Downloaded 1361 bytes. 15:34:34 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 15:34:34 INFO - Using the following test package requirements: 15:34:34 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 15:34:34 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:34:34 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:34:34 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:34:34 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 15:34:34 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:34:34 INFO - u'jsshell-linux-x86_64.zip'], 15:34:34 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:34:34 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:34:34 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 15:34:34 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:34:34 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:34:34 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:34:34 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:34:34 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:34:34 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:34:34 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:34:34 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:34:34 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:34:34 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/V8_984PgRWm8O6EMf8KBTQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 15:34:34 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/V8_984PgRWm8O6EMf8KBTQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:34:34 INFO - Fetch https://queue.taskcluster.net/v1/task/V8_984PgRWm8O6EMf8KBTQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 15:34:35 INFO - Http code: 200 15:34:35 INFO - via: 1.1 ccaa055c9a26ce13da709353563e04a5.cloudfront.net (CloudFront) 15:34:35 INFO - x-amz-cf-id: xNjoSHXD_5kEPsgTkL87AJwGMa2tc4ytsrKdRtw9aFA4APm3BdYkmA== 15:34:35 INFO - x-amz-version-id: FxBOWTOiUAQvnxp.GPX255ZkGFzdeprs 15:34:35 INFO - Expected file size: 20341131 15:34:35 INFO - Obtained file size: 20341131 15:34:39 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 15:34:39 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/V8_984PgRWm8O6EMf8KBTQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 15:34:39 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/V8_984PgRWm8O6EMf8KBTQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:34:39 INFO - Fetch https://queue.taskcluster.net/v1/task/V8_984PgRWm8O6EMf8KBTQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 15:34:40 INFO - Http code: 200 15:34:40 INFO - via: 1.1 bb8a7ff26b131d51953dc2d3e19a2751.cloudfront.net (CloudFront) 15:34:40 INFO - x-amz-cf-id: Ag056CFEEwopzc8JdHsqBP1xUc2El39msekw7KqdcfHN1i7V2jRu7Q== 15:34:40 INFO - x-amz-version-id: FxBOWTOiUAQvnxp.GPX255ZkGFzdeprs 15:34:40 INFO - Expected file size: 20341131 15:34:40 INFO - Obtained file size: 20341131 15:34:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/V8_984PgRWm8O6EMf8KBTQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 15:34:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/V8_984PgRWm8O6EMf8KBTQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 15:34:44 INFO - Fetch https://queue.taskcluster.net/v1/task/V8_984PgRWm8O6EMf8KBTQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 15:34:45 INFO - Http code: 200 15:34:45 INFO - via: 1.1 c0740de9f16cf32ffedfd2f9806b8483.cloudfront.net (CloudFront) 15:34:45 INFO - x-amz-cf-id: pMrPPfYodvHGFkOmsIAnElY9jmTFg1MXAHVfh1T2OuJURgSzAyYz4A== 15:34:45 INFO - x-amz-version-id: _ABAwidjkTQGkihVR0ZZFu8w0pn9AbmW 15:34:45 INFO - Expected file size: 14409038 15:34:45 INFO - Obtained file size: 14409038 15:34:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:34:45 INFO - trying https://queue.taskcluster.net/v1/task/V8_984PgRWm8O6EMf8KBTQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 15:34:45 INFO - Downloading https://queue.taskcluster.net/v1/task/V8_984PgRWm8O6EMf8KBTQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 15:34:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/V8_984PgRWm8O6EMf8KBTQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 15:34:46 INFO - Downloaded 55499473 bytes. 15:34:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/V8_984PgRWm8O6EMf8KBTQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 15:34:46 INFO - mkdir: /builds/slave/test/properties 15:34:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:34:46 INFO - Writing to file /builds/slave/test/properties/build_url 15:34:46 INFO - Contents: 15:34:46 INFO - build_url:https://queue.taskcluster.net/v1/task/V8_984PgRWm8O6EMf8KBTQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 15:34:47 INFO - Running post-action listener: _resource_record_post_action 15:34:47 INFO - Running post-action listener: set_extra_try_arguments 15:34:47 INFO - [mozharness: 2016-11-05 22:34:47.546362Z] Finished download-and-extract step (success) 15:34:47 INFO - [mozharness: 2016-11-05 22:34:47.546589Z] Running populate-webroot step. 15:34:47 INFO - Running pre-action listener: _resource_record_pre_action 15:34:47 INFO - Running main action method: populate_webroot 15:34:47 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:34:47 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:34:47 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:34:47 INFO - '--tppagecycles', 15:34:47 INFO - '7'], 15:34:47 INFO - 'tests': ['tsvgm']}}, 15:34:47 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:34:47 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:34:47 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:34:47 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:34:47 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:34:47 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:34:47 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:34:47 INFO - 'talos_options': ['--disable-e10s'], 15:34:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:34:47 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:34:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:34:47 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:34:47 INFO - 'talos_options': ['--disable-e10s'], 15:34:47 INFO - 'tests': ['damp', 'tps']}, 15:34:47 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:34:47 INFO - 'tests': ['damp', 'tps']}, 15:34:47 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:34:47 INFO - 'tests': ['dromaeo_dom']}, 15:34:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:34:47 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:34:47 INFO - 'tests': ['basic_compositor_video']}, 15:34:47 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:34:47 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:34:47 INFO - 'tests': ['a11yr', 15:34:47 INFO - 'ts_paint', 15:34:47 INFO - 'tpaint', 15:34:47 INFO - 'sessionrestore', 15:34:47 INFO - 'sessionrestore_no_auto_restore', 15:34:47 INFO - 'tabpaint']}, 15:34:47 INFO - 'other-e10s': {'tests': ['a11yr', 15:34:47 INFO - 'ts_paint', 15:34:47 INFO - 'tpaint', 15:34:47 INFO - 'sessionrestore', 15:34:47 INFO - 'sessionrestore_no_auto_restore', 15:34:47 INFO - 'tabpaint']}, 15:34:47 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:34:47 INFO - 'ts_paint', 15:34:47 INFO - 'tpaint', 15:34:47 INFO - 'sessionrestore', 15:34:47 INFO - 'sessionrestore_no_auto_restore', 15:34:47 INFO - 'tabpaint']}, 15:34:47 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:34:47 INFO - 'ts_paint', 15:34:47 INFO - 'tpaint', 15:34:47 INFO - 'sessionrestore', 15:34:47 INFO - 'sessionrestore_no_auto_restore', 15:34:47 INFO - 'tabpaint']}, 15:34:47 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:34:47 INFO - 'tests': ['a11yr', 15:34:47 INFO - 'ts_paint', 15:34:47 INFO - 'tpaint', 15:34:47 INFO - 'sessionrestore', 15:34:47 INFO - 'sessionrestore_no_auto_restore', 15:34:47 INFO - 'tabpaint']}, 15:34:47 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:34:47 INFO - 'tests': ['a11yr', 15:34:47 INFO - 'ts_paint', 15:34:47 INFO - 'tpaint', 15:34:47 INFO - 'sessionrestore', 15:34:47 INFO - 'sessionrestore_no_auto_restore', 15:34:47 INFO - 'tabpaint']}, 15:34:47 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:34:47 INFO - 'tests': ['tsvgx', 15:34:47 INFO - 'tsvgr_opacity', 15:34:47 INFO - 'tart', 15:34:47 INFO - 'tscrollx', 15:34:47 INFO - 'cart']}, 15:34:47 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:34:47 INFO - 'tsvgr_opacity', 15:34:47 INFO - 'tart', 15:34:47 INFO - 'tscrollx', 15:34:47 INFO - 'cart']}, 15:34:47 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:34:47 INFO - 'talos_options': ['--disable-e10s'], 15:34:47 INFO - 'tests': ['tp5o']}, 15:34:47 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:34:47 INFO - 'tests': ['tp5o']}, 15:34:47 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:34:47 INFO - 'talos_options': ['--disable-e10s', 15:34:47 INFO - '--xperf_path', 15:34:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:34:47 INFO - 'tests': ['tp5n']}, 15:34:47 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:34:47 INFO - 'talos_options': ['--xperf_path', 15:34:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:34:47 INFO - 'tests': ['tp5n']}}, 15:34:47 INFO - 'talos.zip': {'path': '', 15:34:47 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:34:47 INFO - Running post-action listener: _resource_record_post_action 15:34:47 INFO - [mozharness: 2016-11-05 22:34:47.566672Z] Finished populate-webroot step (success) 15:34:47 INFO - [mozharness: 2016-11-05 22:34:47.566760Z] Running create-virtualenv step. 15:34:47 INFO - Running pre-action listener: _resource_record_pre_action 15:34:47 INFO - Running main action method: create_virtualenv 15:34:47 INFO - Creating virtualenv /builds/slave/test/build/venv 15:34:47 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 15:34:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:34:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:34:47 INFO - Using real prefix '/usr' 15:34:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:34:48 INFO - Installing distribute.............................................................................................................................................................................................done. 15:34:51 INFO - Installing pip.................done. 15:34:51 INFO - Return code: 0 15:34:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 15:34:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 15:34:52 INFO - Reading from file tmpfile_stdout 15:34:52 INFO - Output received: 15:34:52 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) 15:34:52 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:34:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:34:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:34:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:34:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:34:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:34:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:34:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff6d8326f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2801ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27fef60>, '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 0x27ffd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28001d0>, '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': '20e666a3d4cfbb71505a330e000001b4-1478385271.233659-1212280682', '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 15:34:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 15:34:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 15:34:52 INFO - Using env: {'DISPLAY': ':0', 15:34:52 INFO - 'HOME': '/home/cltbld', 15:34:52 INFO - 'LANG': 'en_US.UTF-8', 15:34:52 INFO - 'LANGUAGE': 'en_US:en', 15:34:52 INFO - 'LOGNAME': 'cltbld', 15:34:52 INFO - 'MAIL': '/var/mail/cltbld', 15:34:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:34:52 INFO - 'MOZ_NO_REMOTE': '1', 15:34:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:34:52 INFO - 'NO_EM_RESTART': '1', 15:34:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:34:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:34:52 INFO - 'PWD': '/builds/slave/test', 15:34:52 INFO - 'SHELL': '/bin/bash', 15:34:52 INFO - 'SHLVL': '1', 15:34:52 INFO - 'TERM': 'linux', 15:34:52 INFO - 'TMOUT': '86400', 15:34:52 INFO - 'USER': 'cltbld', 15:34:52 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1478385271.233659-1212280682', 15:34:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:34:52 INFO - '_': '/tools/buildbot/bin/python'} 15:34:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:34:52 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 15:34:52 INFO - Cleaning up... 15:34:52 INFO - Return code: 0 15:34:52 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:34:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:34:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:34:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:34:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:34:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:34:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:34:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7ff6d8326f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2801ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27fef60>, '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 0x27ffd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28001d0>, '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': '20e666a3d4cfbb71505a330e000001b4-1478385271.233659-1212280682', '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 15:34:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 15:34:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 15:34:52 INFO - Using env: {'DISPLAY': ':0', 15:34:52 INFO - 'HOME': '/home/cltbld', 15:34:52 INFO - 'LANG': 'en_US.UTF-8', 15:34:52 INFO - 'LANGUAGE': 'en_US:en', 15:34:52 INFO - 'LOGNAME': 'cltbld', 15:34:52 INFO - 'MAIL': '/var/mail/cltbld', 15:34:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:34:52 INFO - 'MOZ_NO_REMOTE': '1', 15:34:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:34:52 INFO - 'NO_EM_RESTART': '1', 15:34:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:34:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:34:52 INFO - 'PWD': '/builds/slave/test', 15:34:52 INFO - 'SHELL': '/bin/bash', 15:34:52 INFO - 'SHLVL': '1', 15:34:52 INFO - 'TERM': 'linux', 15:34:52 INFO - 'TMOUT': '86400', 15:34:52 INFO - 'USER': 'cltbld', 15:34:52 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1478385271.233659-1212280682', 15:34:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:34:52 INFO - '_': '/tools/buildbot/bin/python'} 15:34:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:34:52 INFO - Downloading/unpacking psutil>=3.1.1 15:34:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:34:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:34:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:34:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:34:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:34:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:34:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:34:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:34:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:34:54 INFO - Installing collected packages: psutil 15:34:54 INFO - Running setup.py install for psutil 15:34:54 INFO - building 'psutil._psutil_linux' extension 15:34:54 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 15:34:56 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 15:34:56 INFO - building 'psutil._psutil_posix' extension 15:34:56 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 15:34:56 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 15:34:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:34:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:34:56 INFO - Successfully installed psutil 15:34:56 INFO - Cleaning up... 15:34:56 INFO - Return code: 0 15:34:56 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15: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')]} 15:34:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:34:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15: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')]} 15:34:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:34:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:34:56 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 0x7ff6d8326f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2801ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27fef60>, '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 0x27ffd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28001d0>, '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': '20e666a3d4cfbb71505a330e000001b4-1478385271.233659-1212280682', '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 15:34:56 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 15:34:56 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 15:34:56 INFO - Using env: {'DISPLAY': ':0', 15:34:56 INFO - 'HOME': '/home/cltbld', 15:34:56 INFO - 'LANG': 'en_US.UTF-8', 15:34:56 INFO - 'LANGUAGE': 'en_US:en', 15:34:56 INFO - 'LOGNAME': 'cltbld', 15:34:56 INFO - 'MAIL': '/var/mail/cltbld', 15:34:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:34:56 INFO - 'MOZ_NO_REMOTE': '1', 15:34:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:34:56 INFO - 'NO_EM_RESTART': '1', 15:34:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:34:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:34:56 INFO - 'PWD': '/builds/slave/test', 15:34:56 INFO - 'SHELL': '/bin/bash', 15:34:56 INFO - 'SHLVL': '1', 15:34:56 INFO - 'TERM': 'linux', 15:34:56 INFO - 'TMOUT': '86400', 15:34:56 INFO - 'USER': 'cltbld', 15:34:56 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1478385271.233659-1212280682', 15:34:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:34:56 INFO - '_': '/tools/buildbot/bin/python'} 15:34:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:34:56 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:34:56 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 15:34:56 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 15:34:56 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 15:34:56 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 15:34:56 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 15:34:56 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 15:34:58 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:34:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:34:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:34:58 INFO - Installing collected packages: mozsystemmonitor 15:34:58 INFO - Running setup.py install for mozsystemmonitor 15:34:58 INFO - Successfully installed mozsystemmonitor 15:34:58 INFO - Cleaning up... 15:34:58 INFO - Return code: 0 15:34:58 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:34:58 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')]} 15:34:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:34:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:34:58 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')]} 15:34:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:34:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:34:58 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 0x7ff6d8326f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2801ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27fef60>, '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 0x27ffd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28001d0>, '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': '20e666a3d4cfbb71505a330e000001b4-1478385271.233659-1212280682', '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 15:34:58 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 15:34:58 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 15:34:58 INFO - Using env: {'DISPLAY': ':0', 15:34:58 INFO - 'HOME': '/home/cltbld', 15:34:58 INFO - 'LANG': 'en_US.UTF-8', 15:34:58 INFO - 'LANGUAGE': 'en_US:en', 15:34:58 INFO - 'LOGNAME': 'cltbld', 15:34:58 INFO - 'MAIL': '/var/mail/cltbld', 15:34:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:34:58 INFO - 'MOZ_NO_REMOTE': '1', 15:34:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:34:58 INFO - 'NO_EM_RESTART': '1', 15:34:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:34:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:34:58 INFO - 'PWD': '/builds/slave/test', 15:34:58 INFO - 'SHELL': '/bin/bash', 15:34:58 INFO - 'SHLVL': '1', 15:34:58 INFO - 'TERM': 'linux', 15:34:58 INFO - 'TMOUT': '86400', 15:34:58 INFO - 'USER': 'cltbld', 15:34:58 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1478385271.233659-1212280682', 15:34:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:34:58 INFO - '_': '/tools/buildbot/bin/python'} 15:34:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:34:59 INFO - Downloading/unpacking jsonschema==2.5.1 15:34:59 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 15:34:59 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 15:34:59 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 15:34:59 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 15:34:59 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 15:34:59 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 15:35:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:35:01 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:35:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:35:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:35:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:35:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:35:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:35:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:35:01 INFO - Downloading functools32-3.2.3-2.tar.gz 15:35:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:35:01 INFO - warning: no files found matching '*.txt' 15:35:01 INFO - no previously-included directories found matching 'build' 15:35:01 INFO - no previously-included directories found matching 'dist' 15:35:01 INFO - no previously-included directories found matching '.git*' 15:35:01 INFO - Installing collected packages: jsonschema, functools32 15:35:01 INFO - Running setup.py install for functools32 15:35:01 INFO - warning: no files found matching '*.txt' 15:35:01 INFO - no previously-included directories found matching 'build' 15:35:01 INFO - no previously-included directories found matching 'dist' 15:35:01 INFO - no previously-included directories found matching '.git*' 15:35:01 INFO - Successfully installed jsonschema functools32 15:35:01 INFO - Cleaning up... 15:35:01 INFO - Return code: 0 15:35:01 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:35:01 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')]} 15:35:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:35:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:35:01 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')]} 15:35:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:35:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:35:01 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 0x7ff6d8326f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2801ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27fef60>, '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 0x27ffd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28001d0>, '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': '20e666a3d4cfbb71505a330e000001b4-1478385271.233659-1212280682', '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 15:35:01 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 15:35:01 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 15:35:01 INFO - Using env: {'DISPLAY': ':0', 15:35:01 INFO - 'HOME': '/home/cltbld', 15:35:01 INFO - 'LANG': 'en_US.UTF-8', 15:35:01 INFO - 'LANGUAGE': 'en_US:en', 15:35:01 INFO - 'LOGNAME': 'cltbld', 15:35:01 INFO - 'MAIL': '/var/mail/cltbld', 15:35:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:35:01 INFO - 'MOZ_NO_REMOTE': '1', 15:35:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:35:01 INFO - 'NO_EM_RESTART': '1', 15:35:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:35:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:35:01 INFO - 'PWD': '/builds/slave/test', 15:35:01 INFO - 'SHELL': '/bin/bash', 15:35:01 INFO - 'SHLVL': '1', 15:35:01 INFO - 'TERM': 'linux', 15:35:01 INFO - 'TMOUT': '86400', 15:35:01 INFO - 'USER': 'cltbld', 15:35:01 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1478385271.233659-1212280682', 15:35:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:35:01 INFO - '_': '/tools/buildbot/bin/python'} 15:35:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:35:01 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:35:01 INFO - Cleaning up... 15:35:01 INFO - Return code: 0 15:35:01 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:35:01 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')]} 15:35:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:35:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:35:01 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')]} 15:35:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:35:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:35:01 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 0x7ff6d8326f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2801ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27fef60>, '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 0x27ffd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28001d0>, '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': '20e666a3d4cfbb71505a330e000001b4-1478385271.233659-1212280682', '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 15:35:01 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 15:35:01 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 15:35:01 INFO - Using env: {'DISPLAY': ':0', 15:35:01 INFO - 'HOME': '/home/cltbld', 15:35:01 INFO - 'LANG': 'en_US.UTF-8', 15:35:01 INFO - 'LANGUAGE': 'en_US:en', 15:35:01 INFO - 'LOGNAME': 'cltbld', 15:35:01 INFO - 'MAIL': '/var/mail/cltbld', 15:35:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:35:01 INFO - 'MOZ_NO_REMOTE': '1', 15:35:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:35:01 INFO - 'NO_EM_RESTART': '1', 15:35:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:35:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:35:01 INFO - 'PWD': '/builds/slave/test', 15:35:01 INFO - 'SHELL': '/bin/bash', 15:35:01 INFO - 'SHLVL': '1', 15:35:01 INFO - 'TERM': 'linux', 15:35:01 INFO - 'TMOUT': '86400', 15:35:01 INFO - 'USER': 'cltbld', 15:35:01 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1478385271.233659-1212280682', 15:35:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:35:01 INFO - '_': '/tools/buildbot/bin/python'} 15:35:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:35:02 INFO - Downloading/unpacking blobuploader==1.2.4 15:35:02 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 15:35:02 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 15:35:02 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 15:35:02 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 15:35:02 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 15:35:02 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 15:35:03 INFO - Downloading blobuploader-1.2.4.tar.gz 15:35:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:35:04 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:35:04 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 15:35:04 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 15:35:04 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 15:35:04 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 15:35:04 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 15:35:04 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 15:35:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:35:04 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:35:04 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 15:35:04 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 15:35:04 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 15:35:04 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 15:35:04 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 15:35:04 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 15:35:04 INFO - Downloading docopt-0.6.1.tar.gz 15:35:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:35:04 INFO - Installing collected packages: blobuploader, requests, docopt 15:35:04 INFO - Running setup.py install for blobuploader 15:35:04 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:35:04 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:35:04 INFO - Running setup.py install for requests 15:35:05 INFO - Running setup.py install for docopt 15:35:05 INFO - Successfully installed blobuploader requests docopt 15:35:05 INFO - Cleaning up... 15:35:05 INFO - Return code: 0 15:35:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:35:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:35:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:35:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:35:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:35:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:35:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:35:05 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 0x7ff6d8326f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2801ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27fef60>, '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 0x27ffd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28001d0>, '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': '20e666a3d4cfbb71505a330e000001b4-1478385271.233659-1212280682', '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 15:35:05 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 15:35:05 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 15:35:05 INFO - Using env: {'DISPLAY': ':0', 15:35:05 INFO - 'HOME': '/home/cltbld', 15:35:05 INFO - 'LANG': 'en_US.UTF-8', 15:35:05 INFO - 'LANGUAGE': 'en_US:en', 15:35:05 INFO - 'LOGNAME': 'cltbld', 15:35:05 INFO - 'MAIL': '/var/mail/cltbld', 15:35:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:35:05 INFO - 'MOZ_NO_REMOTE': '1', 15:35:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:35:05 INFO - 'NO_EM_RESTART': '1', 15:35:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:35:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:35:05 INFO - 'PWD': '/builds/slave/test', 15:35:05 INFO - 'SHELL': '/bin/bash', 15:35:05 INFO - 'SHLVL': '1', 15:35:05 INFO - 'TERM': 'linux', 15:35:05 INFO - 'TMOUT': '86400', 15:35:05 INFO - 'USER': 'cltbld', 15:35:05 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1478385271.233659-1212280682', 15:35:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:35:05 INFO - '_': '/tools/buildbot/bin/python'} 15:35:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:35:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:35:05 INFO - Running setup.py (path:/tmp/pip-k26UvB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:35:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:35:05 INFO - Running setup.py (path:/tmp/pip-1Pt4Hb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:35:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:35:05 INFO - Running setup.py (path:/tmp/pip-UH6ZtH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:35:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:35:05 INFO - Running setup.py (path:/tmp/pip-ShJcEn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:35:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:35:05 INFO - Running setup.py (path:/tmp/pip-Cv1Yqx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:35:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:35:05 INFO - Running setup.py (path:/tmp/pip-jN6qfT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:35:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:35:05 INFO - Running setup.py (path:/tmp/pip-iTibUw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:35:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:35:06 INFO - Running setup.py (path:/tmp/pip-uhjz6d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:35:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:35:06 INFO - Running setup.py (path:/tmp/pip-AKkE8K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:35:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:35:06 INFO - Running setup.py (path:/tmp/pip-k3IFrA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:35:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:35:06 INFO - Running setup.py (path:/tmp/pip-Dyz3oV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:35:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:35:06 INFO - Running setup.py (path:/tmp/pip-MzmxtY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:35:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:35:06 INFO - Running setup.py (path:/tmp/pip-569cc_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:35:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:35:06 INFO - Running setup.py (path:/tmp/pip-ZvnZAf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:35:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:35:06 INFO - Running setup.py (path:/tmp/pip-h6DODE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:35:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:35:06 INFO - Running setup.py (path:/tmp/pip-gVuHOK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:35:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:35:06 INFO - Running setup.py (path:/tmp/pip-Gz_f5i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:35:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:35:06 INFO - Running setup.py install for manifestparser 15:35:06 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:35:06 INFO - Running setup.py install for mozcrash 15:35:06 INFO - Running setup.py install for mozdebug 15:35:07 INFO - Running setup.py install for mozdevice 15:35:07 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:35:07 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:35:07 INFO - Running setup.py install for mozfile 15:35:07 INFO - Running setup.py install for mozhttpd 15:35:07 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:35:07 INFO - Running setup.py install for mozinfo 15:35:07 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:35:07 INFO - Running setup.py install for mozInstall 15:35:07 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:35:07 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:35:07 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:35:07 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:35:07 INFO - Running setup.py install for mozleak 15:35:07 INFO - Running setup.py install for mozlog 15:35:07 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:35:07 INFO - Running setup.py install for moznetwork 15:35:07 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:35:07 INFO - Running setup.py install for mozprocess 15:35:08 INFO - Running setup.py install for mozprofile 15:35:08 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:35:08 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:35:08 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:35:08 INFO - Running setup.py install for mozrunner 15:35:08 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:35:08 INFO - Running setup.py install for mozscreenshot 15:35:08 INFO - Running setup.py install for moztest 15:35:08 INFO - Running setup.py install for mozversion 15:35:08 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:35:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:35:08 INFO - Cleaning up... 15:35:08 INFO - Return code: 0 15:35:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15: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')]} 15:35:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:35:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15: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')]} 15:35:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:35:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:35:08 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 0x7ff6d8326f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2801ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27fef60>, '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 0x27ffd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28001d0>, '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': '20e666a3d4cfbb71505a330e000001b4-1478385271.233659-1212280682', '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 15:35:08 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 15:35:08 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 15:35:08 INFO - Using env: {'DISPLAY': ':0', 15:35:08 INFO - 'HOME': '/home/cltbld', 15:35:08 INFO - 'LANG': 'en_US.UTF-8', 15:35:08 INFO - 'LANGUAGE': 'en_US:en', 15:35:08 INFO - 'LOGNAME': 'cltbld', 15:35:08 INFO - 'MAIL': '/var/mail/cltbld', 15:35:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:35:08 INFO - 'MOZ_NO_REMOTE': '1', 15:35:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:35:08 INFO - 'NO_EM_RESTART': '1', 15:35:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:35:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:35:08 INFO - 'PWD': '/builds/slave/test', 15:35:08 INFO - 'SHELL': '/bin/bash', 15:35:08 INFO - 'SHLVL': '1', 15:35:08 INFO - 'TERM': 'linux', 15:35:08 INFO - 'TMOUT': '86400', 15:35:08 INFO - 'USER': 'cltbld', 15:35:08 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1478385271.233659-1212280682', 15:35:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:35:08 INFO - '_': '/tools/buildbot/bin/python'} 15:35:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:35:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:35:08 INFO - Running setup.py (path:/tmp/pip-xEtqcA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:35:08 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)) 15:35:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:35:08 INFO - Running setup.py (path:/tmp/pip-xGj2MR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:35:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:35:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:35:08 INFO - Running setup.py (path:/tmp/pip-rKMT5A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:35:09 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)) 15:35:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:35:09 INFO - Running setup.py (path:/tmp/pip-KPKXGt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:35:09 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)) 15:35:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:35:09 INFO - Running setup.py (path:/tmp/pip-imUsPi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:35:09 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)) 15:35:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:35:09 INFO - Running setup.py (path:/tmp/pip-rW6LSy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:35:09 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)) 15:35:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:35:09 INFO - Running setup.py (path:/tmp/pip-pCcTxv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:35:09 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)) 15:35:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:35:09 INFO - Running setup.py (path:/tmp/pip-WCjVHs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:35:09 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)) 15:35:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:35:09 INFO - Running setup.py (path:/tmp/pip-wiOdRH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:35:09 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)) 15:35:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:35:09 INFO - Running setup.py (path:/tmp/pip-FH8HKG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:35:09 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)) 15:35:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:35:09 INFO - Running setup.py (path:/tmp/pip-eg7CKR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:35:09 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)) 15:35:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:35:09 INFO - Running setup.py (path:/tmp/pip-xMXgqD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:35:09 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)) 15:35:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:35:09 INFO - Running setup.py (path:/tmp/pip-oeAmmZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:35:09 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)) 15:35:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:35:09 INFO - Running setup.py (path:/tmp/pip-Lkjau6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:35:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 15:35:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:35:09 INFO - Running setup.py (path:/tmp/pip-cmtNeR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:35:09 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)) 15:35:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:35:09 INFO - Running setup.py (path:/tmp/pip-xJKW6E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:35:09 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)) 15:35:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:35:09 INFO - Running setup.py (path:/tmp/pip-CiAc59-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:35:10 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)) 15:35:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:35:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:35:10 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)) 15:35:10 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)) 15:35:10 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)) 15:35:10 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:35:10 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 15:35:10 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 15:35:10 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 15:35:10 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 15:35:10 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 15:35:10 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 15:35:11 INFO - Downloading blessings-1.6.tar.gz 15:35:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:35:12 INFO - Installing collected packages: blessings 15:35:12 INFO - Running setup.py install for blessings 15:35:12 INFO - Successfully installed blessings 15:35:12 INFO - Cleaning up... 15:35:12 INFO - Return code: 0 15:35:12 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:35:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:35:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:35:12 INFO - Reading from file tmpfile_stdout 15:35:12 INFO - Current package versions: 15:35:12 INFO - argparse == 1.2.1 15:35:12 INFO - blessings == 1.6 15:35:12 INFO - blobuploader == 1.2.4 15:35:12 INFO - docopt == 0.6.1 15:35:12 INFO - functools32 == 3.2.3-2 15:35:12 INFO - jsonschema == 2.5.1 15:35:12 INFO - manifestparser == 1.1 15:35:12 INFO - mozInstall == 1.12 15:35:12 INFO - mozcrash == 0.17 15:35:12 INFO - mozdebug == 0.1 15:35:12 INFO - mozdevice == 0.48 15:35:12 INFO - mozfile == 1.2 15:35:12 INFO - mozhttpd == 0.7 15:35:12 INFO - mozinfo == 0.9 15:35:12 INFO - mozleak == 0.1 15:35:12 INFO - mozlog == 3.4 15:35:12 INFO - moznetwork == 0.27 15:35:12 INFO - mozprocess == 0.23 15:35:12 INFO - mozprofile == 0.28 15:35:12 INFO - mozrunner == 6.12 15:35:12 INFO - mozscreenshot == 0.1 15:35:12 INFO - mozsystemmonitor == 0.3 15:35:12 INFO - moztest == 0.7 15:35:12 INFO - mozversion == 1.4 15:35:12 INFO - psutil == 3.1.1 15:35:12 INFO - requests == 1.2.3 15:35:12 INFO - wsgiref == 0.1.2 15:35:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15: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')]} 15:35:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:35:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15: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')]} 15:35:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:35:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:35:12 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 0x7ff6d8326f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2801ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27fef60>, '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 0x27ffd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28001d0>, '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': '20e666a3d4cfbb71505a330e000001b4-1478385271.233659-1212280682', '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 15:35:12 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 15:35:12 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 15:35:12 INFO - Using env: {'DISPLAY': ':0', 15:35:12 INFO - 'HOME': '/home/cltbld', 15:35:12 INFO - 'LANG': 'en_US.UTF-8', 15:35:12 INFO - 'LANGUAGE': 'en_US:en', 15:35:12 INFO - 'LOGNAME': 'cltbld', 15:35:12 INFO - 'MAIL': '/var/mail/cltbld', 15:35:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:35:12 INFO - 'MOZ_NO_REMOTE': '1', 15:35:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:35:12 INFO - 'NO_EM_RESTART': '1', 15:35:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:35:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:35:12 INFO - 'PWD': '/builds/slave/test', 15:35:12 INFO - 'SHELL': '/bin/bash', 15:35:12 INFO - 'SHLVL': '1', 15:35:12 INFO - 'TERM': 'linux', 15:35:12 INFO - 'TMOUT': '86400', 15:35:12 INFO - 'USER': 'cltbld', 15:35:12 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1478385271.233659-1212280682', 15:35:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:35:12 INFO - '_': '/tools/buildbot/bin/python'} 15:35:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:35:12 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)) 15:35:12 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)) 15:35:12 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)) 15:35:12 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)) 15:35:12 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)) 15:35:12 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)) 15:35:12 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)) 15:35:12 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)) 15:35:12 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)) 15:35:12 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)) 15:35:12 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)) 15:35:12 INFO - Cleaning up... 15:35:12 INFO - Return code: 0 15:35:12 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15: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')]} 15:35:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:35:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15: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')]} 15:35:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:35:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff6d8326f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2801ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27fef60>, '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 0x27ffd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28001d0>, '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': '20e666a3d4cfbb71505a330e000001b4-1478385271.233659-1212280682', '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 15: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', 'jsonschema'] in /builds/slave/test/build 15: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 jsonschema 15:35:12 INFO - Using env: {'DISPLAY': ':0', 15:35:12 INFO - 'HOME': '/home/cltbld', 15:35:12 INFO - 'LANG': 'en_US.UTF-8', 15:35:12 INFO - 'LANGUAGE': 'en_US:en', 15:35:12 INFO - 'LOGNAME': 'cltbld', 15:35:12 INFO - 'MAIL': '/var/mail/cltbld', 15:35:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:35:12 INFO - 'MOZ_NO_REMOTE': '1', 15:35:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:35:12 INFO - 'NO_EM_RESTART': '1', 15:35:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:35:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:35:12 INFO - 'PWD': '/builds/slave/test', 15:35:12 INFO - 'SHELL': '/bin/bash', 15:35:12 INFO - 'SHLVL': '1', 15:35:12 INFO - 'TERM': 'linux', 15:35:12 INFO - 'TMOUT': '86400', 15:35:12 INFO - 'USER': 'cltbld', 15:35:12 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1478385271.233659-1212280682', 15:35:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:35:12 INFO - '_': '/tools/buildbot/bin/python'} 15:35:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:35:12 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:35:12 INFO - Cleaning up... 15:35:12 INFO - Return code: 0 15:35:12 INFO - Running post-action listener: _resource_record_post_action 15:35:12 INFO - Running post-action listener: _start_resource_monitoring 15:35:12 INFO - Starting resource monitoring. 15:35:12 INFO - [mozharness: 2016-11-05 22:35:12.977940Z] Finished create-virtualenv step (success) 15:35:12 INFO - [mozharness: 2016-11-05 22:35:12.978865Z] Running install step. 15:35:12 INFO - Running pre-action listener: _resource_record_pre_action 15:35:12 INFO - Running main action method: install 15:35:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:35:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:35:13 INFO - Reading from file tmpfile_stdout 15:35:13 INFO - Detecting whether we're running mozinstall >=1.0... 15:35:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:35:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:35:13 INFO - Reading from file tmpfile_stdout 15:35:13 INFO - Output received: 15:35:13 INFO - Usage: mozinstall [options] installer 15:35:13 INFO - Options: 15:35:13 INFO - -h, --help show this help message and exit 15:35:13 INFO - -d DEST, --destination=DEST 15:35:13 INFO - Directory to install application into. [default: 15:35:13 INFO - "/builds/slave/test"] 15:35:13 INFO - --app=APP Application being installed. [default: firefox] 15:35:13 INFO - mkdir: /builds/slave/test/build/application 15:35:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 15:35:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 15:35:29 INFO - Reading from file tmpfile_stdout 15:35:29 INFO - Output received: 15:35:29 INFO - /builds/slave/test/build/application/firefox/firefox 15:35:29 INFO - Running post-action listener: _resource_record_post_action 15:35:29 INFO - [mozharness: 2016-11-05 22:35:29.271529Z] Finished install step (success) 15:35:29 INFO - [mozharness: 2016-11-05 22:35:29.271774Z] Running run-tests step. 15:35:29 INFO - Running pre-action listener: _resource_record_pre_action 15:35:29 INFO - Running main action method: run_tests 15:35:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:35:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:35:29 INFO - Python 2.7.3 15:35:29 INFO - Return code: 0 15:35:29 INFO - grabbing minidump binary from tooltool 15:35:29 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')]} 15:35:29 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 0x27fef60>, '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 0x27ffd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28001d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:35:29 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 15:35:29 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 15:35:29 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 15:35:29 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:35:29 INFO - Return code: 0 15:35:29 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:35:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:35:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:35:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:35:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:35:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/V8_984PgRWm8O6EMf8KBTQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--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 15:35:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/V8_984PgRWm8O6EMf8KBTQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-015 --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 15:35:29 INFO - Using env: {'DISPLAY': ':0', 15:35:29 INFO - 'HOME': '/home/cltbld', 15:35:29 INFO - 'LANG': 'en_US.UTF-8', 15:35:29 INFO - 'LANGUAGE': 'en_US:en', 15:35:29 INFO - 'LOGNAME': 'cltbld', 15:35:29 INFO - 'MAIL': '/var/mail/cltbld', 15:35:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:35:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:35:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:35:29 INFO - 'MOZ_NO_REMOTE': '1', 15:35:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:35:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:35:29 INFO - 'NO_EM_RESTART': '1', 15:35:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:35:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:35:29 INFO - 'PWD': '/builds/slave/test', 15:35:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:35:29 INFO - 'SHELL': '/bin/bash', 15:35:29 INFO - 'SHLVL': '1', 15:35:29 INFO - 'TERM': 'linux', 15:35:29 INFO - 'TMOUT': '86400', 15:35:29 INFO - 'USER': 'cltbld', 15:35:29 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1478385271.233659-1212280682', 15:35:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:35:29 INFO - '_': '/tools/buildbot/bin/python'} 15:35:29 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/V8_984PgRWm8O6EMf8KBTQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--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 15:35:29 INFO - mozversion application_buildid: 20161105132922 15:35:29 INFO - mozversion application_changeset: 572249b2ffb6ccd84e7fb5ffdf529aceb557ce51 15:35:29 INFO - mozversion application_display_name: Nightly 15:35:29 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:35:29 INFO - mozversion application_name: Firefox 15:35:29 INFO - mozversion application_remotingname: firefox 15:35:29 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 15:35:29 INFO - mozversion application_vendor: Mozilla 15:35:29 INFO - mozversion application_version: 52.0a1 15:35:29 INFO - mozversion platform_buildid: 20161105132922 15:35:29 INFO - mozversion platform_changeset: 572249b2ffb6ccd84e7fb5ffdf529aceb557ce51 15:35:29 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 15:35:29 INFO - mozversion platform_version: 52.0a1 15:35:29 INFO - using testdate: 1478385329 15:35:29 INFO - actual date: 1478385329 15:35:29 INFO - starting webserver on 'localhost:50188' 15:35:29 INFO - SUITE-START | Running 2 tests 15:35:29 INFO - TEST-START | dromaeo_css 15:35:29 INFO - operating with platform_type : linux_ 15:35:29 INFO - Initialising browser for dromaeo_css test... 15:35:29 INFO - TEST-INFO | started process 3302 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0d3eF1/profile http://localhost:50188/getInfo.html) 15:35:36 INFO - PROCESS | 3302 | __metrics Screen width/height:1600/1200 15:35:36 INFO - PROCESS | 3302 | colorDepth:24 15:35:36 INFO - PROCESS | 3302 | Browser inner width/height: 1024/697 15:35:36 INFO - PROCESS | 3302 | __metrics 15:35:37 INFO - PROCESS | 3302 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 15:35:37 INFO - PROCESS | 3302 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:35:37 INFO - PROCESS | 3302 | console.error: PushService: 15:35:37 INFO - PROCESS | 3302 | stateChangeProcessEnqueue: Error transitioning state 15:35:37 INFO - PROCESS | 3302 | UnknownError 15:35:38 INFO - TEST-INFO | 3302: exit 0 15:35:38 INFO - Browser initialized. 15:35:38 INFO - Running cycle 1/1 for dromaeo_css test... 15:35:38 INFO - TEST-INFO | started process 3385 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0d3eF1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:35:50 INFO - PROCESS | 3385 | RSS: Main: 175259648 15:35:50 INFO - PROCESS | 3385 | 15:36:41 INFO - PROCESS | 3385 | 1478385401732 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] 15:38:56 INFO - PROCESS | 3385 | Cycle 1(1): loaded http://localhost:50188/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50188/tests/dromaeo/cssquery-ext.html) 15:38:57 INFO - PROCESS | 3385 | RSS: Main: 311218176 15:38:57 INFO - PROCESS | 3385 | 15:42:00 INFO - PROCESS | 3385 | Cycle 1(1): loaded http://localhost:50188/tests/dromaeo/cssquery-ext.html (next: http://localhost:50188/tests/dromaeo/cssquery-jquery.html) 15:42:01 INFO - PROCESS | 3385 | RSS: Main: 278126592 15:42:01 INFO - PROCESS | 3385 | 15:45:03 INFO - PROCESS | 3385 | Cycle 1(1): loaded http://localhost:50188/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50188/tests/dromaeo/cssquery-mootools.html) 15:45:03 INFO - PROCESS | 3385 | RSS: Main: 240922624 15:45:03 INFO - PROCESS | 3385 | 15:48:06 INFO - PROCESS | 3385 | Cycle 1(1): loaded http://localhost:50188/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50188/tests/dromaeo/cssquery-prototype.html) 15:48:06 INFO - PROCESS | 3385 | RSS: Main: 221782016 15:48:06 INFO - PROCESS | 3385 | 15:51:09 INFO - PROCESS | 3385 | Cycle 1(1): loaded http://localhost:50188/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50188/tests/dromaeo/cssquery-yui.html) 15:51:10 INFO - PROCESS | 3385 | RSS: Main: 223256576 15:51:10 INFO - PROCESS | 3385 | 15:54:13 INFO - PROCESS | 3385 | Cycle 1(1): loaded http://localhost:50188/tests/dromaeo/cssquery-yui.html (next: http://localhost:50188/tests/dromaeo/cssquery-dojo.html) 15:54:13 INFO - PROCESS | 3385 | RSS: Main: 311971840 15:54:13 INFO - PROCESS | 3385 | 15:54:13 INFO - PROCESS | 3385 | __start_tp_report 15:54:13 INFO - PROCESS | 3385 | _x_x_mozilla_page_load 15:54:13 INFO - PROCESS | 3385 | _x_x_mozilla_page_load_details 15:54:13 INFO - PROCESS | 3385 | |i|pagename|runs| 15:54:13 INFO - PROCESS | 3385 | |0;dojo.html;2648.5365061114308;2668.1061844282162;2688.274165975187;2705.797065220108;2710.0650275654893;4588.90822183557;4653.162430762462;4718.386609740734;4773.689710168836;4804.639652026099;4680.719156850591;4706.035262771133;4750.121227572893;4780.187368147414;4816.301636262749;4283.121959998209;4320.611144996966;4354.97822510887;4362.760048197348;4363.323684828841;3916.8824935251987;4313.525512193672;4401.845935392262;4444.622207112399;4477.843275485358;4216.894577635553;4336.761478118702;4344.066025804467;4429.77851107445;4447.266201076818;4274.2092712848225;4316.352547117926;4328.4156638853665;4329.480462344507;4330.372096046056;4283.678724095674;4309.116631090619;4337.63130133939;4378.64970802335;4385;4672.836450724242;4716.151092803294;4718.268668356411;4760.309755085494;4776.665633405663;5051.722155281458;5060.797568097271;5063.949360506384;5065.797368105272;5109.974450127763;4941.827036053757;4986.202207646759;4992.650514463989;5056.292119103328;5089.720065396402;4715.221988371949;4766.308885211625;4769.189237829577;4811.013742182914;4820.638452116105;5222.477752224747;5236.947630523722;5242.004019236333;5250.212468129735;5289.603279754034;4952.331435256267;5011.774470148852;5025.79896804131;5032.547070763649;5066.746662666852;4871.318015477836;4921;4926.802927882844;4998.90002199954;5058.140116180258;5008.449070602231;5071.5689166420525;5108.463611320833;5114.923276150861;5120.1039818031695;5022.974885125551;5037.269595908573;5042.647014708935;5055.86243095308;5091.516305951003;4075.286824805647;4113.053997580573;4214.05183833635;4227.51383590891;4253.404523366731;3639.9090022749115;3657.6708096271464;3679.1170119171743;3693.2244228711734;3735.7571757835653;4272.829086836492;4283.978580107142;4287.914241715148;4293.5706429356815;4334.609885110355;4993.825216117419;5043.823466178666;5049.267856160836;5051.848444546669;5076.314697515862;4151.522574903925;4178.561251068655;4214.030772922245;4221.409002739558;4256.723312984646;4495.527969563149;4513.458384993822;4525.162844873643;4534.909301814011;4538.546145385501;4749.4063242094735;4750.07373562152;4754.2630892212455;4757.072370887782;4799.520047995173;4847.80608775645;4996.375453068366;4998.050370429607;5018.548330650113;5049.2173713074535;4655.580997710223;4692.155412025868;4721.079389519011;4723.622110231105;4742.881427964328;4998.2502624606595;5003.54968052877;5010.273510341053;5018.121828679893;5059.848204553869;5076.340075790124;5080.644354895122;5081.4664460232625;5084.3898732152375;5120.923186152137;4808.975955120202;4821.059893320768;4888.877778055577;4911.263310503453;4933.161362568444;4925.408950925912;4937.753112344297;4961.900761984668;4987.675801072919;5003.099442100457;4867.440244371943;4888.9488759916785;4894.339264199288;4896.706197628154;4925.605951523941;4756.025014872012;4817.5182481752945;4820.325154478446;5001.474845141208;5067.543921047123;4820.734859582757;4859.732714700725;4866.6350023747655;4870.366852309177;4935.728534930613 15:54:13 INFO - PROCESS | 3385 | |1;ext.html;546.2298159594969;549.7306319903247;558.8519042453753;578.9218455508507;596.961197522161;28211.576826347595;38360.80819595901;40137.9758542255;40225;43792.12415751683;39812.402813957815;40256.19487610246;40266.39600405996;40292.19415611686;40308.19383612326;7619.657115429819;7776.377889768805;7777.300042996129;7779.649915753805;7779.9222007780045;7488.176300606929;7571.583562904038;7575.9621201893915;7576.848463030736;7578.393728501735;7566.4325175611775;7632.656530456143;7633;7637.694492220305;7645.808854778619;7574.4319176061745;7606.581638009935;7615.238476152396;7621.58081305528;7625.885611715828;7671.731489397845;7731.149573546905;7732.072151341818;7733.883991740128;7735.883961740578;38078.23843523114;38326.80836595827;38463.615363846286;38482.80758596217;38518.807405963074;3085.6451508076634;3121.4693502104697;3144.4497212987635;3327.234736010707;3327.2680010397917;27929.301767455774;28205.576916346065;28881.42237155266;29189.85405072961;29274.707252927412;3354.1279267390655;3435.5018522314376;3465.5668041494814;3508.7719298245534;3516.1561225306;240988;242605;243116;243918;244410;52663.21005184925;52955.735221323645;52958;52971.47028529665;53074.73462632662;32279.51580726291;33279.16802079919;33355;34794;55258.17112743312;14858.702825943421;15191.164485953157;15275.770863437057;15284.541463756104;15298.847011529742;11288.209825312313;11639.59261425846;11641.941790290994;11646.592369267035;11649.47577359021;17516.64966700659;17535.561610959572;17544.29822807099;17581.38465153739;17647.73528397075;6341.175647165839;6384.062821575886;6398.424141827258;6528.412442880069;6621.205455345389;760.8059944714173;913.3423934766957;939.910708482693;957.7557722780647;983.2920297385871;26600.8669956649;27075.86462067677;27243.318917026838;27390.726092739216;27892.30269243285;785.6386062411241;893.2184338703635;901.756525738047;950.3442624589012;963.7542426681151;12407.627771166879;15694.372225111096;16329.510114696579;16437.342506299614;17424.825751742574;256116;652205;659981;660481;661095;50554.74722626437;51344;51408.48591514037;51437.7428112857;51486.74256628693;1089.7657003744232;1124.3703526025452;1137.7212582917239;1181.9172657913864;1200.5977997370978;26957.46085078248;28108.70793115995;28365.290867728472;29058.564121538617;29092.854535727187;41576;42297.15405691807;42297.365539516315;42362.15275694407;42379.364309535995;290944;292980;293046;293181;294953;35903.46144807882;36958.44562331621;37531.624683752816;39663.80168099256;40091.39862902117;39197.6080239194;39434.2113157741;39678.60321396864;39751.80124099361;40513.79743101384;35077.824610876785;35096.12259693528;35151;35511.644883550834;35532.644673553965;34828.477572835924;34860.82569587237;35090.122746931534;35220.47169292514;35475.290494190485;34180.65819341874;34583.82708086444;35152.648473514935;35208.823955880056;35466.468002980495;26397.472050558496;27427.725722743315;28107;28196.577051344655;28241;24254.393640158432;24442.75557244476;24460.388490287885;24631.630525541772;24812.50374992454 15:54:13 INFO - PROCESS | 3385 | |2;jquery.html;351.47454555439623;355.3284292686822;356.2625365493428;359.7643543479022;387.32798594438646;12405.751884962307;15543.533693989184;15789.763153552705;17541.3860514882;17656.293748250086;16817.41139060133;16861.494155175333;16871.15644217787;16977.49067527973;16979.83020169801;4821.156297647915;4905.0925578767865;4951.43058548268;5008.549230569248;5036.143855544567;4934.087193869128;5027.899442011158;6431;6786.524943253974;6795.9660201698925;6772.322767723237;6881.44948404129;6885.48358873084;6892.241853396123;6908.274631163706;6500.902486462707;6807.149106361705;6846.041554182419;6953.930460695429;6960.338767817049;6452.774152904626;6588.703508342136;6616.139901812781;6617.536772425884;6700.765473208463;22946;23135.76864231353;23441.41396465102;23672.526549469087;24045;1996.710476980844;2005.3883565512513;2112.86266392684;2182.879941603211;2292.5422904581656;14039.78940315896;14102.858971410256;14289.142651440947;14292.071015383966;14481.710365792731;1780.468528653016;1855.5361159710073;1903.200655724599;1905.9809401905943;1938.2150229157214;82252.58873705653;85873.57063214644;86780.56609716911;88079.55960220222;88304.11695883023;16003.679926401639;16039.919800401156;16451;16743.91628041852;16857.915710421614;28911.56632650512;28963.85518072396;29054;29055;29149.271268218465;8875.4024275631;8930.285577153812;9071.59177836999;9245.583948722324;9557.474338911426;7429.851402972018;7437.8140546486775;7599.544027358376;7805.063392392835;7821.452498325063;7832.295093441504;8173.918260817316;8285.212904774036;8287.544185069759;8402.495850249004;2575.781058610039;3036.7874248802814;3123.5966269148157;3170.726845022112;3292.456744637108;725.9673314700851;808.3290868579065;861.1173547114133;865.5672163918041;930.9069093090636;16084.678306433805;16338.767284553964;16764.58088547796;17090.230939607747;17164.828351716573;801.6112185589984;829.7925518620345;847.4068152293419;904.1410659873147;925.7916968681992;9030.869767857028;9580.904190958141;9593;9613.615455381847;9709.36889102206;361306;361977;363575;363845;364507;70403.64798175976;72097.63951180315;75354.62322688352;75969;77957;834.1741675741094;856.6016802186888;857.6312185760058;858.0347109501811;858.2104463893234;14674.926625366805;14712.926435367755;14765.114093154445;14852.108873467627;15504.302306396465;34117.3543024936;34763.13092172716;35588.822055889555;35880.64119358773;35919.82040089783;48148.759256204896;49781;51440.48559514357;52115;52319.215211772615;6367.172267605181;6721.092652491851;6849.863002740017;6857.794266172023;7053.541519801196;9617.855732163884;11530.76938461243;11578.594749183738;11659.125565582784;11825.881741182478;8622.913770862462;8638.524881131598;9141.77145571366;9592.136707696342;9741.025897410202;9872.851907221253;9912.653057142965;10011.899881001387;10022.699319020441;10296.485175741333;9187.540622968958;9265.583048762686;9375.812483750424;9479.241660667269;9914.851277230702;6123.4488895999575;6125.571210015256;6137.557673946708;6253.687315634291;6435.967820160869;7832.960835195788;8520.275776559061;8713.52075635846;8813.206811387006;9281.953590232006 15:54:13 INFO - PROCESS | 3385 | |3;mootools.html;1307.7776777947747;1352.3643887372934;1385.508144608664;1584.1288782816223;1602.9278682459287;6570.244421891484;7058.541194822339;7062.046623705798;7063.6468176591225;7064.187618423883;6160.753569857212;6340.239171299439;6365.52258580606;6492.3832235937625;6762.763303284386;1826.0139524656702;1879.2483006797322;1935.622553602041;1938.5832046110083;1951.0829909942304;1978.0900785638623;2037.928672496463;2038.4598081508411;2040.4898775306174;2044;1977.5748214133957;1981.9108140133656;2026.7871873453296;2031.1164643380102;2035.4199053269822;1725.30125299254;1796.847267982223;1933.9323123690604;2016.8890711010888;2023.3828682251908;2041.469218003315;2044.499097721053;2057.44448998771;2057.5267688431595;2058.1458694641706;6997.055397521321;7054;7057.364837164629;7059.223485416652;7064.823379415556;4071.389291606253;4188.204241194163;4189.303332150484;4192;4195.119025004753;2566.794656427481;2749.9037533686223;2757.8483183424905;2762.709915458868;2772.0575004498364;831.8045259364045;872.6378552900538;905.7237542549519;915.4461550761827;919.3702313914989;9158.129977652112;9159.26725861936;9165.220956218729;9174.220191283748;9204.263658907272;3651.123730304708;3828.770273783526;3921.3529767588598;3923.6272554107886;3936.842526298916;7907.762767116996;7907.920920790833;7911;7911.5253084815095;7912.881306780403;4265.658747300208;4270.50889147752;4270.743755374625;4272.6795490338345;4273.017206042628;3667.0832291927018;3890.9688932432928;3905.2970465316516;3910.921781564353;3911.2568611964207;3281.425750493702;3308.3052558962886;3380.983095084558;3407.9318413632086;3443.810590417501;1121.3103941076179;1152.7521582859727;1160.4777849967547;1162.3200427749691;1166.288563975974;750.6622020090981;787.4802630264113;789.3251270164042;793.0562630469723;799.8080460689392;4646.3495110684535;4721.551452611996;4734.28985652148;4752.429708434941;4923.310736496894;363.2372018760582;370.9425039118941;372.12736133766276;373.35968813485005;376.5142965574433;3180.0936733030976;3237.5143728440453;3240.9837950810097;3248.9187770305457;3276.672332766704;7953.5227886327;8466.153384661608;8486.830263394697;8488.193621605938;8491.915080849236;8449.32405407566;8452.366072544584;8456.661733530713;8459.957700211582;8467.95766021166;6534.901976470357;6646.26891041985;6647.235567909655;6651.900221496585;6653.234877988996;4551.340055691972;4669.159551280802;4680.3915490985955;4684.320773487757;4730.290456431563;7624.5425274483705;7672.808179795326;7734.066483379155;7790.3378212850275;7791.805204869697;7782.92217077822;7922.643481043252;7975.521468711664;7977.52696664036;7984.121746607752;5841.853953651193;5961.850953726192;5967.850803729942;5984.521238300838;5988.880222395441;6406.167198264196;6464.288928217987;6481.708323125565;6484.546081774419;6488.805335839932;5786.85532861665;5853;5871.060630299132;5933.643981361132;6189;5734.111212762028;5886.793962211302;5887.293524776883;5976.7908123215475;6002.0996850472775;5386.057439948072;5464.672119672832;5469.480399362054;5470.316210473691;5477.4796394342475;3986.402039693953;4112.321466957918;4169.749815011109;4206.831726730897;4306.375575541591;4085.897852553591;4096.877093687194;4129.359949207877;4175;4293.957060429356 15:54:13 INFO - PROCESS | 3385 | |4;prototype.html;283.9701831307713;285.1019289238897;289.1801742061259;291.1629066434002;291.34592839076277;4808.759562021903;4851.1753001989655;4860.326820248867;4882.145624515709;4886.291487734276;4769.833055843046;4774.729310422363;4777.450593181785;4781.330613714074;4815.253635686474;3525.4888041234008;3642.162302670374;3644.6355364463475;3765.698744100479;3775.830087646049;3618.3125206210866;3687.410014397697;3688.723345749066;3727.869524566641;3758.267137908109;3692.5753538343033;3694.6120657331;3698.500702405168;3699.5375578052744;3709.406494960807;3692.4276737105793;3708.7589306694977;3723.590405055442;3730.034622475139;3736.8878933632036;3237.303979644364;3309.5035744638258;3314.767966242364;3321.3025264694443;3331.6168640606397;4630.907381852344;4640.953590464086;4648.767561621906;4660.440747110335;4660.743659098748;4268.487781466244;4279.743215407055;4293.463317085364;4294.484661840568;4299.677524185668;4804;4954.2568614707725;4957.5042495750495;5048.516523598705;5062.772175252123;3618.9191215051187;3620.8913732588067;3622.710183185339;3628.8004159771203;3637.9991004947437;5226.843194704127;5233.162693968947;5243.082460569385;5243.528082472596;5263.684178949237;3647.325244829715;3752;3752.887413377603;3753.6997040236715;3767.1900541383734;3788.6590206881515;3789.2717243584575;3813.3517302058717;3814.809259537012;3823.885283441501;4264.87205383839;4270.850520231839;4285.207236661227;4291.489478654959;4302.935455968163;4955.677880937727;5000.89998200034;5004.074246264453;5014.197728363517;5027.84916452507;1211.7939950208486;1261.2621616354352;1263.848338199422;1268.543324403214;1279.2324605236784;851.1913682001999;858.3004851046377;877.4121338703085;878.8549889268199;884.4428010353565;4150.671785028761;4189.905047476262;4229.725067870579;4244.7739717814065;4259.297215959332;5026.195808670595;5150.27896094547;5165.793368265227;5180.8963820723375;5186;4387.4954380246045;4412.183461305947;4433.224185767478;4438;4460.799264033127;2530.544501989623;2650.310919161032;2654.2302732207445;2667;2669.7196794336314;4669.2996050592;4719.528047195253;4720.386349774507;4732.6687131900435;4733.562215459041;5118.923216151761;5126.282320475137;5151.768170432265;5162.819301324435;5170.844874653766;4634.559716826896;4714.087307534738;4719.905601887943;4733.928991065137;4764.690295130806;5023.748812559431;5031.195008798574;5031.874203144951;5036.647434679684;5069.6197785167;4940.481249468754;4952.306677065286;4953.968872762151;4979.377577802775;4979.551840334388;4576.512633394227;4671.322658214472;4728.38530990969;4728.385309909827;4739.573438390561;3513.418961467401;3515.9824200878834;3517.3844577198374;3523.436250199956;3523.559555055618;4987.576056035277;4991.675541089818;5035.751939998607;5036.29491871131;5042.39491261051;4659.767011649336;4854.684445511171;4874.975625121851;4903.8528844134735;4909.214525675875;4809.519048095162;4830.806767729251;4833.299171620166;4838.782254798472;4863.7324947128245;4760.357351757469;4763.261694437368;4768.141734487686;4770.666053376231;4777.402824646919;4739.549742774431;4858.416989961227;4860.441049279237;4865.80787707014;4878.707277563358;4673.532646735299;4741.525847415231;4755.548222918817;4756.286557016475;4758.643786520964 15:54:13 INFO - PROCESS | 3385 | |5;yui.html;600.7116584039661;654.1136759690617;660.5739298152691;695.1102588686483;712.1809918593617;11753.353565553902;12246.326452045134;12246.93876530616;12255.080868934843;12256.203346782464;11776.470058847352;11821.34982575958;11825;11836.763264734722;11851.288922664624;605.7819185093363;625.0686477149061;733.9559626422432;753.950993185444;756.9659365328573;725.735106686061;752.345459450279;755.5202446446491;756.1380026769488;758.1054355860083;799.1648727080186;800.75977206838;800.8158123631569;801.5070731500115;801.8075661841175;636.0491065856528;654.6399480285824;798.1579433697476;799.1688643810488;799.1808396393714;408.5383516626223;412.2373608823682;417.5761601973999;419.9895002624928;420.22049098921366;12230.938845305805;12248.142630015902;12261.93869030658;12266.080043996735;12332.81500777489;11041.83437248442;11243.494042768096;11354.375509346983;11521.596744114;11830.290182588986;10993.175511836644;11076;11084.113270938306;11123.72190695239;11427.314361138358;3935.527736671589;3954.090559171378;3954.6045395460224;4129.566395528456;4142.979285103585;47221.52778472206;48057.51942480565;48430.27354589684;49407;50229;9197.310201734897;9264;9456.290778191664;9462.384944978554;9548.522573871278;14365.281735913162;14462.855371446361;15024.399024039134;16248.431304904272;16510.091944942902;6033.9698301508215;6085.665288409092;6192.8761424771255;6241.313455519889;6409.9679501602195;3485.6165821759587;3488.965110348864;3544.929101417957;3570.98214508931;3628.63713628635;2476.9752302476745;2546.1979476464853;2560.039985005623;2564.7948164146824;2575.6007818788116;438.110635410118;441.3798612948812;441.8939454530889;449.5976101389238;455.51487665636654;448.4932026809684;474.895867108973;527.9762410691528;587.5974957154363;590.3093380744539;7042.542234754725;7270.236625154388;7308.96345518269;7438.070241219848;7765.961170194226;503.44118028987793;505.54248405193357;509.83430385124984;561.9687872753461;600.6066026752484;3290.391277613649;3357.8321083945707;3399.9490007649906;3437.089171369589;3528.2237907660274;70497;71332.2866771336;72373.27626723771;72397.6380118096;73425.63287183637;61086;62583.299588563845;62830.68584657047;64213.35786642167;66167.33832661709;56359;56836;58338.70830645905;58461.4153858456;60196.398036019076;6669.899951500634;6847.281035491202;6955.304469553004;6979.267176946348;7039.577625342496;37689.43465847959;37922;38271.80864095662;38359.2328153441;40386.19227615373;48551.75724121357;52746.45070985742;53781.73109134429;54164;55911.44088559062;9194.770130746785;9447.433154010781;9522.761930951781;9524.666636667684;9560.569774360032;10087.142592879687;10334.948325258325;10352.113026144021;10491.265611407434;10601.946990265;9305.674301399418;10258.948705256425;10411.323263987817;10464.529096190841;10476.63331783384;11086.113110951266;11262.267952583055;11330.263532870336;11475.655730328104;11636.709082272671;10721.35671859691;11035.448227588427;11120.555177792798;11327.773444531229;11435;8785.560721964004;8822.779430514289;9106;9197.310201734763;9238.584263708015;8369.874451883104;9054.094590540893;9192.35653504275;9311.487868167316;9353.158215760614 15:54:13 INFO - PROCESS | 3385 | __end_tp_report 15:54:13 INFO - PROCESS | 3385 | __start_cc_report 15:54:13 INFO - PROCESS | 3385 | _x_x_mozilla_cycle_collect,1378 15:54:13 INFO - PROCESS | 3385 | __end_cc_report 15:54:13 INFO - PROCESS | 3385 | __startTimestamp1478386453635__endTimestamp 15:54:13 INFO - PROCESS | 3385 | 15:54:13 INFO - PROCESS | 3385 | ------- Summary: start ------- 15:54:13 INFO - PROCESS | 3385 | Number of tests: 6 15:54:13 INFO - PROCESS | 3385 | 15:54:13 INFO - PROCESS | 3385 | [#0] dojo.html Cycles:165 Average:4658.00 Median:4804.64 stddev:499.62 (10.4%) stddev-sans-first:475.64 15:54:13 INFO - PROCESS | 3385 | Values: 2648.5 2668.1 2688.3 2705.8 2710.1 4588.9 4653.2 4718.4 4773.7 4804.6 4680.7 4706.0 4750.1 4780.2 4816.3 4283.1 4320.6 4355.0 4362.8 4363.3 3916.9 4313.5 4401.8 4444.6 4477.8 4216.9 4336.8 4344.1 4429.8 4447.3 4274.2 4316.4 4328.4 4329.5 4330.4 4283.7 4309.1 4337.6 4378.6 4385.0 4672.8 4716.2 4718.3 4760.3 4776.7 5051.7 5060.8 5063.9 5065.8 5110.0 4941.8 4986.2 4992.7 5056.3 5089.7 4715.2 4766.3 4769.2 4811.0 4820.6 5222.5 5236.9 5242.0 5250.2 5289.6 4952.3 5011.8 5025.8 5032.5 5066.7 4871.3 4921.0 4926.8 4998.9 5058.1 5008.4 5071.6 5108.5 5114.9 5120.1 5023.0 5037.3 5042.6 5055.9 5091.5 4075.3 4113.1 4214.1 4227.5 4253.4 3639.9 3657.7 3679.1 3693.2 3735.8 4272.8 4284.0 4287.9 4293.6 4334.6 4993.8 5043.8 5049.3 5051.8 5076.3 4151.5 4178.6 4214.0 4221.4 4256.7 4495.5 4513.5 4525.2 4534.9 4538.5 4749.4 4750.1 4754.3 4757.1 4799.5 4847.8 4996.4 4998.1 5018.5 5049.2 4655.6 4692.2 4721.1 4723.6 4742.9 4998.3 5003.5 5010.3 5018.1 5059.8 5076.3 5080.6 5081.5 5084.4 5120.9 4809.0 4821.1 4888.9 4911.3 4933.2 4925.4 4937.8 4961.9 4987.7 5003.1 4867.4 4888.9 4894.3 4896.7 4925.6 4756.0 4817.5 4820.3 5001.5 5067.5 4820.7 4859.7 4866.6 4870.4 4935.7 15:54:13 INFO - PROCESS | 3385 | 15:54:13 INFO - PROCESS | 3385 | [#1] ext.html Cycles:180 Average:51366.90 Median:35718.05 stddev:110220.06 (308.6%) stddev-sans-first:110463.21 15:54:13 INFO - PROCESS | 3385 | Values: 546.2 549.7 558.9 578.9 597.0 28211.6 38360.8 40138.0 40225.0 43792.1 39812.4 40256.2 40266.4 40292.2 40308.2 7619.7 7776.4 7777.3 7779.6 7779.9 7488.2 7571.6 7576.0 7576.8 7578.4 7566.4 7632.7 7633.0 7637.7 7645.8 7574.4 7606.6 7615.2 7621.6 7625.9 7671.7 7731.1 7732.1 7733.9 7735.9 38078.2 38326.8 38463.6 38482.8 38518.8 3085.6 3121.5 3144.4 3327.2 3327.3 27929.3 28205.6 28881.4 29189.9 29274.7 3354.1 3435.5 3465.6 3508.8 3516.2 240988.0 242605.0 243116.0 243918.0 244410.0 52663.2 52955.7 52958.0 52971.5 53074.7 32279.5 33279.2 33355.0 34794.0 55258.2 14858.7 15191.2 15275.8 15284.5 15298.8 11288.2 11639.6 11641.9 11646.6 11649.5 17516.6 17535.6 17544.3 17581.4 17647.7 6341.2 6384.1 6398.4 6528.4 6621.2 760.8 913.3 939.9 957.8 983.3 26600.9 27075.9 27243.3 27390.7 27892.3 785.6 893.2 901.8 950.3 963.8 12407.6 15694.4 16329.5 16437.3 17424.8 256116.0 652205.0 659981.0 660481.0 661095.0 50554.7 51344.0 51408.5 51437.7 51486.7 1089.8 1124.4 1137.7 1181.9 1200.6 26957.5 28108.7 28365.3 29058.6 29092.9 41576.0 42297.2 42297.4 42362.2 42379.4 290944.0 292980.0 293046.0 293181.0 294953.0 35903.5 36958.4 37531.6 39663.8 40091.4 39197.6 39434.2 39678.6 39751.8 40513.8 35077.8 35096.1 35151.0 35511.6 35532.6 34828.5 34860.8 35090.1 35220.5 35475.3 34180.7 34583.8 35152.6 35208.8 35466.5 26397.5 27427.7 28107.0 28196.6 28241.0 24254.4 24442.8 24460.4 24631.6 24812.5 15:54:13 INFO - PROCESS | 3385 | 15:54:13 INFO - PROCESS | 3385 | [#2] jquery.html Cycles:180 Average:24838.44 Median:6131.56 stddev:60347.32 (984.2%) stddev-sans-first:60488.60 15:54:13 INFO - PROCESS | 3385 | Values: 351.5 355.3 356.3 359.8 387.3 12405.8 15543.5 15789.8 17541.4 17656.3 16817.4 16861.5 16871.2 16977.5 16979.8 4821.2 4905.1 4951.4 5008.5 5036.1 4934.1 5027.9 6431.0 6786.5 6796.0 6772.3 6881.4 6885.5 6892.2 6908.3 6500.9 6807.1 6846.0 6953.9 6960.3 6452.8 6588.7 6616.1 6617.5 6700.8 22946.0 23135.8 23441.4 23672.5 24045.0 1996.7 2005.4 2112.9 2182.9 2292.5 14039.8 14102.9 14289.1 14292.1 14481.7 1780.5 1855.5 1903.2 1906.0 1938.2 82252.6 85873.6 86780.6 88079.6 88304.1 16003.7 16039.9 16451.0 16743.9 16857.9 28911.6 28963.9 29054.0 29055.0 29149.3 8875.4 8930.3 9071.6 9245.6 9557.5 7429.9 7437.8 7599.5 7805.1 7821.5 7832.3 8173.9 8285.2 8287.5 8402.5 2575.8 3036.8 3123.6 3170.7 3292.5 726.0 808.3 861.1 865.6 930.9 16084.7 16338.8 16764.6 17090.2 17164.8 801.6 829.8 847.4 904.1 925.8 9030.9 9580.9 9593.0 9613.6 9709.4 361306.0 361977.0 363575.0 363845.0 364507.0 70403.6 72097.6 75354.6 75969.0 77957.0 834.2 856.6 857.6 858.0 858.2 14674.9 14712.9 14765.1 14852.1 15504.3 34117.4 34763.1 35588.8 35880.6 35919.8 48148.8 49781.0 51440.5 52115.0 52319.2 6367.2 6721.1 6849.9 6857.8 7053.5 9617.9 11530.8 11578.6 11659.1 11825.9 8622.9 8638.5 9141.8 9592.1 9741.0 9872.9 9912.7 10011.9 10022.7 10296.5 9187.5 9265.6 9375.8 9479.2 9914.9 6123.4 6125.6 6137.6 6253.7 6436.0 7833.0 8520.3 8713.5 8813.2 9282.0 15:54:13 INFO - PROCESS | 3385 | 15:54:13 INFO - PROCESS | 3385 | [#3] mootools.html Cycles:180 Average:4557.28 Median:4725.92 stddev:2488.36 (52.7%) stddev-sans-first:2483.35 15:54:13 INFO - PROCESS | 3385 | Values: 1307.8 1352.4 1385.5 1584.1 1602.9 6570.2 7058.5 7062.0 7063.6 7064.2 6160.8 6340.2 6365.5 6492.4 6762.8 1826.0 1879.2 1935.6 1938.6 1951.1 1978.1 2037.9 2038.5 2040.5 2044.0 1977.6 1981.9 2026.8 2031.1 2035.4 1725.3 1796.8 1933.9 2016.9 2023.4 2041.5 2044.5 2057.4 2057.5 2058.1 6997.1 7054.0 7057.4 7059.2 7064.8 4071.4 4188.2 4189.3 4192.0 4195.1 2566.8 2749.9 2757.8 2762.7 2772.1 831.8 872.6 905.7 915.4 919.4 9158.1 9159.3 9165.2 9174.2 9204.3 3651.1 3828.8 3921.4 3923.6 3936.8 7907.8 7907.9 7911.0 7911.5 7912.9 4265.7 4270.5 4270.7 4272.7 4273.0 3667.1 3891.0 3905.3 3910.9 3911.3 3281.4 3308.3 3381.0 3407.9 3443.8 1121.3 1152.8 1160.5 1162.3 1166.3 750.7 787.5 789.3 793.1 799.8 4646.3 4721.6 4734.3 4752.4 4923.3 363.2 370.9 372.1 373.4 376.5 3180.1 3237.5 3241.0 3248.9 3276.7 7953.5 8466.2 8486.8 8488.2 8491.9 8449.3 8452.4 8456.7 8460.0 8468.0 6534.9 6646.3 6647.2 6651.9 6653.2 4551.3 4669.2 4680.4 4684.3 4730.3 7624.5 7672.8 7734.1 7790.3 7791.8 7782.9 7922.6 7975.5 7977.5 7984.1 5841.9 5961.9 5967.9 5984.5 5988.9 6406.2 6464.3 6481.7 6484.5 6488.8 5786.9 5853.0 5871.1 5933.6 6189.0 5734.1 5886.8 5887.3 5976.8 6002.1 5386.1 5464.7 5469.5 5470.3 5477.5 3986.4 4112.3 4169.7 4206.8 4306.4 4085.9 4096.9 4129.4 4175.0 4294.0 15:54:13 INFO - PROCESS | 3385 | 15:54:13 INFO - PROCESS | 3385 | [#4] prototype.html Cycles:180 Average:4110.45 Median:4693.81 stddev:1181.19 (25.2%) stddev-sans-first:1149.05 15:54:13 INFO - PROCESS | 3385 | Values: 284.0 285.1 289.2 291.2 291.3 4808.8 4851.2 4860.3 4882.1 4886.3 4769.8 4774.7 4777.5 4781.3 4815.3 3525.5 3642.2 3644.6 3765.7 3775.8 3618.3 3687.4 3688.7 3727.9 3758.3 3692.6 3694.6 3698.5 3699.5 3709.4 3692.4 3708.8 3723.6 3730.0 3736.9 3237.3 3309.5 3314.8 3321.3 3331.6 4630.9 4641.0 4648.8 4660.4 4660.7 4268.5 4279.7 4293.5 4294.5 4299.7 4804.0 4954.3 4957.5 5048.5 5062.8 3618.9 3620.9 3622.7 3628.8 3638.0 5226.8 5233.2 5243.1 5243.5 5263.7 3647.3 3752.0 3752.9 3753.7 3767.2 3788.7 3789.3 3813.4 3814.8 3823.9 4264.9 4270.9 4285.2 4291.5 4302.9 4955.7 5000.9 5004.1 5014.2 5027.8 1211.8 1261.3 1263.8 1268.5 1279.2 851.2 858.3 877.4 878.9 884.4 4150.7 4189.9 4229.7 4244.8 4259.3 5026.2 5150.3 5165.8 5180.9 5186.0 4387.5 4412.2 4433.2 4438.0 4460.8 2530.5 2650.3 2654.2 2667.0 2669.7 4669.3 4719.5 4720.4 4732.7 4733.6 5118.9 5126.3 5151.8 5162.8 5170.8 4634.6 4714.1 4719.9 4733.9 4764.7 5023.7 5031.2 5031.9 5036.6 5069.6 4940.5 4952.3 4954.0 4979.4 4979.6 4576.5 4671.3 4728.4 4728.4 4739.6 3513.4 3516.0 3517.4 3523.4 3523.6 4987.6 4991.7 5035.8 5036.3 5042.4 4659.8 4854.7 4875.0 4903.9 4909.2 4809.5 4830.8 4833.3 4838.8 4863.7 4760.4 4763.3 4768.1 4770.7 4777.4 4739.5 4858.4 4860.4 4865.8 4878.7 4673.5 4741.5 4755.5 4756.3 4758.6 15:54:13 INFO - PROCESS | 3385 | 15:54:13 INFO - PROCESS | 3385 | [#5] yui.html Cycles:180 Average:14645.98 Median:49818.00 stddev:19383.40 (38.9%) stddev-sans-first:19409.08 15:54:13 INFO - PROCESS | 3385 | Values: 600.7 654.1 660.6 695.1 712.2 11753.4 12246.3 12246.9 12255.1 12256.2 11776.5 11821.3 11825.0 11836.8 11851.3 605.8 625.1 734.0 754.0 757.0 725.7 752.3 755.5 756.1 758.1 799.2 800.8 800.8 801.5 801.8 636.0 654.6 798.2 799.2 799.2 408.5 412.2 417.6 420.0 420.2 12230.9 12248.1 12261.9 12266.1 12332.8 11041.8 11243.5 11354.4 11521.6 11830.3 10993.2 11076.0 11084.1 11123.7 11427.3 3935.5 3954.1 3954.6 4129.6 4143.0 47221.5 48057.5 48430.3 49407.0 50229.0 9197.3 9264.0 9456.3 9462.4 9548.5 14365.3 14462.9 15024.4 16248.4 16510.1 6034.0 6085.7 6192.9 6241.3 6410.0 3485.6 3489.0 3544.9 3571.0 3628.6 2477.0 2546.2 2560.0 2564.8 2575.6 438.1 441.4 441.9 449.6 455.5 448.5 474.9 528.0 587.6 590.3 7042.5 7270.2 7309.0 7438.1 7766.0 503.4 505.5 509.8 562.0 600.6 3290.4 3357.8 3399.9 3437.1 3528.2 70497.0 71332.3 72373.3 72397.6 73425.6 61086.0 62583.3 62830.7 64213.4 66167.3 56359.0 56836.0 58338.7 58461.4 60196.4 6669.9 6847.3 6955.3 6979.3 7039.6 37689.4 37922.0 38271.8 38359.2 40386.2 48551.8 52746.5 53781.7 54164.0 55911.4 9194.8 9447.4 9522.8 9524.7 9560.6 10087.1 10334.9 10352.1 10491.3 10601.9 9305.7 10258.9 10411.3 10464.5 10476.6 11086.1 11262.3 11330.3 11475.7 11636.7 10721.4 11035.4 11120.6 11327.8 11435.0 8785.6 8822.8 9106.0 9197.3 9238.6 8369.9 9054.1 9192.4 9311.5 9353.2 15:54:13 INFO - PROCESS | 3385 | -------- Summary: end -------- 15:54:13 INFO - PROCESS | 3385 | 15:54:14 INFO - TEST-INFO | 3385: exit 0 15:54:14 INFO - TEST-OK | dromaeo_css | took 1125030ms 15:54:14 INFO - TEST-START | kraken 15:54:14 INFO - operating with platform_type : linux_ 15:54:14 INFO - Initialising browser for kraken test... 15:54:14 INFO - TEST-INFO | started process 3697 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYKsJy6/profile http://localhost:50188/getInfo.html) 15:54:18 INFO - PROCESS | 3697 | __metrics Screen width/height:1600/1200 15:54:18 INFO - PROCESS | 3697 | colorDepth:24 15:54:18 INFO - PROCESS | 3697 | Browser inner width/height: 1024/697 15:54:18 INFO - PROCESS | 3697 | __metrics 15:54:19 INFO - PROCESS | 3697 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 15:54:19 INFO - PROCESS | 3697 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:54:19 INFO - PROCESS | 3697 | console.error: PushService: 15:54:19 INFO - PROCESS | 3697 | stateChangeProcessEnqueue: Error transitioning state 15:54:19 INFO - PROCESS | 3697 | UnknownError 15:54:20 INFO - TEST-INFO | 3697: exit 0 15:54:20 INFO - Browser initialized. 15:54:20 INFO - Running cycle 1/1 for kraken test... 15:54:20 INFO - TEST-INFO | started process 3779 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYKsJy6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:54:32 INFO - PROCESS | 3779 | RSS: Main: 174669824 15:54:32 INFO - PROCESS | 3779 | 15:54:35 INFO - PROCESS | 3779 | Cycle 1(1): loaded http://localhost:50188/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50188/tests/kraken/driver.html?testName=audio-beat-detection) 15:54:36 INFO - PROCESS | 3779 | RSS: Main: 231301120 15:54:36 INFO - PROCESS | 3779 | 15:54:39 INFO - PROCESS | 3779 | Cycle 1(1): loaded http://localhost:50188/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50188/tests/kraken/driver.html?testName=audio-dft) 15:54:40 INFO - PROCESS | 3779 | RSS: Main: 218341376 15:54:40 INFO - PROCESS | 3779 | 15:54:43 INFO - PROCESS | 3779 | Cycle 1(1): loaded http://localhost:50188/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50188/tests/kraken/driver.html?testName=audio-fft) 15:54:43 INFO - PROCESS | 3779 | RSS: Main: 299814912 15:54:43 INFO - PROCESS | 3779 | 15:54:46 INFO - PROCESS | 3779 | Cycle 1(1): loaded http://localhost:50188/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50188/tests/kraken/driver.html?testName=audio-oscillator) 15:54:46 INFO - PROCESS | 3779 | RSS: Main: 211374080 15:54:46 INFO - PROCESS | 3779 | 15:54:49 INFO - PROCESS | 3779 | Cycle 1(1): loaded http://localhost:50188/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50188/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:54:49 INFO - PROCESS | 3779 | RSS: Main: 213749760 15:54:49 INFO - PROCESS | 3779 | 15:54:52 INFO - PROCESS | 3779 | Cycle 1(1): loaded http://localhost:50188/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50188/tests/kraken/driver.html?testName=imaging-darkroom) 15:54:53 INFO - PROCESS | 3779 | RSS: Main: 249319424 15:54:53 INFO - PROCESS | 3779 | 15:54:56 INFO - PROCESS | 3779 | Cycle 1(1): loaded http://localhost:50188/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50188/tests/kraken/driver.html?testName=imaging-desaturate) 15:54:57 INFO - PROCESS | 3779 | RSS: Main: 248938496 15:54:57 INFO - PROCESS | 3779 | 15:55:00 INFO - PROCESS | 3779 | Cycle 1(1): loaded http://localhost:50188/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50188/tests/kraken/driver.html?testName=json-parse-financial) 15:55:00 INFO - PROCESS | 3779 | RSS: Main: 248254464 15:55:00 INFO - PROCESS | 3779 | 15:55:02 INFO - PROCESS | 3779 | Cycle 1(1): loaded http://localhost:50188/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50188/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:55:03 INFO - PROCESS | 3779 | RSS: Main: 210481152 15:55:03 INFO - PROCESS | 3779 | 15:55:05 INFO - PROCESS | 3779 | Cycle 1(1): loaded http://localhost:50188/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50188/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:55:05 INFO - PROCESS | 3779 | RSS: Main: 218267648 15:55:05 INFO - PROCESS | 3779 | 15:55:07 INFO - PROCESS | 3779 | Cycle 1(1): loaded http://localhost:50188/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50188/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:55:08 INFO - PROCESS | 3779 | RSS: Main: 226869248 15:55:08 INFO - PROCESS | 3779 | 15:55:12 INFO - PROCESS | 3779 | Cycle 1(1): loaded http://localhost:50188/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50188/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:55:13 INFO - PROCESS | 3779 | RSS: Main: 224337920 15:55:13 INFO - PROCESS | 3779 | 15:55:15 INFO - PROCESS | 3779 | Cycle 1(1): loaded http://localhost:50188/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50188/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:55:16 INFO - PROCESS | 3779 | RSS: Main: 228737024 15:55:16 INFO - PROCESS | 3779 | 15:55:18 INFO - PROCESS | 3779 | Cycle 1(1): loaded http://localhost:50188/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50188/tests/kraken/driver.html?testName=ai-astar) 15:55:18 INFO - PROCESS | 3779 | RSS: Main: 280027136 15:55:18 INFO - PROCESS | 3779 | 15:55:18 INFO - PROCESS | 3779 | __start_tp_report 15:55:18 INFO - PROCESS | 3779 | _x_x_mozilla_page_load 15:55:18 INFO - PROCESS | 3779 | _x_x_mozilla_page_load_details 15:55:18 INFO - PROCESS | 3779 | |i|pagename|runs| 15:55:18 INFO - PROCESS | 3779 | |0;ai-astar;106;114;114;116;114;116;114;115;114;114 15:55:18 INFO - PROCESS | 3779 | |1;audio-beat-detection;151;133;130;167;132;130;128;129;164;132 15:55:18 INFO - PROCESS | 3779 | |2;audio-dft;161;160;161;160;161;161;161;161;161;159 15:55:18 INFO - PROCESS | 3779 | |3;audio-fft;77;77;77;113;78;78;78;77;107;76 15:55:18 INFO - PROCESS | 3779 | |4;audio-oscillator;83;82;133;84;83;85;105;84;84;114 15:55:18 INFO - PROCESS | 3779 | |5;imaging-gaussian-blur;116;117;117;117;117;117;117;117;117;116 15:55:18 INFO - PROCESS | 3779 | |6;imaging-darkroom;146;146;146;146;146;146;147;146;146;147 15:55:18 INFO - PROCESS | 3779 | |7;imaging-desaturate;84;85;85;86;85;85;85;85;85;84 15:55:18 INFO - PROCESS | 3779 | |8;json-parse-financial;66;63;62;63;64;64;63;64;64;65 15:55:18 INFO - PROCESS | 3779 | |9;json-stringify-tinderbox;66;66;66;65;67;66;66;66;68;66 15:55:18 INFO - PROCESS | 3779 | |10;stanford-crypto-aes;84;84;93;90;84;83;83;91;84;92 15:55:18 INFO - PROCESS | 3779 | |11;stanford-crypto-ccm;141;140;140;146;138;138;153;138;183;147 15:55:18 INFO - PROCESS | 3779 | |12;stanford-crypto-pbkdf2;182;177;176;179;174;176;174;178;181;178 15:55:18 INFO - PROCESS | 3779 | |13;stanford-crypto-sha256-iterative;75;68;68;69;73;68;68;69;67;68 15:55:18 INFO - PROCESS | 3779 | __end_tp_report 15:55:18 INFO - PROCESS | 3779 | __start_cc_report 15:55:18 INFO - PROCESS | 3779 | _x_x_mozilla_cycle_collect,1971 15:55:18 INFO - PROCESS | 3779 | __end_cc_report 15:55:18 INFO - PROCESS | 3779 | __startTimestamp1478386518633__endTimestamp 15:55:18 INFO - PROCESS | 3779 | 15:55:18 INFO - PROCESS | 3779 | ------- Summary: start ------- 15:55:18 INFO - PROCESS | 3779 | Number of tests: 14 15:55:18 INFO - PROCESS | 3779 | 15:55:18 INFO - PROCESS | 3779 | [#0] ai-astar Cycles:10 Average:113.70 Median:114.00 stddev:2.83 (2.5%) stddev-sans-first:0.88 15:55:18 INFO - PROCESS | 3779 | Values: 106.0 114.0 114.0 116.0 114.0 116.0 114.0 115.0 114.0 114.0 15:55:18 INFO - PROCESS | 3779 | 15:55:18 INFO - PROCESS | 3779 | [#1] audio-beat-detection Cycles:10 Average:139.60 Median:132.50 stddev:15.15 (11.4%) stddev-sans-first:15.50 15:55:18 INFO - PROCESS | 3779 | Values: 151.0 133.0 130.0 167.0 132.0 130.0 128.0 129.0 164.0 132.0 15:55:18 INFO - PROCESS | 3779 | 15:55:18 INFO - PROCESS | 3779 | [#2] audio-dft Cycles:10 Average:160.60 Median:161.00 stddev:0.70 (0.4%) stddev-sans-first:0.73 15:55:18 INFO - PROCESS | 3779 | Values: 161.0 160.0 161.0 160.0 161.0 161.0 161.0 161.0 161.0 159.0 15:55:18 INFO - PROCESS | 3779 | 15:55:18 INFO - PROCESS | 3779 | [#3] audio-fft Cycles:10 Average:83.80 Median:77.00 stddev:13.89 (18.0%) stddev-sans-first:14.52 15:55:18 INFO - PROCESS | 3779 | Values: 77.0 77.0 77.0 113.0 78.0 78.0 78.0 77.0 107.0 76.0 15:55:18 INFO - PROCESS | 3779 | 15:55:18 INFO - PROCESS | 3779 | [#4] audio-oscillator Cycles:10 Average:93.70 Median:83.50 stddev:17.66 (21.2%) stddev-sans-first:18.31 15:55:18 INFO - PROCESS | 3779 | Values: 83.0 82.0 133.0 84.0 83.0 85.0 105.0 84.0 84.0 114.0 15:55:18 INFO - PROCESS | 3779 | 15:55:18 INFO - PROCESS | 3779 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 15:55:18 INFO - PROCESS | 3779 | Values: 116.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 116.0 15:55:18 INFO - PROCESS | 3779 | 15:55:18 INFO - PROCESS | 3779 | [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 15:55:18 INFO - PROCESS | 3779 | Values: 146.0 146.0 146.0 146.0 146.0 146.0 147.0 146.0 146.0 147.0 15:55:18 INFO - PROCESS | 3779 | 15:55:18 INFO - PROCESS | 3779 | [#7] imaging-desaturate Cycles:10 Average:84.90 Median:85.00 stddev:0.57 (0.7%) stddev-sans-first:0.50 15:55:18 INFO - PROCESS | 3779 | Values: 84.0 85.0 85.0 86.0 85.0 85.0 85.0 85.0 85.0 84.0 15:55:18 INFO - PROCESS | 3779 | 15:55:18 INFO - PROCESS | 3779 | [#8] json-parse-financial Cycles:10 Average:63.80 Median:64.00 stddev:1.14 (1.8%) stddev-sans-first:0.88 15:55:18 INFO - PROCESS | 3779 | Values: 66.0 63.0 62.0 63.0 64.0 64.0 63.0 64.0 64.0 65.0 15:55:18 INFO - PROCESS | 3779 | 15:55:18 INFO - PROCESS | 3779 | [#9] json-stringify-tinderbox Cycles:10 Average:66.20 Median:66.00 stddev:0.79 (1.2%) stddev-sans-first:0.83 15:55:18 INFO - PROCESS | 3779 | Values: 66.0 66.0 66.0 65.0 67.0 66.0 66.0 66.0 68.0 66.0 15:55:18 INFO - PROCESS | 3779 | 15:55:18 INFO - PROCESS | 3779 | [#10] stanford-crypto-aes Cycles:10 Average:86.80 Median:87.00 stddev:4.13 (4.7%) stddev-sans-first:4.26 15:55:18 INFO - PROCESS | 3779 | Values: 84.0 84.0 93.0 90.0 84.0 83.0 83.0 91.0 84.0 92.0 15:55:18 INFO - PROCESS | 3779 | 15:55:18 INFO - PROCESS | 3779 | [#11] stanford-crypto-ccm Cycles:10 Average:146.40 Median:143.50 stddev:13.77 (9.6%) stddev-sans-first:14.47 15:55:18 INFO - PROCESS | 3779 | Values: 141.0 140.0 140.0 146.0 138.0 138.0 153.0 138.0 183.0 147.0 15:55:18 INFO - PROCESS | 3779 | 15:55:18 INFO - PROCESS | 3779 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:177.50 Median:178.00 stddev:2.68 (1.5%) stddev-sans-first:2.29 15:55:18 INFO - PROCESS | 3779 | Values: 182.0 177.0 176.0 179.0 174.0 176.0 174.0 178.0 181.0 178.0 15:55:18 INFO - PROCESS | 3779 | 15:55:18 INFO - PROCESS | 3779 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.30 Median:68.50 stddev:2.58 (3.8%) stddev-sans-first:1.73 15:55:18 INFO - PROCESS | 3779 | Values: 75.0 68.0 68.0 69.0 73.0 68.0 68.0 69.0 67.0 68.0 15:55:18 INFO - PROCESS | 3779 | -------- Summary: end -------- 15:55:18 INFO - PROCESS | 3779 | 15:55:19 INFO - TEST-INFO | 3779: exit 0 15:55:19 INFO - TEST-OK | kraken | took 65308ms 15:55:19 INFO - SUITE-END | took 1190s 15:55:20 INFO - Completed test suite (00:19:50) 15:55:20 INFO - javascript benchmark 15:55:20 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2648.5365061114308, 2668.1061844282162, 2688.274165975187, 2705.797065220108, 2710.0650275654893, 4588.90822183557, 4653.162430762462, 4718.386609740734, 4773.689710168836, 4804.639652026099, 4680.719156850591, 4706.035262771133, 4750.121227572893, 4780.187368147414, 4816.301636262749, 4283.121959998209, 4320.611144996966, 4354.97822510887, 4362.760048197348, 4363.323684828841, 3916.8824935251987, 4313.525512193672, 4401.845935392262, 4444.622207112399, 4477.843275485358, 4216.894577635553, 4336.761478118702, 4344.066025804467, 4429.77851107445, 4447.266201076818, 4274.2092712848225, 4316.352547117926, 4328.4156638853665, 4329.480462344507, 4330.372096046056, 4283.678724095674, 4309.116631090619, 4337.63130133939, 4378.64970802335, 4385.0, 4672.836450724242, 4716.151092803294, 4718.268668356411, 4760.309755085494, 4776.665633405663, 5051.722155281458, 5060.797568097271, 5063.949360506384, 5065.797368105272, 5109.974450127763, 4941.827036053757, 4986.202207646759, 4992.650514463989, 5056.292119103328, 5089.720065396402, 4715.221988371949, 4766.308885211625, 4769.189237829577, 4811.013742182914, 4820.638452116105, 5222.477752224747, 5236.947630523722, 5242.004019236333, 5250.212468129735, 5289.603279754034, 4952.331435256267, 5011.774470148852, 5025.79896804131, 5032.547070763649, 5066.746662666852, 4871.318015477836, 4921.0, 4926.802927882844, 4998.90002199954, 5058.140116180258, 5008.449070602231, 5071.5689166420525, 5108.463611320833, 5114.923276150861, 5120.1039818031695, 5022.974885125551, 5037.269595908573, 5042.647014708935, 5055.86243095308, 5091.516305951003, 4075.286824805647, 4113.053997580573, 4214.05183833635, 4227.51383590891, 4253.404523366731, 3639.9090022749115, 3657.6708096271464, 3679.1170119171743, 3693.2244228711734, 3735.7571757835653, 4272.829086836492, 4283.978580107142, 4287.914241715148, 4293.5706429356815, 4334.609885110355, 4993.825216117419, 5043.823466178666, 5049.267856160836, 5051.848444546669, 5076.314697515862, 4151.522574903925, 4178.561251068655, 4214.030772922245, 4221.409002739558, 4256.723312984646, 4495.527969563149, 4513.458384993822, 4525.162844873643, 4534.909301814011, 4538.546145385501, 4749.4063242094735, 4750.07373562152, 4754.2630892212455, 4757.072370887782, 4799.520047995173, 4847.80608775645, 4996.375453068366, 4998.050370429607, 5018.548330650113, 5049.2173713074535, 4655.580997710223, 4692.155412025868, 4721.079389519011, 4723.622110231105, 4742.881427964328, 4998.2502624606595, 5003.54968052877, 5010.273510341053, 5018.121828679893, 5059.848204553869, 5076.340075790124, 5080.644354895122, 5081.4664460232625, 5084.3898732152375, 5120.923186152137, 4808.975955120202, 4821.059893320768, 4888.877778055577, 4911.263310503453, 4933.161362568444, 4925.408950925912, 4937.753112344297, 4961.900761984668, 4987.675801072919, 5003.099442100457, 4867.440244371943, 4888.9488759916785, 4894.339264199288, 4896.706197628154, 4925.605951523941, 4756.025014872012, 4817.5182481752945, 4820.325154478446, 5001.474845141208, 5067.543921047123, 4820.734859582757, 4859.732714700725, 4866.6350023747655, 4870.366852309177, 4935.728534930613], "value": 4626.158285638509, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [546.2298159594969, 549.7306319903247, 558.8519042453753, 578.9218455508507, 596.961197522161, 28211.576826347595, 38360.80819595901, 40137.9758542255, 40225.0, 43792.12415751683, 39812.402813957815, 40256.19487610246, 40266.39600405996, 40292.19415611686, 40308.19383612326, 7619.657115429819, 7776.377889768805, 7777.300042996129, 7779.649915753805, 7779.9222007780045, 7488.176300606929, 7571.583562904038, 7575.9621201893915, 7576.848463030736, 7578.393728501735, 7566.4325175611775, 7632.656530456143, 7633.0, 7637.694492220305, 7645.808854778619, 7574.4319176061745, 7606.581638009935, 7615.238476152396, 7621.58081305528, 7625.885611715828, 7671.731489397845, 7731.149573546905, 7732.072151341818, 7733.883991740128, 7735.883961740578, 38078.23843523114, 38326.80836595827, 38463.615363846286, 38482.80758596217, 38518.807405963074, 3085.6451508076634, 3121.4693502104697, 3144.4497212987635, 3327.234736010707, 3327.2680010397917, 27929.301767455774, 28205.576916346065, 28881.42237155266, 29189.85405072961, 29274.707252927412, 3354.1279267390655, 3435.5018522314376, 3465.5668041494814, 3508.7719298245534, 3516.1561225306, 240988.0, 242605.0, 243116.0, 243918.0, 244410.0, 52663.21005184925, 52955.735221323645, 52958.0, 52971.47028529665, 53074.73462632662, 32279.51580726291, 33279.16802079919, 33355.0, 34794.0, 55258.17112743312, 14858.702825943421, 15191.164485953157, 15275.770863437057, 15284.541463756104, 15298.847011529742, 11288.209825312313, 11639.59261425846, 11641.941790290994, 11646.592369267035, 11649.47577359021, 17516.64966700659, 17535.561610959572, 17544.29822807099, 17581.38465153739, 17647.73528397075, 6341.175647165839, 6384.062821575886, 6398.424141827258, 6528.412442880069, 6621.205455345389, 760.8059944714173, 913.3423934766957, 939.910708482693, 957.7557722780647, 983.2920297385871, 26600.8669956649, 27075.86462067677, 27243.318917026838, 27390.726092739216, 27892.30269243285, 785.6386062411241, 893.2184338703635, 901.756525738047, 950.3442624589012, 963.7542426681151, 12407.627771166879, 15694.372225111096, 16329.510114696579, 16437.342506299614, 17424.825751742574, 256116.0, 652205.0, 659981.0, 660481.0, 661095.0, 50554.74722626437, 51344.0, 51408.48591514037, 51437.7428112857, 51486.74256628693, 1089.7657003744232, 1124.3703526025452, 1137.7212582917239, 1181.9172657913864, 1200.5977997370978, 26957.46085078248, 28108.70793115995, 28365.290867728472, 29058.564121538617, 29092.854535727187, 41576.0, 42297.15405691807, 42297.365539516315, 42362.15275694407, 42379.364309535995, 290944.0, 292980.0, 293046.0, 293181.0, 294953.0, 35903.46144807882, 36958.44562331621, 37531.624683752816, 39663.80168099256, 40091.39862902117, 39197.6080239194, 39434.2113157741, 39678.60321396864, 39751.80124099361, 40513.79743101384, 35077.824610876785, 35096.12259693528, 35151.0, 35511.644883550834, 35532.644673553965, 34828.477572835924, 34860.82569587237, 35090.122746931534, 35220.47169292514, 35475.290494190485, 34180.65819341874, 34583.82708086444, 35152.648473514935, 35208.823955880056, 35466.468002980495, 26397.472050558496, 27427.725722743315, 28107.0, 28196.577051344655, 28241.0, 24254.393640158432, 24442.75557244476, 24460.388490287885, 24631.630525541772, 24812.50374992454], "value": 17440.162869878095, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [351.47454555439623, 355.3284292686822, 356.2625365493428, 359.7643543479022, 387.32798594438646, 12405.751884962307, 15543.533693989184, 15789.763153552705, 17541.3860514882, 17656.293748250086, 16817.41139060133, 16861.494155175333, 16871.15644217787, 16977.49067527973, 16979.83020169801, 4821.156297647915, 4905.0925578767865, 4951.43058548268, 5008.549230569248, 5036.143855544567, 4934.087193869128, 5027.899442011158, 6431.0, 6786.524943253974, 6795.9660201698925, 6772.322767723237, 6881.44948404129, 6885.48358873084, 6892.241853396123, 6908.274631163706, 6500.902486462707, 6807.149106361705, 6846.041554182419, 6953.930460695429, 6960.338767817049, 6452.774152904626, 6588.703508342136, 6616.139901812781, 6617.536772425884, 6700.765473208463, 22946.0, 23135.76864231353, 23441.41396465102, 23672.526549469087, 24045.0, 1996.710476980844, 2005.3883565512513, 2112.86266392684, 2182.879941603211, 2292.5422904581656, 14039.78940315896, 14102.858971410256, 14289.142651440947, 14292.071015383966, 14481.710365792731, 1780.468528653016, 1855.5361159710073, 1903.200655724599, 1905.9809401905943, 1938.2150229157214, 82252.58873705653, 85873.57063214644, 86780.56609716911, 88079.55960220222, 88304.11695883023, 16003.679926401639, 16039.919800401156, 16451.0, 16743.91628041852, 16857.915710421614, 28911.56632650512, 28963.85518072396, 29054.0, 29055.0, 29149.271268218465, 8875.4024275631, 8930.285577153812, 9071.59177836999, 9245.583948722324, 9557.474338911426, 7429.851402972018, 7437.8140546486775, 7599.544027358376, 7805.063392392835, 7821.452498325063, 7832.295093441504, 8173.918260817316, 8285.212904774036, 8287.544185069759, 8402.495850249004, 2575.781058610039, 3036.7874248802814, 3123.5966269148157, 3170.726845022112, 3292.456744637108, 725.9673314700851, 808.3290868579065, 861.1173547114133, 865.5672163918041, 930.9069093090636, 16084.678306433805, 16338.767284553964, 16764.58088547796, 17090.230939607747, 17164.828351716573, 801.6112185589984, 829.7925518620345, 847.4068152293419, 904.1410659873147, 925.7916968681992, 9030.869767857028, 9580.904190958141, 9593.0, 9613.615455381847, 9709.36889102206, 361306.0, 361977.0, 363575.0, 363845.0, 364507.0, 70403.64798175976, 72097.63951180315, 75354.62322688352, 75969.0, 77957.0, 834.1741675741094, 856.6016802186888, 857.6312185760058, 858.0347109501811, 858.2104463893234, 14674.926625366805, 14712.926435367755, 14765.114093154445, 14852.108873467627, 15504.302306396465, 34117.3543024936, 34763.13092172716, 35588.822055889555, 35880.64119358773, 35919.82040089783, 48148.759256204896, 49781.0, 51440.48559514357, 52115.0, 52319.215211772615, 6367.172267605181, 6721.092652491851, 6849.863002740017, 6857.794266172023, 7053.541519801196, 9617.855732163884, 11530.76938461243, 11578.594749183738, 11659.125565582784, 11825.881741182478, 8622.913770862462, 8638.524881131598, 9141.77145571366, 9592.136707696342, 9741.025897410202, 9872.851907221253, 9912.653057142965, 10011.899881001387, 10022.699319020441, 10296.485175741333, 9187.540622968958, 9265.583048762686, 9375.812483750424, 9479.241660667269, 9914.851277230702, 6123.4488895999575, 6125.571210015256, 6137.557673946708, 6253.687315634291, 6435.967820160869, 7832.960835195788, 8520.275776559061, 8713.52075635846, 8813.206811387006, 9281.953590232006], "value": 8981.754169687778, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1307.7776777947747, 1352.3643887372934, 1385.508144608664, 1584.1288782816223, 1602.9278682459287, 6570.244421891484, 7058.541194822339, 7062.046623705798, 7063.6468176591225, 7064.187618423883, 6160.753569857212, 6340.239171299439, 6365.52258580606, 6492.3832235937625, 6762.763303284386, 1826.0139524656702, 1879.2483006797322, 1935.622553602041, 1938.5832046110083, 1951.0829909942304, 1978.0900785638623, 2037.928672496463, 2038.4598081508411, 2040.4898775306174, 2044.0, 1977.5748214133957, 1981.9108140133656, 2026.7871873453296, 2031.1164643380102, 2035.4199053269822, 1725.30125299254, 1796.847267982223, 1933.9323123690604, 2016.8890711010888, 2023.3828682251908, 2041.469218003315, 2044.499097721053, 2057.44448998771, 2057.5267688431595, 2058.1458694641706, 6997.055397521321, 7054.0, 7057.364837164629, 7059.223485416652, 7064.823379415556, 4071.389291606253, 4188.204241194163, 4189.303332150484, 4192.0, 4195.119025004753, 2566.794656427481, 2749.9037533686223, 2757.8483183424905, 2762.709915458868, 2772.0575004498364, 831.8045259364045, 872.6378552900538, 905.7237542549519, 915.4461550761827, 919.3702313914989, 9158.129977652112, 9159.26725861936, 9165.220956218729, 9174.220191283748, 9204.263658907272, 3651.123730304708, 3828.770273783526, 3921.3529767588598, 3923.6272554107886, 3936.842526298916, 7907.762767116996, 7907.920920790833, 7911.0, 7911.5253084815095, 7912.881306780403, 4265.658747300208, 4270.50889147752, 4270.743755374625, 4272.6795490338345, 4273.017206042628, 3667.0832291927018, 3890.9688932432928, 3905.2970465316516, 3910.921781564353, 3911.2568611964207, 3281.425750493702, 3308.3052558962886, 3380.983095084558, 3407.9318413632086, 3443.810590417501, 1121.3103941076179, 1152.7521582859727, 1160.4777849967547, 1162.3200427749691, 1166.288563975974, 750.6622020090981, 787.4802630264113, 789.3251270164042, 793.0562630469723, 799.8080460689392, 4646.3495110684535, 4721.551452611996, 4734.28985652148, 4752.429708434941, 4923.310736496894, 363.2372018760582, 370.9425039118941, 372.12736133766276, 373.35968813485005, 376.5142965574433, 3180.0936733030976, 3237.5143728440453, 3240.9837950810097, 3248.9187770305457, 3276.672332766704, 7953.5227886327, 8466.153384661608, 8486.830263394697, 8488.193621605938, 8491.915080849236, 8449.32405407566, 8452.366072544584, 8456.661733530713, 8459.957700211582, 8467.95766021166, 6534.901976470357, 6646.26891041985, 6647.235567909655, 6651.900221496585, 6653.234877988996, 4551.340055691972, 4669.159551280802, 4680.3915490985955, 4684.320773487757, 4730.290456431563, 7624.5425274483705, 7672.808179795326, 7734.066483379155, 7790.3378212850275, 7791.805204869697, 7782.92217077822, 7922.643481043252, 7975.521468711664, 7977.52696664036, 7984.121746607752, 5841.853953651193, 5961.850953726192, 5967.850803729942, 5984.521238300838, 5988.880222395441, 6406.167198264196, 6464.288928217987, 6481.708323125565, 6484.546081774419, 6488.805335839932, 5786.85532861665, 5853.0, 5871.060630299132, 5933.643981361132, 6189.0, 5734.111212762028, 5886.793962211302, 5887.293524776883, 5976.7908123215475, 6002.0996850472775, 5386.057439948072, 5464.672119672832, 5469.480399362054, 5470.316210473691, 5477.4796394342475, 3986.402039693953, 4112.321466957918, 4169.749815011109, 4206.831726730897, 4306.375575541591, 4085.897852553591, 4096.877093687194, 4129.359949207877, 4175.0, 4293.957060429356], "value": 3658.4331447141803, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [283.9701831307713, 285.1019289238897, 289.1801742061259, 291.1629066434002, 291.34592839076277, 4808.759562021903, 4851.1753001989655, 4860.326820248867, 4882.145624515709, 4886.291487734276, 4769.833055843046, 4774.729310422363, 4777.450593181785, 4781.330613714074, 4815.253635686474, 3525.4888041234008, 3642.162302670374, 3644.6355364463475, 3765.698744100479, 3775.830087646049, 3618.3125206210866, 3687.410014397697, 3688.723345749066, 3727.869524566641, 3758.267137908109, 3692.5753538343033, 3694.6120657331, 3698.500702405168, 3699.5375578052744, 3709.406494960807, 3692.4276737105793, 3708.7589306694977, 3723.590405055442, 3730.034622475139, 3736.8878933632036, 3237.303979644364, 3309.5035744638258, 3314.767966242364, 3321.3025264694443, 3331.6168640606397, 4630.907381852344, 4640.953590464086, 4648.767561621906, 4660.440747110335, 4660.743659098748, 4268.487781466244, 4279.743215407055, 4293.463317085364, 4294.484661840568, 4299.677524185668, 4804.0, 4954.2568614707725, 4957.5042495750495, 5048.516523598705, 5062.772175252123, 3618.9191215051187, 3620.8913732588067, 3622.710183185339, 3628.8004159771203, 3637.9991004947437, 5226.843194704127, 5233.162693968947, 5243.082460569385, 5243.528082472596, 5263.684178949237, 3647.325244829715, 3752.0, 3752.887413377603, 3753.6997040236715, 3767.1900541383734, 3788.6590206881515, 3789.2717243584575, 3813.3517302058717, 3814.809259537012, 3823.885283441501, 4264.87205383839, 4270.850520231839, 4285.207236661227, 4291.489478654959, 4302.935455968163, 4955.677880937727, 5000.89998200034, 5004.074246264453, 5014.197728363517, 5027.84916452507, 1211.7939950208486, 1261.2621616354352, 1263.848338199422, 1268.543324403214, 1279.2324605236784, 851.1913682001999, 858.3004851046377, 877.4121338703085, 878.8549889268199, 884.4428010353565, 4150.671785028761, 4189.905047476262, 4229.725067870579, 4244.7739717814065, 4259.297215959332, 5026.195808670595, 5150.27896094547, 5165.793368265227, 5180.8963820723375, 5186.0, 4387.4954380246045, 4412.183461305947, 4433.224185767478, 4438.0, 4460.799264033127, 2530.544501989623, 2650.310919161032, 2654.2302732207445, 2667.0, 2669.7196794336314, 4669.2996050592, 4719.528047195253, 4720.386349774507, 4732.6687131900435, 4733.562215459041, 5118.923216151761, 5126.282320475137, 5151.768170432265, 5162.819301324435, 5170.844874653766, 4634.559716826896, 4714.087307534738, 4719.905601887943, 4733.928991065137, 4764.690295130806, 5023.748812559431, 5031.195008798574, 5031.874203144951, 5036.647434679684, 5069.6197785167, 4940.481249468754, 4952.306677065286, 4953.968872762151, 4979.377577802775, 4979.551840334388, 4576.512633394227, 4671.322658214472, 4728.38530990969, 4728.385309909827, 4739.573438390561, 3513.418961467401, 3515.9824200878834, 3517.3844577198374, 3523.436250199956, 3523.559555055618, 4987.576056035277, 4991.675541089818, 5035.751939998607, 5036.29491871131, 5042.39491261051, 4659.767011649336, 4854.684445511171, 4874.975625121851, 4903.8528844134735, 4909.214525675875, 4809.519048095162, 4830.806767729251, 4833.299171620166, 4838.782254798472, 4863.7324947128245, 4760.357351757469, 4763.261694437368, 4768.141734487686, 4770.666053376231, 4777.402824646919, 4739.549742774431, 4858.416989961227, 4860.441049279237, 4865.80787707014, 4878.707277563358, 4673.532646735299, 4741.525847415231, 4755.548222918817, 4756.286557016475, 4758.643786520964], "value": 3734.1111969546077, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [600.7116584039661, 654.1136759690617, 660.5739298152691, 695.1102588686483, 712.1809918593617, 11753.353565553902, 12246.326452045134, 12246.93876530616, 12255.080868934843, 12256.203346782464, 11776.470058847352, 11821.34982575958, 11825.0, 11836.763264734722, 11851.288922664624, 605.7819185093363, 625.0686477149061, 733.9559626422432, 753.950993185444, 756.9659365328573, 725.735106686061, 752.345459450279, 755.5202446446491, 756.1380026769488, 758.1054355860083, 799.1648727080186, 800.75977206838, 800.8158123631569, 801.5070731500115, 801.8075661841175, 636.0491065856528, 654.6399480285824, 798.1579433697476, 799.1688643810488, 799.1808396393714, 408.5383516626223, 412.2373608823682, 417.5761601973999, 419.9895002624928, 420.22049098921366, 12230.938845305805, 12248.142630015902, 12261.93869030658, 12266.080043996735, 12332.81500777489, 11041.83437248442, 11243.494042768096, 11354.375509346983, 11521.596744114, 11830.290182588986, 10993.175511836644, 11076.0, 11084.113270938306, 11123.72190695239, 11427.314361138358, 3935.527736671589, 3954.090559171378, 3954.6045395460224, 4129.566395528456, 4142.979285103585, 47221.52778472206, 48057.51942480565, 48430.27354589684, 49407.0, 50229.0, 9197.310201734897, 9264.0, 9456.290778191664, 9462.384944978554, 9548.522573871278, 14365.281735913162, 14462.855371446361, 15024.399024039134, 16248.431304904272, 16510.091944942902, 6033.9698301508215, 6085.665288409092, 6192.8761424771255, 6241.313455519889, 6409.9679501602195, 3485.6165821759587, 3488.965110348864, 3544.929101417957, 3570.98214508931, 3628.63713628635, 2476.9752302476745, 2546.1979476464853, 2560.039985005623, 2564.7948164146824, 2575.6007818788116, 438.110635410118, 441.3798612948812, 441.8939454530889, 449.5976101389238, 455.51487665636654, 448.4932026809684, 474.895867108973, 527.9762410691528, 587.5974957154363, 590.3093380744539, 7042.542234754725, 7270.236625154388, 7308.96345518269, 7438.070241219848, 7765.961170194226, 503.44118028987793, 505.54248405193357, 509.83430385124984, 561.9687872753461, 600.6066026752484, 3290.391277613649, 3357.8321083945707, 3399.9490007649906, 3437.089171369589, 3528.2237907660274, 70497.0, 71332.2866771336, 72373.27626723771, 72397.6380118096, 73425.63287183637, 61086.0, 62583.299588563845, 62830.68584657047, 64213.35786642167, 66167.33832661709, 56359.0, 56836.0, 58338.70830645905, 58461.4153858456, 60196.398036019076, 6669.899951500634, 6847.281035491202, 6955.304469553004, 6979.267176946348, 7039.577625342496, 37689.43465847959, 37922.0, 38271.80864095662, 38359.2328153441, 40386.19227615373, 48551.75724121357, 52746.45070985742, 53781.73109134429, 54164.0, 55911.44088559062, 9194.770130746785, 9447.433154010781, 9522.761930951781, 9524.666636667684, 9560.569774360032, 10087.142592879687, 10334.948325258325, 10352.113026144021, 10491.265611407434, 10601.946990265, 9305.674301399418, 10258.948705256425, 10411.323263987817, 10464.529096190841, 10476.63331783384, 11086.113110951266, 11262.267952583055, 11330.263532870336, 11475.655730328104, 11636.709082272671, 10721.35671859691, 11035.448227588427, 11120.555177792798, 11327.773444531229, 11435.0, 8785.560721964004, 8822.779430514289, 9106.0, 9197.310201734763, 9238.584263708015, 8369.874451883104, 9054.094590540893, 9192.35653504275, 9311.487868167316, 9353.158215760614], "value": 5830.269061567802, "unit": "score"}], "name": "dromaeo_css", "value": 6216.7027660552185, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 114.0, 114.0, 116.0, 114.0, 116.0, 114.0, 115.0, 114.0, 114.0], "value": 113.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 133.0, 130.0, 167.0, 132.0, 130.0, 128.0, 129.0, 164.0, 132.0], "value": 139.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 161.0, 160.0, 161.0, 161.0, 161.0, 161.0, 161.0, 159.0], "value": 160.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 77.0, 77.0, 113.0, 78.0, 78.0, 78.0, 77.0, 107.0, 76.0], "value": 83.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 133.0, 84.0, 83.0, 85.0, 105.0, 84.0, 84.0, 114.0], "value": 93.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 147.0, 146.0, 146.0, 147.0], "value": 146.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 85.0, 86.0, 85.0, 85.0, 85.0, 85.0, 85.0, 84.0], "value": 84.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 63.0, 62.0, 63.0, 64.0, 64.0, 63.0, 64.0, 64.0, 65.0], "value": 63.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 66.0, 65.0, 67.0, 66.0, 66.0, 66.0, 68.0, 66.0], "value": 66.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 93.0, 90.0, 84.0, 83.0, 83.0, 91.0, 84.0, 92.0], "value": 86.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 140.0, 140.0, 146.0, 138.0, 138.0, 153.0, 138.0, 183.0, 147.0], "value": 146.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 177.0, 176.0, 179.0, 174.0, 176.0, 174.0, 178.0, 181.0, 178.0], "value": 177.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 68.0, 68.0, 69.0, 73.0, 68.0, 68.0, 69.0, 67.0, 68.0], "value": 69.3, "unit": "score"}], "name": "kraken", "value": 1549.2999999999997, "alertThreshold": 2.0}]} 15:55:20 INFO - Return code: 0 15:55:20 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:55:20 INFO - # TBPL SUCCESS # 15:55:20 INFO - Running post-action listener: _resource_record_post_action 15:55:20 INFO - [mozharness: 2016-11-05 22:55:20.417180Z] Finished run-tests step (success) 15:55:20 INFO - Running post-run listener: _resource_record_post_run 15:55:20 INFO - Total resource usage - Wall time: 1207s; CPU: 13.0%; Read bytes: 9936896; Write bytes: 418697216; Read time: 1528; Write time: 437676 15:55:20 INFO - TinderboxPrint: CPU usage
13.1% 15:55:20 INFO - TinderboxPrint: I/O read bytes / time
9,936,896 / 1,528 15:55:20 INFO - TinderboxPrint: I/O write bytes / time
418,697,216 / 437,676 15:55:20 INFO - TinderboxPrint: CPU idle
8,364.9 (86.9%) 15:55:20 INFO - TinderboxPrint: CPU user
1,209.4 (12.6%) 15:55:20 INFO - TinderboxPrint: Swap in / out
0 / 0 15:55:20 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 4096; Write bytes: 83578880; Read time: 116; Write time: 90588 15:55:20 INFO - run-tests - Wall time: 1191s; CPU: 13.0%; Read bytes: 5840896; Write bytes: 335118336; Read time: 1168; Write time: 347088 15:55:21 INFO - Running post-run listener: _upload_blobber_files 15:55:21 INFO - Blob upload gear active. 15:55:21 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:55:21 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 15:55:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 15:55:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 15:55:21 INFO - (blobuploader) - INFO - Open directory for files ... 15:55:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:55:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:55:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:55:24 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:55:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:55:24 INFO - (blobuploader) - INFO - Done attempting. 15:55:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 15:55:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:55:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:55:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 15:55:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:55:25 INFO - (blobuploader) - INFO - Done attempting. 15:55:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 15:55:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:55:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:55:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 15:55:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:55:25 INFO - (blobuploader) - INFO - Done attempting. 15:55:25 INFO - (blobuploader) - INFO - Iteration through files over. 15:55:25 INFO - Return code: 0 15:55:25 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:55:25 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:55:25 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a7d404b325e602f7e01c56dfae846942d65290853a3c0cba6b5b151618bd4d9e2882796347ff21e512b97b0f9110fcc4f7172237a71f23b537ae0d925ee13c69", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f6c25437322978b85a1f906c65479110d90f3bfd3ab051f1d2b4309c3fcdb9cd62b4fd19cd535b17428802304bee797bf7a369e29ec28c77abaf75d587d4a043", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fd49a20b80308904e6f067dbe6054392e939f85f711eb167a2e4665e7a959eb6c0f4d9d46139aba6510cc4e1a883b0692e870b3063ec3680f46178348e4d8758"} 15:55:25 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:55:25 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:55:25 INFO - Contents: 15:55:25 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a7d404b325e602f7e01c56dfae846942d65290853a3c0cba6b5b151618bd4d9e2882796347ff21e512b97b0f9110fcc4f7172237a71f23b537ae0d925ee13c69", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f6c25437322978b85a1f906c65479110d90f3bfd3ab051f1d2b4309c3fcdb9cd62b4fd19cd535b17428802304bee797bf7a369e29ec28c77abaf75d587d4a043", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fd49a20b80308904e6f067dbe6054392e939f85f711eb167a2e4665e7a959eb6c0f4d9d46139aba6510cc4e1a883b0692e870b3063ec3680f46178348e4d8758"} 15:55:25 INFO - Running post-run listener: copy_logs_to_upload_dir 15:55:25 INFO - Copying logs to upload dir... 15:55:25 INFO - mkdir: /builds/slave/test/build/upload/logs 15:55:26 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1252.535478 ========= master_lag: 0.53 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2016-11-05 15:55:26.104404) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-05 15:55:26.107610) ========= 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=20e666a3d4cfbb71505a330e000001b4-1478385271.233659-1212280682 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a7d404b325e602f7e01c56dfae846942d65290853a3c0cba6b5b151618bd4d9e2882796347ff21e512b97b0f9110fcc4f7172237a71f23b537ae0d925ee13c69", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f6c25437322978b85a1f906c65479110d90f3bfd3ab051f1d2b4309c3fcdb9cd62b4fd19cd535b17428802304bee797bf7a369e29ec28c77abaf75d587d4a043", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fd49a20b80308904e6f067dbe6054392e939f85f711eb167a2e4665e7a959eb6c0f4d9d46139aba6510cc4e1a883b0692e870b3063ec3680f46178348e4d8758"} build_url:https://queue.taskcluster.net/v1/task/V8_984PgRWm8O6EMf8KBTQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011210 build_url: 'https://queue.taskcluster.net/v1/task/V8_984PgRWm8O6EMf8KBTQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a7d404b325e602f7e01c56dfae846942d65290853a3c0cba6b5b151618bd4d9e2882796347ff21e512b97b0f9110fcc4f7172237a71f23b537ae0d925ee13c69", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f6c25437322978b85a1f906c65479110d90f3bfd3ab051f1d2b4309c3fcdb9cd62b4fd19cd535b17428802304bee797bf7a369e29ec28c77abaf75d587d4a043", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fd49a20b80308904e6f067dbe6054392e939f85f711eb167a2e4665e7a959eb6c0f4d9d46139aba6510cc4e1a883b0692e870b3063ec3680f46178348e4d8758"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-05 15:55:26.132699) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-05 15:55:26.133025) ========= 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=20e666a3d4cfbb71505a330e000001b4-1478385271.233659-1212280682 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004454 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-05 15:55:26.218286) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-05 15:55:26.218626) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-05 15:55:26.218926) ========= ========= Total master_lag: 0.69 =========