builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-015 starttime: 1478883015.35 results: success (0) buildid: 20161111073320 builduid: 6040fd0114eb4b08a9086e42f87aaffb revision: d284cdb3ad6e0609a53a275df6efcff4255c30ec ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-11 08:50:15.353253) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-11 08:50:15.353701) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-11 08:50:15.353986) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-11 08:50:15.368374) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-11 08:50:15.368670) ========= 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-1478881625.57469-2121917952 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-11 08:50:15-- 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% 42.9M=0s 2016-11-11 08:50:15 (42.9 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.088550 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-11 08:50:15.473973) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-11 08:50:15.474295) ========= 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-1478881625.57469-2121917952 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021701 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-11 08:50:15.527149) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-11 08:50:15.527457) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev d284cdb3ad6e0609a53a275df6efcff4255c30ec --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 d284cdb3ad6e0609a53a275df6efcff4255c30ec --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-1478881625.57469-2121917952 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-11 08:50:16,043 truncating revision to first 12 chars 2016-11-11 08:50:16,043 Setting DEBUG logging. 2016-11-11 08:50:16,043 attempt 1/10 2016-11-11 08:50:16,043 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/d284cdb3ad6e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-11 08:50:16,353 unpacking tar archive at: mozilla-central-d284cdb3ad6e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.637127 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-11 08:50:16.177850) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-11 08:50:16.178221) ========= script_repo_revision: d284cdb3ad6e0609a53a275df6efcff4255c30ec ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-11 08:50:16.178769) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-11 08:50:16.179076) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-11 08:50:16.192259) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-11-11 08:50:16.192628) ========= /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-1478881625.57469-2121917952 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:50:16 INFO - MultiFileLogger online at 20161111 08:50:16 in /builds/slave/test 08:50:16 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 08:50:16 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:50:16 INFO - {'append_to_log': False, 08:50:16 INFO - 'base_work_dir': '/builds/slave/test', 08:50:16 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 08:50:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:50:16 INFO - 'branch': 'Firefox-Non-PGO', 08:50:16 INFO - 'buildbot_json_path': 'buildprops.json', 08:50:16 INFO - 'config_files': ('talos/linux_config.py',), 08:50:16 INFO - 'default_actions': ('clobber', 08:50:16 INFO - 'read-buildbot-config', 08:50:16 INFO - 'download-and-extract', 08:50:16 INFO - 'populate-webroot', 08:50:16 INFO - 'create-virtualenv', 08:50:16 INFO - 'install', 08:50:16 INFO - 'run-tests'), 08:50:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:50:16 INFO - 'download_minidump_stackwalk': True, 08:50:16 INFO - 'download_symbols': 'ondemand', 08:50:16 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:50:16 INFO - 'tooltool.py': '/tools/tooltool.py', 08:50:16 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:50:16 INFO - '/tools/misc-python/virtualenv.py')}, 08:50:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:50:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:50:16 INFO - 'installer_path': 'installer.exe', 08:50:16 INFO - 'log_level': 'info', 08:50:16 INFO - 'log_name': 'talos', 08:50:16 INFO - 'log_to_console': True, 08:50:16 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:50:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:50:16 INFO - 'opt_config_files': (), 08:50:16 INFO - 'pip_index': False, 08:50:16 INFO - 'sps_profile': False, 08:50:16 INFO - 'sps_profile_interval': 0, 08:50:16 INFO - 'suite': 'dromaeojs', 08:50:16 INFO - 'system_bits': '32', 08:50:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:50:16 INFO - 'title': 'talos-linux64-ix-015', 08:50:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:50:16 INFO - 'use_talos_json': True, 08:50:16 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:50:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:50:16 INFO - 'work_dir': 'build'} 08:50:16 INFO - [mozharness: 2016-11-11 16:50:16.800658Z] Running clobber step. 08:50:16 INFO - Running pre-action listener: _resource_record_pre_action 08:50:16 INFO - Running main action method: clobber 08:50:16 INFO - rmtree: /builds/slave/test/build 08:50:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:50:17 INFO - Running post-action listener: _resource_record_post_action 08:50:17 INFO - [mozharness: 2016-11-11 16:50:17.256059Z] Finished clobber step (success) 08:50:17 INFO - [mozharness: 2016-11-11 16:50:17.256159Z] Running read-buildbot-config step. 08:50:17 INFO - Running pre-action listener: _resource_record_pre_action 08:50:17 INFO - Running main action method: read_buildbot_config 08:50:17 INFO - Using buildbot properties: 08:50:17 INFO - { 08:50:17 INFO - "project": "", 08:50:17 INFO - "product": "firefox", 08:50:17 INFO - "script_repo_revision": "production", 08:50:17 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 08:50:17 INFO - "repository": "", 08:50:17 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 08:50:17 INFO - "buildid": "20161111073320", 08:50:17 INFO - "pgo_build": "False", 08:50:17 INFO - "basedir": "/builds/slave/test", 08:50:17 INFO - "buildnumber": 297, 08:50:17 INFO - "slavename": "talos-linux64-ix-015", 08:50:17 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 08:50:17 INFO - "platform": "ubuntu64_hw", 08:50:17 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 08:50:17 INFO - "branch": "mozilla-central", 08:50:17 INFO - "repo_path": "mozilla-central", 08:50:17 INFO - "revision": "d284cdb3ad6e0609a53a275df6efcff4255c30ec", 08:50:17 INFO - "stage_platform": "linux64", 08:50:17 INFO - "builduid": "6040fd0114eb4b08a9086e42f87aaffb", 08:50:17 INFO - "slavebuilddir": "test" 08:50:17 INFO - } 08:50:17 INFO - Found installer url https://queue.taskcluster.net/v1/task/ZI7JOZs5RnW2CrtFnU4v0g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 08:50:17 INFO - Running post-action listener: _resource_record_post_action 08:50:17 INFO - [mozharness: 2016-11-11 16:50:17.258583Z] Finished read-buildbot-config step (success) 08:50:17 INFO - [mozharness: 2016-11-11 16:50:17.258670Z] Running download-and-extract step. 08:50:17 INFO - Running pre-action listener: _resource_record_pre_action 08:50:17 INFO - Running main action method: download_and_extract 08:50:17 INFO - mkdir: /builds/slave/test/build/tests 08:50:17 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')]} 08:50:17 INFO - trying https://queue.taskcluster.net/v1/task/ZI7JOZs5RnW2CrtFnU4v0g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 08:50:17 INFO - Downloading https://queue.taskcluster.net/v1/task/ZI7JOZs5RnW2CrtFnU4v0g/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 08:50:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZI7JOZs5RnW2CrtFnU4v0g/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 08:50:17 INFO - Downloaded 1361 bytes. 08:50:17 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 08:50:17 INFO - Using the following test package requirements: 08:50:17 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 08:50:17 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 08:50:17 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:50:17 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 08:50:17 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:50:17 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 08:50:17 INFO - u'jsshell-linux-x86_64.zip'], 08:50:17 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 08:50:17 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:50:17 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 08:50:17 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 08:50:17 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:50:17 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 08:50:17 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:50:17 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 08:50:17 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:50:17 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 08:50:17 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:50:17 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:50:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZI7JOZs5RnW2CrtFnU4v0g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 08:50:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZI7JOZs5RnW2CrtFnU4v0g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:50:17 INFO - Fetch https://queue.taskcluster.net/v1/task/ZI7JOZs5RnW2CrtFnU4v0g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 08:50:18 INFO - Http code: 200 08:50:18 INFO - via: 1.1 441811a054e8d055b893175754efd0c3.cloudfront.net (CloudFront) 08:50:18 INFO - x-amz-cf-id: swScb07qE6XuzTe4b--pKxTvK2RSCfZFcoME04KcIE6vpzi7bc_ruA== 08:50:18 INFO - x-amz-version-id: bybohKsvTYNbC2rHkeI3aPoIjjXuKzYU 08:50:19 INFO - Expected file size: 20414089 08:50:19 INFO - Obtained file size: 20414089 08:50:23 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 08:50:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZI7JOZs5RnW2CrtFnU4v0g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 08:50:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZI7JOZs5RnW2CrtFnU4v0g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:50:23 INFO - Fetch https://queue.taskcluster.net/v1/task/ZI7JOZs5RnW2CrtFnU4v0g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 08:50:23 INFO - Http code: 200 08:50:23 INFO - via: 1.1 49c80a47c1441dd194a8337982f1cd7e.cloudfront.net (CloudFront) 08:50:23 INFO - x-amz-cf-id: DyqvJeU_2lhWjGA6ujLXyNZCRKu9gG1XQNtcOKjkyV3ZYHUHiZSgrw== 08:50:23 INFO - x-amz-version-id: bybohKsvTYNbC2rHkeI3aPoIjjXuKzYU 08:50:24 INFO - Expected file size: 20414089 08:50:24 INFO - Obtained file size: 20414089 08:50:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZI7JOZs5RnW2CrtFnU4v0g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 08:50:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZI7JOZs5RnW2CrtFnU4v0g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 08:50:28 INFO - Fetch https://queue.taskcluster.net/v1/task/ZI7JOZs5RnW2CrtFnU4v0g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 08:50:29 INFO - Http code: 200 08:50:29 INFO - via: 1.1 5c2ff4ca1e447265402af29264e83497.cloudfront.net (CloudFront) 08:50:29 INFO - x-amz-cf-id: U0ehX7pq1JaWlmlgKr_OyTaYIFgUv2kXrXOBIv_14Eb3dQwEUdqCPg== 08:50:29 INFO - x-amz-version-id: oq4cGFLKJrZS5C2eMDO6IozE7WPnKxZH 08:50:30 INFO - Expected file size: 14409038 08:50:30 INFO - Obtained file size: 14409038 08:50:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:50:30 INFO - trying https://queue.taskcluster.net/v1/task/ZI7JOZs5RnW2CrtFnU4v0g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 08:50:30 INFO - Downloading https://queue.taskcluster.net/v1/task/ZI7JOZs5RnW2CrtFnU4v0g/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 08:50:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZI7JOZs5RnW2CrtFnU4v0g/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 08:50:32 INFO - Downloaded 55711752 bytes. 08:50:32 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZI7JOZs5RnW2CrtFnU4v0g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 08:50:32 INFO - mkdir: /builds/slave/test/properties 08:50:32 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:50:32 INFO - Writing to file /builds/slave/test/properties/build_url 08:50:32 INFO - Contents: 08:50:32 INFO - build_url:https://queue.taskcluster.net/v1/task/ZI7JOZs5RnW2CrtFnU4v0g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 08:50:33 INFO - Running post-action listener: _resource_record_post_action 08:50:33 INFO - Running post-action listener: set_extra_try_arguments 08:50:33 INFO - [mozharness: 2016-11-11 16:50:33.028855Z] Finished download-and-extract step (success) 08:50:33 INFO - [mozharness: 2016-11-11 16:50:33.029118Z] Running populate-webroot step. 08:50:33 INFO - Running pre-action listener: _resource_record_pre_action 08:50:33 INFO - Running main action method: populate_webroot 08:50:33 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:50:33 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:50:33 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:50:33 INFO - '--tppagecycles', 08:50:33 INFO - '7'], 08:50:33 INFO - 'tests': ['tsvgm']}}, 08:50:33 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:50:33 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:50:33 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:50:33 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:50:33 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:50:33 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:50:33 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:50:33 INFO - 'talos_options': ['--disable-e10s'], 08:50:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:50:33 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:50:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:50:33 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:50:33 INFO - 'talos_options': ['--disable-e10s'], 08:50:33 INFO - 'tests': ['damp', 'tps']}, 08:50:33 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:50:33 INFO - 'tests': ['damp', 'tps']}, 08:50:33 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:50:33 INFO - 'tests': ['dromaeo_dom']}, 08:50:33 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:50:33 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:50:33 INFO - 'tests': ['basic_compositor_video']}, 08:50:33 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:50:33 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:50:33 INFO - 'tests': ['a11yr', 08:50:33 INFO - 'ts_paint', 08:50:33 INFO - 'tpaint', 08:50:33 INFO - 'sessionrestore', 08:50:33 INFO - 'sessionrestore_no_auto_restore', 08:50:33 INFO - 'tabpaint']}, 08:50:33 INFO - 'other-e10s': {'tests': ['a11yr', 08:50:33 INFO - 'ts_paint', 08:50:33 INFO - 'tpaint', 08:50:33 INFO - 'sessionrestore', 08:50:33 INFO - 'sessionrestore_no_auto_restore', 08:50:33 INFO - 'tabpaint']}, 08:50:33 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:50:33 INFO - 'ts_paint', 08:50:33 INFO - 'tpaint', 08:50:33 INFO - 'sessionrestore', 08:50:33 INFO - 'sessionrestore_no_auto_restore', 08:50:33 INFO - 'tabpaint']}, 08:50:33 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:50:33 INFO - 'ts_paint', 08:50:33 INFO - 'tpaint', 08:50:33 INFO - 'sessionrestore', 08:50:33 INFO - 'sessionrestore_no_auto_restore', 08:50:33 INFO - 'tabpaint']}, 08:50:33 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:50:33 INFO - 'tests': ['a11yr', 08:50:33 INFO - 'ts_paint', 08:50:33 INFO - 'tpaint', 08:50:33 INFO - 'sessionrestore', 08:50:33 INFO - 'sessionrestore_no_auto_restore', 08:50:33 INFO - 'tabpaint']}, 08:50:33 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:50:33 INFO - 'tests': ['a11yr', 08:50:33 INFO - 'ts_paint', 08:50:33 INFO - 'tpaint', 08:50:33 INFO - 'sessionrestore', 08:50:33 INFO - 'sessionrestore_no_auto_restore', 08:50:33 INFO - 'tabpaint']}, 08:50:33 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:50:33 INFO - 'tests': ['tsvgx', 08:50:33 INFO - 'tsvgr_opacity', 08:50:33 INFO - 'tart', 08:50:33 INFO - 'tscrollx', 08:50:33 INFO - 'cart']}, 08:50:33 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:50:33 INFO - 'tsvgr_opacity', 08:50:33 INFO - 'tart', 08:50:33 INFO - 'tscrollx', 08:50:33 INFO - 'cart']}, 08:50:33 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:50:33 INFO - 'talos_options': ['--disable-e10s'], 08:50:33 INFO - 'tests': ['tp5o']}, 08:50:33 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:50:33 INFO - 'tests': ['tp5o']}, 08:50:33 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:50:33 INFO - 'talos_options': ['--disable-e10s', 08:50:33 INFO - '--xperf_path', 08:50:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:50:33 INFO - 'tests': ['tp5n']}, 08:50:33 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:50:33 INFO - 'talos_options': ['--xperf_path', 08:50:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:50:33 INFO - 'tests': ['tp5n']}}, 08:50:33 INFO - 'talos.zip': {'path': '', 08:50:33 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:50:33 INFO - Running post-action listener: _resource_record_post_action 08:50:33 INFO - [mozharness: 2016-11-11 16:50:33.044834Z] Finished populate-webroot step (success) 08:50:33 INFO - [mozharness: 2016-11-11 16:50:33.044921Z] Running create-virtualenv step. 08:50:33 INFO - Running pre-action listener: _resource_record_pre_action 08:50:33 INFO - Running main action method: create_virtualenv 08:50:33 INFO - Creating virtualenv /builds/slave/test/build/venv 08:50:33 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 08:50:33 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:50:33 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:50:33 INFO - Using real prefix '/usr' 08:50:33 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:50:33 INFO - Installing distribute.............................................................................................................................................................................................done. 08:50:35 INFO - Installing pip.................done. 08:50:35 INFO - Return code: 0 08:50:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:50:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:50:35 INFO - Reading from file tmpfile_stdout 08:50:35 INFO - Output received: 08:50:35 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) 08:50:35 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:50:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:50:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:50:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:50:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:50:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:50:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:50:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f618704af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c558a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d22ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d1ff60>, '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 0x1d20d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d211d0>, '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-1478881625.57469-2121917952', '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 08:50:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:50:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:50:35 INFO - Using env: {'DISPLAY': ':0', 08:50:35 INFO - 'HOME': '/home/cltbld', 08:50:35 INFO - 'LANG': 'en_US.UTF-8', 08:50:35 INFO - 'LANGUAGE': 'en_US:en', 08:50:35 INFO - 'LOGNAME': 'cltbld', 08:50:35 INFO - 'MAIL': '/var/mail/cltbld', 08:50:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:50:35 INFO - 'MOZ_NO_REMOTE': '1', 08:50:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:50:35 INFO - 'NO_EM_RESTART': '1', 08:50:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:50:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:50:35 INFO - 'PWD': '/builds/slave/test', 08:50:35 INFO - 'SHELL': '/bin/bash', 08:50:35 INFO - 'SHLVL': '1', 08:50:35 INFO - 'TERM': 'linux', 08:50:35 INFO - 'TMOUT': '86400', 08:50:35 INFO - 'USER': 'cltbld', 08:50:35 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1478881625.57469-2121917952', 08:50:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:50:35 INFO - '_': '/tools/buildbot/bin/python'} 08:50:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:50:36 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 08:50:36 INFO - Cleaning up... 08:50:36 INFO - Return code: 0 08:50:36 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:50:36 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')]} 08:50:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:50:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:50:36 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')]} 08:50:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:50:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:50:36 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 0x7f618704af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c558a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d22ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d1ff60>, '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 0x1d20d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d211d0>, '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-1478881625.57469-2121917952', '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 08:50:36 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 08:50:36 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 08:50:36 INFO - Using env: {'DISPLAY': ':0', 08:50:36 INFO - 'HOME': '/home/cltbld', 08:50:36 INFO - 'LANG': 'en_US.UTF-8', 08:50:36 INFO - 'LANGUAGE': 'en_US:en', 08:50:36 INFO - 'LOGNAME': 'cltbld', 08:50:36 INFO - 'MAIL': '/var/mail/cltbld', 08:50:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:50:36 INFO - 'MOZ_NO_REMOTE': '1', 08:50:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:50:36 INFO - 'NO_EM_RESTART': '1', 08:50:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:50:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:50:36 INFO - 'PWD': '/builds/slave/test', 08:50:36 INFO - 'SHELL': '/bin/bash', 08:50:36 INFO - 'SHLVL': '1', 08:50:36 INFO - 'TERM': 'linux', 08:50:36 INFO - 'TMOUT': '86400', 08:50:36 INFO - 'USER': 'cltbld', 08:50:36 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1478881625.57469-2121917952', 08:50:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:50:36 INFO - '_': '/tools/buildbot/bin/python'} 08:50:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:50:36 INFO - Downloading/unpacking psutil>=3.1.1 08:50:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:50:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:50:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:50:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:50:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:50:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:50:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:50:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:50:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:50:38 INFO - Installing collected packages: psutil 08:50:38 INFO - Running setup.py install for psutil 08:50:38 INFO - building 'psutil._psutil_linux' extension 08:50:38 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 08:50:38 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 08:50:38 INFO - building 'psutil._psutil_posix' extension 08:50:38 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 08:50:38 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 08:50:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:50:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:50:38 INFO - Successfully installed psutil 08:50:38 INFO - Cleaning up... 08:50:39 INFO - Return code: 0 08:50:39 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:50:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:50:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:50:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:50:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:50:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:50:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:50:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f618704af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c558a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d22ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d1ff60>, '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 0x1d20d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d211d0>, '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-1478881625.57469-2121917952', '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 08:50:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:50:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:50:39 INFO - Using env: {'DISPLAY': ':0', 08:50:39 INFO - 'HOME': '/home/cltbld', 08:50:39 INFO - 'LANG': 'en_US.UTF-8', 08:50:39 INFO - 'LANGUAGE': 'en_US:en', 08:50:39 INFO - 'LOGNAME': 'cltbld', 08:50:39 INFO - 'MAIL': '/var/mail/cltbld', 08:50:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:50:39 INFO - 'MOZ_NO_REMOTE': '1', 08:50:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:50:39 INFO - 'NO_EM_RESTART': '1', 08:50:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:50:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:50:39 INFO - 'PWD': '/builds/slave/test', 08:50:39 INFO - 'SHELL': '/bin/bash', 08:50:39 INFO - 'SHLVL': '1', 08:50:39 INFO - 'TERM': 'linux', 08:50:39 INFO - 'TMOUT': '86400', 08:50:39 INFO - 'USER': 'cltbld', 08:50:39 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1478881625.57469-2121917952', 08:50:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:50:39 INFO - '_': '/tools/buildbot/bin/python'} 08:50:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:50:39 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:50:39 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 08:50:39 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 08:50:39 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 08:50:39 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 08:50:39 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 08:50:39 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 08:50:41 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:50:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:50:41 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:50:41 INFO - Installing collected packages: mozsystemmonitor 08:50:41 INFO - Running setup.py install for mozsystemmonitor 08:50:41 INFO - Successfully installed mozsystemmonitor 08:50:41 INFO - Cleaning up... 08:50:41 INFO - Return code: 0 08:50:41 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:50:41 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')]} 08:50:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:50:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:50:41 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')]} 08:50:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:50:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:50:41 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 0x7f618704af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c558a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d22ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d1ff60>, '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 0x1d20d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d211d0>, '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-1478881625.57469-2121917952', '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 08:50:41 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 08:50:41 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 08:50:41 INFO - Using env: {'DISPLAY': ':0', 08:50:41 INFO - 'HOME': '/home/cltbld', 08:50:41 INFO - 'LANG': 'en_US.UTF-8', 08:50:41 INFO - 'LANGUAGE': 'en_US:en', 08:50:41 INFO - 'LOGNAME': 'cltbld', 08:50:41 INFO - 'MAIL': '/var/mail/cltbld', 08:50:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:50:41 INFO - 'MOZ_NO_REMOTE': '1', 08:50:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:50:41 INFO - 'NO_EM_RESTART': '1', 08:50:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:50:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:50:41 INFO - 'PWD': '/builds/slave/test', 08:50:41 INFO - 'SHELL': '/bin/bash', 08:50:41 INFO - 'SHLVL': '1', 08:50:41 INFO - 'TERM': 'linux', 08:50:41 INFO - 'TMOUT': '86400', 08:50:41 INFO - 'USER': 'cltbld', 08:50:41 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1478881625.57469-2121917952', 08:50:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:50:41 INFO - '_': '/tools/buildbot/bin/python'} 08:50:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:50:41 INFO - Downloading/unpacking jsonschema==2.5.1 08:50:41 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 08:50:41 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 08:50:41 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 08:50:41 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 08:50:41 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 08:50:41 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 08:50:43 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:50:43 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:50:43 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 08:50:43 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 08:50:43 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 08:50:43 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 08:50:43 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 08:50:43 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 08:50:43 INFO - Downloading functools32-3.2.3-2.tar.gz 08:50:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:50:43 INFO - warning: no files found matching '*.txt' 08:50:43 INFO - no previously-included directories found matching 'build' 08:50:43 INFO - no previously-included directories found matching 'dist' 08:50:43 INFO - no previously-included directories found matching '.git*' 08:50:43 INFO - Installing collected packages: jsonschema, functools32 08:50:43 INFO - Running setup.py install for functools32 08:50:43 INFO - warning: no files found matching '*.txt' 08:50:43 INFO - no previously-included directories found matching 'build' 08:50:43 INFO - no previously-included directories found matching 'dist' 08:50:43 INFO - no previously-included directories found matching '.git*' 08:50:43 INFO - Successfully installed jsonschema functools32 08:50:43 INFO - Cleaning up... 08:50:44 INFO - Return code: 0 08:50:44 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:50:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:50:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:50:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:50:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:50:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:50:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:50:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f618704af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c558a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d22ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d1ff60>, '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 0x1d20d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d211d0>, '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-1478881625.57469-2121917952', '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 08:50:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 08:50:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 08:50:44 INFO - Using env: {'DISPLAY': ':0', 08:50:44 INFO - 'HOME': '/home/cltbld', 08:50:44 INFO - 'LANG': 'en_US.UTF-8', 08:50:44 INFO - 'LANGUAGE': 'en_US:en', 08:50:44 INFO - 'LOGNAME': 'cltbld', 08:50:44 INFO - 'MAIL': '/var/mail/cltbld', 08:50:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:50:44 INFO - 'MOZ_NO_REMOTE': '1', 08:50:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:50:44 INFO - 'NO_EM_RESTART': '1', 08:50:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:50:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:50:44 INFO - 'PWD': '/builds/slave/test', 08:50:44 INFO - 'SHELL': '/bin/bash', 08:50:44 INFO - 'SHLVL': '1', 08:50:44 INFO - 'TERM': 'linux', 08:50:44 INFO - 'TMOUT': '86400', 08:50:44 INFO - 'USER': 'cltbld', 08:50:44 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1478881625.57469-2121917952', 08:50:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:50:44 INFO - '_': '/tools/buildbot/bin/python'} 08:50:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:50:44 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:50:44 INFO - Cleaning up... 08:50:44 INFO - Return code: 0 08:50:44 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:50:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:50:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:50:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:50:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:50:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:50:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:50:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f618704af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c558a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d22ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d1ff60>, '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 0x1d20d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d211d0>, '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-1478881625.57469-2121917952', '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 08:50:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:50:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:50:44 INFO - Using env: {'DISPLAY': ':0', 08:50:44 INFO - 'HOME': '/home/cltbld', 08:50:44 INFO - 'LANG': 'en_US.UTF-8', 08:50:44 INFO - 'LANGUAGE': 'en_US:en', 08:50:44 INFO - 'LOGNAME': 'cltbld', 08:50:44 INFO - 'MAIL': '/var/mail/cltbld', 08:50:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:50:44 INFO - 'MOZ_NO_REMOTE': '1', 08:50:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:50:44 INFO - 'NO_EM_RESTART': '1', 08:50:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:50:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:50:44 INFO - 'PWD': '/builds/slave/test', 08:50:44 INFO - 'SHELL': '/bin/bash', 08:50:44 INFO - 'SHLVL': '1', 08:50:44 INFO - 'TERM': 'linux', 08:50:44 INFO - 'TMOUT': '86400', 08:50:44 INFO - 'USER': 'cltbld', 08:50:44 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1478881625.57469-2121917952', 08:50:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:50:44 INFO - '_': '/tools/buildbot/bin/python'} 08:50:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:50:44 INFO - Downloading/unpacking blobuploader==1.2.4 08:50:44 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 08:50:44 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 08:50:44 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 08:50:44 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 08:50:44 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 08:50:44 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 08:50:46 INFO - Downloading blobuploader-1.2.4.tar.gz 08:50:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:50:46 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:50:46 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 08:50:46 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 08:50:46 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 08:50:46 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 08:50:46 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 08:50:46 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 08:50:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:50:46 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:50:46 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 08:50:46 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 08:50:46 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 08:50:46 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 08:50:46 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 08:50:46 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 08:50:47 INFO - Downloading docopt-0.6.1.tar.gz 08:50:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:50:47 INFO - Installing collected packages: blobuploader, requests, docopt 08:50:47 INFO - Running setup.py install for blobuploader 08:50:47 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:50:47 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:50:47 INFO - Running setup.py install for requests 08:50:47 INFO - Running setup.py install for docopt 08:50:47 INFO - Successfully installed blobuploader requests docopt 08:50:47 INFO - Cleaning up... 08:50:47 INFO - Return code: 0 08:50:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:50:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:50:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:50:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:50:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:50:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:50:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:50:47 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 0x7f618704af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c558a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d22ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d1ff60>, '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 0x1d20d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d211d0>, '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-1478881625.57469-2121917952', '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 08:50:47 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 08:50:47 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 08:50:47 INFO - Using env: {'DISPLAY': ':0', 08:50:47 INFO - 'HOME': '/home/cltbld', 08:50:47 INFO - 'LANG': 'en_US.UTF-8', 08:50:47 INFO - 'LANGUAGE': 'en_US:en', 08:50:47 INFO - 'LOGNAME': 'cltbld', 08:50:47 INFO - 'MAIL': '/var/mail/cltbld', 08:50:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:50:47 INFO - 'MOZ_NO_REMOTE': '1', 08:50:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:50:47 INFO - 'NO_EM_RESTART': '1', 08:50:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:50:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:50:47 INFO - 'PWD': '/builds/slave/test', 08:50:47 INFO - 'SHELL': '/bin/bash', 08:50:47 INFO - 'SHLVL': '1', 08:50:47 INFO - 'TERM': 'linux', 08:50:47 INFO - 'TMOUT': '86400', 08:50:47 INFO - 'USER': 'cltbld', 08:50:47 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1478881625.57469-2121917952', 08:50:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:50:47 INFO - '_': '/tools/buildbot/bin/python'} 08:50:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:50:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:50:48 INFO - Running setup.py (path:/tmp/pip-x389z2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:50:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:50:48 INFO - Running setup.py (path:/tmp/pip-uIMCqK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:50:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:50:48 INFO - Running setup.py (path:/tmp/pip-S0a5Bl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:50:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:50:48 INFO - Running setup.py (path:/tmp/pip-AKgoJv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:50:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:50:48 INFO - Running setup.py (path:/tmp/pip-5deShV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:50:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:50:48 INFO - Running setup.py (path:/tmp/pip-XXijKX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:50:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:50:48 INFO - Running setup.py (path:/tmp/pip-0D3AQP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:50:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:50:48 INFO - Running setup.py (path:/tmp/pip-4_src1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:50:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:50:48 INFO - Running setup.py (path:/tmp/pip-Ox8z25-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:50:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:50:48 INFO - Running setup.py (path:/tmp/pip-PRW0gs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:50:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:50:48 INFO - Running setup.py (path:/tmp/pip-Oogm9E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:50:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:50:48 INFO - Running setup.py (path:/tmp/pip-x2L6BJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:50:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:50:48 INFO - Running setup.py (path:/tmp/pip-52Onx_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:50:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:50:48 INFO - Running setup.py (path:/tmp/pip-cHmRbs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:50:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:50:49 INFO - Running setup.py (path:/tmp/pip-HCX0XI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:50:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:50:49 INFO - Running setup.py (path:/tmp/pip-RwWci_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:50:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:50:49 INFO - Running setup.py (path:/tmp/pip-VLoC3C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:50:49 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:50:49 INFO - Running setup.py install for manifestparser 08:50:49 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:50:49 INFO - Running setup.py install for mozcrash 08:50:49 INFO - Running setup.py install for mozdebug 08:50:49 INFO - Running setup.py install for mozdevice 08:50:49 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:50:49 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:50:49 INFO - Running setup.py install for mozfile 08:50:49 INFO - Running setup.py install for mozhttpd 08:50:49 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:50:49 INFO - Running setup.py install for mozinfo 08:50:49 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:50:49 INFO - Running setup.py install for mozInstall 08:50:50 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:50:50 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:50:50 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:50:50 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:50:50 INFO - Running setup.py install for mozleak 08:50:50 INFO - Running setup.py install for mozlog 08:50:50 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:50:50 INFO - Running setup.py install for moznetwork 08:50:50 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:50:50 INFO - Running setup.py install for mozprocess 08:50:50 INFO - Running setup.py install for mozprofile 08:50:50 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:50:50 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:50:50 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:50:50 INFO - Running setup.py install for mozrunner 08:50:50 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:50:50 INFO - Running setup.py install for mozscreenshot 08:50:50 INFO - Running setup.py install for moztest 08:50:50 INFO - Running setup.py install for mozversion 08:50:51 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:50:51 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:50:51 INFO - Cleaning up... 08:50:51 INFO - Return code: 0 08:50:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:50:51 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')]} 08:50:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:50:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:50:51 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')]} 08:50:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:50:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:50:51 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 0x7f618704af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c558a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d22ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d1ff60>, '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 0x1d20d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d211d0>, '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-1478881625.57469-2121917952', '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 08:50:51 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 08:50:51 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 08:50:51 INFO - Using env: {'DISPLAY': ':0', 08:50:51 INFO - 'HOME': '/home/cltbld', 08:50:51 INFO - 'LANG': 'en_US.UTF-8', 08:50:51 INFO - 'LANGUAGE': 'en_US:en', 08:50:51 INFO - 'LOGNAME': 'cltbld', 08:50:51 INFO - 'MAIL': '/var/mail/cltbld', 08:50:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:50:51 INFO - 'MOZ_NO_REMOTE': '1', 08:50:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:50:51 INFO - 'NO_EM_RESTART': '1', 08:50:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:50:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:50:51 INFO - 'PWD': '/builds/slave/test', 08:50:51 INFO - 'SHELL': '/bin/bash', 08:50:51 INFO - 'SHLVL': '1', 08:50:51 INFO - 'TERM': 'linux', 08:50:51 INFO - 'TMOUT': '86400', 08:50:51 INFO - 'USER': 'cltbld', 08:50:51 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1478881625.57469-2121917952', 08:50:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:50:51 INFO - '_': '/tools/buildbot/bin/python'} 08:50:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:50:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:50:51 INFO - Running setup.py (path:/tmp/pip-Pgf24V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:50:51 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)) 08:50:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:50:51 INFO - Running setup.py (path:/tmp/pip-ybi9DU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:50:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:50:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:50:51 INFO - Running setup.py (path:/tmp/pip-WW2x86-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:50:51 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)) 08:50:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:50:51 INFO - Running setup.py (path:/tmp/pip-GNYDc4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:50:51 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)) 08:50:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:50:51 INFO - Running setup.py (path:/tmp/pip-aH4nMX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:50:51 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)) 08:50:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:50:51 INFO - Running setup.py (path:/tmp/pip-G6dXtk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:50:51 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)) 08:50:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:50:51 INFO - Running setup.py (path:/tmp/pip-COW0AD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:50:51 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)) 08:50:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:50:51 INFO - Running setup.py (path:/tmp/pip-hAA4hb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:50:51 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)) 08:50:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:50:51 INFO - Running setup.py (path:/tmp/pip-HvQvk_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:50:51 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)) 08:50:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:50:51 INFO - Running setup.py (path:/tmp/pip-adm__x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:50:52 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)) 08:50:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:50:52 INFO - Running setup.py (path:/tmp/pip-9nq_Ap-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:50:52 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)) 08:50:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:50:52 INFO - Running setup.py (path:/tmp/pip-C_Ti_y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:50:52 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)) 08:50:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:50:52 INFO - Running setup.py (path:/tmp/pip-JVPWXn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:50:52 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)) 08:50:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:50:52 INFO - Running setup.py (path:/tmp/pip-E6pxOT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:50:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 08:50:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:50:52 INFO - Running setup.py (path:/tmp/pip-BOisYR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:50:52 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)) 08:50:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:50:52 INFO - Running setup.py (path:/tmp/pip-NlKoij-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:50:52 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)) 08:50:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:50:52 INFO - Running setup.py (path:/tmp/pip-jx75ph-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:50:52 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)) 08:50:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:50:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:50:52 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)) 08:50:52 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)) 08:50:52 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)) 08:50:52 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:50: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 08:50: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 08:50: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 08:50: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 08:50: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 08:50: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 08:50:54 INFO - Downloading blessings-1.6.tar.gz 08:50:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:50:54 INFO - Installing collected packages: blessings 08:50:54 INFO - Running setup.py install for blessings 08:50:54 INFO - Successfully installed blessings 08:50:54 INFO - Cleaning up... 08:50:54 INFO - Return code: 0 08:50:54 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:50:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:50:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:50:54 INFO - Reading from file tmpfile_stdout 08:50:54 INFO - Current package versions: 08:50:54 INFO - argparse == 1.2.1 08:50:54 INFO - blessings == 1.6 08:50:54 INFO - blobuploader == 1.2.4 08:50:54 INFO - docopt == 0.6.1 08:50:54 INFO - functools32 == 3.2.3-2 08:50:54 INFO - jsonschema == 2.5.1 08:50:54 INFO - manifestparser == 1.1 08:50:54 INFO - mozInstall == 1.12 08:50:54 INFO - mozcrash == 1.0 08:50:54 INFO - mozdebug == 0.1 08:50:54 INFO - mozdevice == 0.48 08:50:54 INFO - mozfile == 1.2 08:50:54 INFO - mozhttpd == 0.7 08:50:54 INFO - mozinfo == 0.9 08:50:54 INFO - mozleak == 0.1 08:50:54 INFO - mozlog == 3.4 08:50:54 INFO - moznetwork == 0.27 08:50:54 INFO - mozprocess == 0.23 08:50:54 INFO - mozprofile == 0.28 08:50:54 INFO - mozrunner == 6.13 08:50:54 INFO - mozscreenshot == 0.1 08:50:54 INFO - mozsystemmonitor == 0.3 08:50:54 INFO - moztest == 0.7 08:50:54 INFO - mozversion == 1.4 08:50:54 INFO - psutil == 3.1.1 08:50:54 INFO - requests == 1.2.3 08:50:54 INFO - wsgiref == 0.1.2 08:50:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:50:54 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')]} 08:50:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:50:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:50:54 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')]} 08:50:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:50:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:50:54 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 0x7f618704af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c558a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d22ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d1ff60>, '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 0x1d20d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d211d0>, '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-1478881625.57469-2121917952', '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 08:50:54 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 08:50:54 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 08:50:54 INFO - Using env: {'DISPLAY': ':0', 08:50:54 INFO - 'HOME': '/home/cltbld', 08:50:54 INFO - 'LANG': 'en_US.UTF-8', 08:50:54 INFO - 'LANGUAGE': 'en_US:en', 08:50:54 INFO - 'LOGNAME': 'cltbld', 08:50:54 INFO - 'MAIL': '/var/mail/cltbld', 08:50:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:50:54 INFO - 'MOZ_NO_REMOTE': '1', 08:50:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:50:54 INFO - 'NO_EM_RESTART': '1', 08:50:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:50:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:50:54 INFO - 'PWD': '/builds/slave/test', 08:50:54 INFO - 'SHELL': '/bin/bash', 08:50:54 INFO - 'SHLVL': '1', 08:50:54 INFO - 'TERM': 'linux', 08:50:54 INFO - 'TMOUT': '86400', 08:50:54 INFO - 'USER': 'cltbld', 08:50:54 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1478881625.57469-2121917952', 08:50:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:50:54 INFO - '_': '/tools/buildbot/bin/python'} 08:50:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:50:55 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)) 08:50:55 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)) 08:50:55 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)) 08:50:55 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)) 08:50:55 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)) 08:50:55 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)) 08:50:55 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)) 08:50:55 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)) 08:50:55 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)) 08:50:55 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)) 08:50:55 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)) 08:50:55 INFO - Cleaning up... 08:50:55 INFO - Return code: 0 08:50:55 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:50:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:50:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:50:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:50:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:50:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:50:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:50:55 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 0x7f618704af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c558a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d22ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d1ff60>, '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 0x1d20d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d211d0>, '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-1478881625.57469-2121917952', '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 08:50:55 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 08:50:55 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 08:50:55 INFO - Using env: {'DISPLAY': ':0', 08:50:55 INFO - 'HOME': '/home/cltbld', 08:50:55 INFO - 'LANG': 'en_US.UTF-8', 08:50:55 INFO - 'LANGUAGE': 'en_US:en', 08:50:55 INFO - 'LOGNAME': 'cltbld', 08:50:55 INFO - 'MAIL': '/var/mail/cltbld', 08:50:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:50:55 INFO - 'MOZ_NO_REMOTE': '1', 08:50:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:50:55 INFO - 'NO_EM_RESTART': '1', 08:50:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:50:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:50:55 INFO - 'PWD': '/builds/slave/test', 08:50:55 INFO - 'SHELL': '/bin/bash', 08:50:55 INFO - 'SHLVL': '1', 08:50:55 INFO - 'TERM': 'linux', 08:50:55 INFO - 'TMOUT': '86400', 08:50:55 INFO - 'USER': 'cltbld', 08:50:55 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1478881625.57469-2121917952', 08:50:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:50:55 INFO - '_': '/tools/buildbot/bin/python'} 08:50:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:50:55 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:50:55 INFO - Cleaning up... 08:50:55 INFO - Return code: 0 08:50:55 INFO - Running post-action listener: _resource_record_post_action 08:50:55 INFO - Running post-action listener: _start_resource_monitoring 08:50:55 INFO - Starting resource monitoring. 08:50:55 INFO - [mozharness: 2016-11-11 16:50:55.466352Z] Finished create-virtualenv step (success) 08:50:55 INFO - [mozharness: 2016-11-11 16:50:55.466817Z] Running install step. 08:50:55 INFO - Running pre-action listener: _resource_record_pre_action 08:50:55 INFO - Running main action method: install 08:50:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:50:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:50:55 INFO - Reading from file tmpfile_stdout 08:50:55 INFO - Detecting whether we're running mozinstall >=1.0... 08:50:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:50:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:50:55 INFO - Reading from file tmpfile_stdout 08:50:55 INFO - Output received: 08:50:55 INFO - Usage: mozinstall [options] installer 08:50:55 INFO - Options: 08:50:55 INFO - -h, --help show this help message and exit 08:50:55 INFO - -d DEST, --destination=DEST 08:50:55 INFO - Directory to install application into. [default: 08:50:55 INFO - "/builds/slave/test"] 08:50:55 INFO - --app=APP Application being installed. [default: firefox] 08:50:55 INFO - mkdir: /builds/slave/test/build/application 08:50:55 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'] 08:50:55 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 08:51:11 INFO - Reading from file tmpfile_stdout 08:51:11 INFO - Output received: 08:51:11 INFO - /builds/slave/test/build/application/firefox/firefox 08:51:11 INFO - Running post-action listener: _resource_record_post_action 08:51:11 INFO - [mozharness: 2016-11-11 16:51:11.759029Z] Finished install step (success) 08:51:11 INFO - [mozharness: 2016-11-11 16:51:11.759272Z] Running run-tests step. 08:51:11 INFO - Running pre-action listener: _resource_record_pre_action 08:51:11 INFO - Running main action method: run_tests 08:51:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:51:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:51:11 INFO - Python 2.7.3 08:51:11 INFO - Return code: 0 08:51:11 INFO - grabbing minidump binary from tooltool 08:51:11 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')]} 08:51:11 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 0x1d1ff60>, '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 0x1d20d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d211d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:51:11 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 08:51:11 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 08:51:11 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 08:51:11 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:51:11 INFO - Return code: 0 08:51:11 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:51:11 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:51:11 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:51:11 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:51:11 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:51:11 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/ZI7JOZs5RnW2CrtFnU4v0g/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 08:51:11 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/ZI7JOZs5RnW2CrtFnU4v0g/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 08:51:11 INFO - Using env: {'DISPLAY': ':0', 08:51:11 INFO - 'HOME': '/home/cltbld', 08:51:11 INFO - 'LANG': 'en_US.UTF-8', 08:51:11 INFO - 'LANGUAGE': 'en_US:en', 08:51:11 INFO - 'LOGNAME': 'cltbld', 08:51:11 INFO - 'MAIL': '/var/mail/cltbld', 08:51:11 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:51:11 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:51:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:51:11 INFO - 'MOZ_NO_REMOTE': '1', 08:51:11 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:51:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:51:11 INFO - 'NO_EM_RESTART': '1', 08:51:11 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:51:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:51:11 INFO - 'PWD': '/builds/slave/test', 08:51:11 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:51:11 INFO - 'SHELL': '/bin/bash', 08:51:11 INFO - 'SHLVL': '1', 08:51:11 INFO - 'TERM': 'linux', 08:51:11 INFO - 'TMOUT': '86400', 08:51:11 INFO - 'USER': 'cltbld', 08:51:11 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1478881625.57469-2121917952', 08:51:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:51:11 INFO - '_': '/tools/buildbot/bin/python'} 08:51:11 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/ZI7JOZs5RnW2CrtFnU4v0g/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 08:51:12 INFO - mozversion application_buildid: 20161111073320 08:51:12 INFO - mozversion application_changeset: d284cdb3ad6e0609a53a275df6efcff4255c30ec 08:51:12 INFO - mozversion application_display_name: Nightly 08:51:12 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:51:12 INFO - mozversion application_name: Firefox 08:51:12 INFO - mozversion application_remotingname: firefox 08:51:12 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 08:51:12 INFO - mozversion application_vendor: Mozilla 08:51:12 INFO - mozversion application_version: 52.0a1 08:51:12 INFO - mozversion platform_buildid: 20161111073320 08:51:12 INFO - mozversion platform_changeset: d284cdb3ad6e0609a53a275df6efcff4255c30ec 08:51:12 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 08:51:12 INFO - mozversion platform_version: 52.0a1 08:51:12 INFO - using testdate: 1478883072 08:51:12 INFO - actual date: 1478883072 08:51:12 INFO - starting webserver on 'localhost:37218' 08:51:12 INFO - SUITE-START | Running 2 tests 08:51:12 INFO - TEST-START | dromaeo_css 08:51:12 INFO - operating with platform_type : linux_ 08:51:12 INFO - Initialising browser for dromaeo_css test... 08:51:12 INFO - TEST-INFO | started process 24996 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFSTqeZ/profile http://localhost:37218/getInfo.html) 08:51:16 INFO - PROCESS | 24996 | __metrics Screen width/height:1600/1200 08:51:16 INFO - PROCESS | 24996 | colorDepth:24 08:51:16 INFO - PROCESS | 24996 | Browser inner width/height: 1024/697 08:51:16 INFO - PROCESS | 24996 | __metrics 08:51:16 INFO - PROCESS | 24996 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:51:16 INFO - PROCESS | 24996 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:51:17 INFO - PROCESS | 24996 | console.error: PushService: 08:51:17 INFO - PROCESS | 24996 | stateChangeProcessEnqueue: Error transitioning state 08:51:17 INFO - PROCESS | 24996 | UnknownError 08:51:17 INFO - TEST-INFO | 24996: exit 0 08:51:17 INFO - Browser initialized. 08:51:17 INFO - Running cycle 1/1 for dromaeo_css test... 08:51:17 INFO - TEST-INFO | started process 25078 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFSTqeZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:51:30 INFO - PROCESS | 25078 | RSS: Main: 174112768 08:51:30 INFO - PROCESS | 25078 | 08:52:21 INFO - PROCESS | 25078 | 1478883141029 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] 08:54:34 INFO - PROCESS | 25078 | Cycle 1(1): loaded http://localhost:37218/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37218/tests/dromaeo/cssquery-ext.html) 08:54:36 INFO - PROCESS | 25078 | RSS: Main: 318664704 08:54:36 INFO - PROCESS | 25078 | 08:57:39 INFO - PROCESS | 25078 | Cycle 1(1): loaded http://localhost:37218/tests/dromaeo/cssquery-ext.html (next: http://localhost:37218/tests/dromaeo/cssquery-jquery.html) 08:57:40 INFO - PROCESS | 25078 | RSS: Main: 280346624 08:57:40 INFO - PROCESS | 25078 | 09:00:42 INFO - PROCESS | 25078 | Cycle 1(1): loaded http://localhost:37218/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37218/tests/dromaeo/cssquery-mootools.html) 09:00:42 INFO - PROCESS | 25078 | RSS: Main: 260124672 09:00:42 INFO - PROCESS | 25078 | 09:03:45 INFO - PROCESS | 25078 | Cycle 1(1): loaded http://localhost:37218/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37218/tests/dromaeo/cssquery-prototype.html) 09:03:45 INFO - PROCESS | 25078 | RSS: Main: 243056640 09:03:45 INFO - PROCESS | 25078 | 09:06:48 INFO - PROCESS | 25078 | Cycle 1(1): loaded http://localhost:37218/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37218/tests/dromaeo/cssquery-yui.html) 09:06:49 INFO - PROCESS | 25078 | RSS: Main: 226570240 09:06:49 INFO - PROCESS | 25078 | 09:09:52 INFO - PROCESS | 25078 | Cycle 1(1): loaded http://localhost:37218/tests/dromaeo/cssquery-yui.html (next: http://localhost:37218/tests/dromaeo/cssquery-dojo.html) 09:09:53 INFO - PROCESS | 25078 | RSS: Main: 298344448 09:09:53 INFO - PROCESS | 25078 | 09:09:53 INFO - PROCESS | 25078 | __start_tp_report 09:09:53 INFO - PROCESS | 25078 | _x_x_mozilla_page_load 09:09:53 INFO - PROCESS | 25078 | _x_x_mozilla_page_load_details 09:09:53 INFO - PROCESS | 25078 | |i|pagename|runs| 09:09:53 INFO - PROCESS | 25078 | |0;dojo.html;2596.8182227244097;2643.140979181764;2643.814932954694;2676.759091681748;2689.166358428886;4632.837850675227;4720.622350211984;4739.90520189596;4790.0419916016845;4804.966932109595;4697.553732395426;4731.432228132629;4764.618830493561;4800.159972004903;4841.8305359312435;4308.633766129867;4325.4593175853015;4357.4771027476745;4360.890977725567;4385.232584297735;4410.845620403286;4430.158269928719;4431.9778401108115;4455.198064348416;4489.6408287336935;4385.583369579885;4436.0240747035605;4444.044530425957;4447.599716025557;4469.620082293009;4253.3619957006695;4256.4679415073115;4280.336547835091;4341.826326946918;4345.630621397185;4272.978635106836;4290.163418133465;4327.502337231227;4333.544977777351;4342.5874541918465;4644.256918892995;4644.976775116136;4693.225617773063;4709.387779588666;4724.929126063112;4920.6309526785635;4976.776045077981;5008.398992120932;5015.548600625962;5020.246962955549;4997.275395067732;5046.041252162077;5049.469805670426;5067.5185857343495;5133.486651334837;4763.309320148559;4768.117898188777;4768.380110585671;4811.831585894512;4815.2054910939305;5234.659747116425;5236.921446178234;5237.423883372826;5238.92141617876;5271.6309858310315;4864.197407427735;4872.9512704873205;4917.975410122926;5000.374953130859;5005.374328208974;5062.443131255559;5075.568576671024;5122.334096567497;5133.948660513422;5179.326687530597;5047.369078865142;5084.313617661568;5084.872878178076;5114.846554603368;5148.613853960968;5054.216596427486;5086.821961231339;5093.286939828427;5100.056489549445;5142.357205349332;4199.454070970815;4255.957440425556;4265.55211702773;4396.27461468854;4404.273294906368;3700.703943684499;3722.236941427001;3729.645683660048;3730.6642402183393;3776.3957766757735;4265.893352666146;4272.87181384559;4276.91446171081;4293.699441039097;4319.222539942778;4967.105920934267;4988.276699878497;4989.625778066659;4999.550040496373;5042.823501177441;4269.380939763779;4305.268104422255;4337.522872484024;4342.6742994275555;4343.326784348431;4624.815007399667;4629.791659375336;4630.745309008037;4649.628029757679;4673.299005149255;4798.088363210979;4801.18379875415;4819.397575303087;4831.0820944020525;4844.006978569314;4890.413150421972;4899.3385892904;4935.876603084952;5122.615803814654;5131.435542090292;4678.625709943264;4714.9292760609305;4719.009008108198;4722.338872557776;4795.784189711401;4978.27814966835;4978.651494395358;4984.950150498448;5005.399352077774;5030.723310217827;4878.0975519529;5021.799128034838;5050.469700681522;5051.6716413433005;5093.006863661551;4809.2305231162845;4878.414590249193;4922.335484709662;4963.131451995814;5021.6735912165595;4949.777260023236;4969.751512424436;4975.875603109951;5008.649394542493;5025.623078269071;4900.044491324157;4926.5073492650445;4929.507049295185;4934.5805606523845;4967.180415231446;4826.444958829639;4848.80604775805;4891.046245981999;4945.455999840086;4946.975265123651;4872.43966943806;4875.341828853059;4877;4916.877078072934;4927.827526036572 09:09:53 INFO - PROCESS | 25078 | |1;ext.html;560.6972234993102;569.1491220625164;585.847679603303;588.1765528260438;592.8903152916708;28138.718612813867;37918;38844.367566702844;38861.41707874384;43241.56758432415;39354;39786.60213397865;39801;39815.40276895849;39872.40191397131;7458.813529661761;7608.7336943207;7611.048618922635;7611.771646850603;7613.428992825533;7343.77968660941;7424.628768561577;7430.479866409353;7430.479866409353;7432.479726419153;7440.553566785983;7490.700371985114;7494.587797671126;7497.987771650812;7498.100227972651;7423.035005449284;7457.8508429831645;7462.626868656545;7465.664045117983;7467.141278752904;7366.558006519626;7427.257274272583;7429.7399591014055;7429.739959101459;7430.814229644248;36651.266974660626;36988;36996.44505332422;37006.25987480262;37020;2897.1887871396043;3008.2329006103523;3178.5867837181017;3605.6214097519646;3633.073566240618;27888.16335509938;27907.860460697768;27970.860145699142;27997.440051199064;28206.153815385573;3470.340635279289;3531.9293614127832;3579.8568057277676;3634.800085995269;3650.4159334506353;232469;233853;233933.9999999983;236039;236104.81947590323;51335.229971550456;51857;51939;53630.731846341296;55146;56620.15069773957;57047.42952570421;57156.42843571594;57276;57329.71335143381;15029.098254104789;15299.311530981133;15306.617334566503;15310.770338444932;15311.310991005432;11515.25150865191;11737.823932641017;11744.58893938708;11755.823662645067;11757.412129393497;17774.822251777317;18063.54841128956;18070.277188912558;18082;18160.1827917744;6869.7595584154315;6895.241523432418;6924.203716572558;7068.893966590403;7296.562206267535;734.6951015328685;832.1886160993105;870.7997160653085;897.7755561109723;996.6312464388222;25984.610230846552;27029.594556081676;27083.86458067697;27542.173734787586;27564.724352756217;781.4686013510867;912.493566070837;946.2477330522252;946.2997381937316;996.6860438961849;13439.462421503225;14138.151710897173;14154.858451415354;14293.428262869369;14407;344551;346569;347884;348245;348815;47887.28169077467;48544;48606.75696621494;48608.7569562157;48664.51335486671;1050.3120456101267;1076.7146706122883;1081.1296905990753;1156.7628636129573;1171.4611278811672;26374;28058.158255252376;28912.566311504925;31051.53422698616;31262.53106203363;45452.77273613611;45881.31178032399;45917;45961.540384595726;46157.538424615326;298210;300878;300894;302204;302738;32151.874684385934;32257.677423226407;36948.44577331289;37011.81494092512;37013.96734620413;39847.60152398439;40125.197496050496;40148.1970360597;40575.57985470494;41603.1679366417;34038.65961340454;34121.658783412844;34360.82819585886;34421;34442.31115377628;33154.834225828716;33796.831015845746;34220.48669270013;34318.656813431546;34476.65523344835;30281.24296892595;31037.8448107758;34389.65610343865;36901.63098368982;37088.07279817918;32161.35677286488;36007.63992360148;36335;36567;37848.81075594604;27879;28774.712252878042;28882.855585722777;29296.121116366543;29333 09:09:53 INFO - PROCESS | 25078 | |2;jquery.html;343.7129996452962;348.99999999999994;350.97192224622034;354.7304048922818;374.591695052393;15540.222988850555;16749.58126046848;16935.745963810536;17102.31590736372;17193.226304816282;15687.05877647342;16407.261673224704;16491.17544122795;16507.58731031725;16575.917120414382;4226.852060177886;4473.083017981322;4500.842470513533;4546.681732278742;4553.977230113845;3445.7415693822936;4520.570545798144;4546.795394207252;4549.795259213343;4554.180247555439;3531.8234088295612;3567.4648802679676;3723.143676954302;5757.712114394263;5874.765009399619;5810.477057064863;5837;5845.941540584582;5848.912266316009;5850;4459.710118842298;4732.455767586737;4755.881102972418;4788.95211047892;4799.088173247072;11938.880611193863;12004.339761313124;12477.75044499114;19061.61876762471;19426;1657.1796960504507;1695.7965044194775;1717.939872104483;1718.8367105124994;1795.685754992884;8377.916220837835;8657.610407531676;8851;9363.297752668577;11987.160898737093;1591.554364777864;1647.571631375839;1657.693326734558;1684.676422504891;1707.5560354307845;64412.677936610955;64616.67691661511;65019.3498065018;66448;66560;9327.253819694408;9454.90545094554;9659.517024148765;9684.32209745311;9781.119699226962;13014.089013769135;13028.739425211443;13043;13048.54330098442;13063.412146453242;7016.5790052597;7096.467764917652;7227.855442891113;7412.073490813648;7425.331720145213;7078.362947334765;7091.92908070923;7297.306755858185;7344.632768361561;7350.852982940311;3995.6403923647013;4097.918041639151;4114.136031433372;4220.957790422118;4223.514295856015;1722.879398442097;1761.779777527809;1769.2480695704273;1835.2567210279858;1839.1907560673528;795.586295126531;848.4103548034057;882.9337799665051;884.2793123604242;921.1065266691298;15686;16302.83697163037;16336.75494867578;16417.01497910105;17055.31778728862;823.4112609484127;863.3352318714681;863.53369180643;870.0907551608584;872.6204101215991;5584.748686309126;5820.097884827774;5870.442307980735;5956.880862382728;8884.37809353352;219866;237133;395849;402173;407336;79461.60269198618;79673;79717;79999;82570.58714706388;397.32653152906124;414.9875503734953;415.42048841865426;415.95216550096524;417.7994562609903;9552.90447095548;9750.902490974999;9971.650992215238;10007.349522281029;10182.898171018194;37219.62780372162;37999.81000095092;38261;38545.807270963465;39162;49736.751316243186;51737;52408.475915241885;52558.73720631372;53229.467705324;4498;7075.973983772427;7367.557946523226;7530.322270995418;7596.126445458843;9745.366551174435;11549.82675259855;11705.239159454608;11717.414129293331;11847.822282665938;9984.650537231162;10114.696559103239;10232.795344092927;10600.151987841109;10657.840132398176;10199.38803671782;10216.948915255674;10301.484925753832;10357.533910973874;10396.48017599132;9957;10354.948225258826;10358.637447689294;10571.788564228826;10961.342319460859;6884.449244060363;7447.851042979219;7574.886376704464;7682.625286693004;7775.961120194363;8029.7189598363775;9495;10561.89438105609;10606.310589811637;10901.291416057931 09:09:53 INFO - PROCESS | 25078 | |3;mootools.html;1175.9529618815247;1285.8971282297414;1338.4177882621061;1374.8831349335312;1620.5948512871776;5962.64224146551;6768.3908448239645;7015.123109611299;7023;7195.208527062019;7058.082449281599;7116.288371162881;7126.572405655665;7128.073350464445;7131.251218622035;2067.3694523170466;2097.905594248255;2101.2960658179527;2102.579484103178;2105.1895020417173;1935.5644979879555;2005.6289586426485;2005.7492813398326;2007.3676791810533;2017.273781438681;2030.6141833051672;2040.2247146084542;2051.8871462069656;2068.265765653194;2068.513899233679;1991.332903477337;2009.1461129020108;2009.2264478175862;2009.6784514477613;2010.1657812008073;2006.197520991615;2032.5020370009295;2041.326362300452;2041.622299874528;2047.0276618606042;6859.794206173823;6947.826304342381;7014.473914456436;7020.684069216846;7022.929770702279;4150.128473020669;4327.242732521796;4333.739975601474;4335.891602709926;4337.306031035051;2547.808914331414;2745.409736906555;2788.428372183718;2802.5515917453313;2806.943861122766;826.2357319479518;841.032812265893;878.1218781218781;880.7669263031743;894.4767311123001;9034.909650903539;9092.363534552584;9101.499417532099;9111.726648200565;9115.407498512643;3504.212851445781;3527.1358517162944;3606.711463082947;3673.577538583044;3707.277080969185;7221.96389018062;7225.530340527849;7231.674574644048;7232.421406287484;7235.710571577078;4042.6765858731233;4047.716659833842;4054.0675644601315;4059.715819892638;4065.2682517147196;3368.4105281575626;3467.1505481156773;3811.599782022903;3816.904577385588;3930.5283365995692;2837.2197645647198;2912.199145235035;3001.669816320203;3025.0471101602925;3043.6195475565555;851.5018714052349;858.9012263589642;866.3156106675782;871.4575201892615;879.8372301124184;792.484884824857;796.7888509544975;805.070143983688;816.995915020433;817.5952903312898;4775.164346239394;4831.685940413932;4853.684510506806;4917.606591472673;5086.0845047891;379.7911148868167;384.2602989245691;386.95936926622863;390.4455672944426;394.1919065914863;3245.4807230842953;3254.1213872254834;3274.721648659843;3299.15871452778;3428.9142771430415;8059.113497515269;8325.084240733515;8404.159584041668;8430.241278284984;8438.74683759476;8381.916180838236;8389.203025712548;8389.706360277483;8390.790230244293;8395.916040839636;6122.846928826726;6279.560430769893;6342;6529.575577587537;6534.052562378429;4892.3884514435695;4994.425641051325;5015.3730783652045;5024.773885175103;5075.2387141929;7462.626868656437;7636.350910172698;7666.6166691664075;7667.539947603162;7688.615569221628;7752.961235193788;7765.06665870151;7779.260970207822;7840.059192896889;7842.254985776342;5121.385433747974;6133;6238.095476156022;6271.184745982993;6288.088227207121;5992.43071908168;6397.136386587751;6586.045023471665;6624.072629831731;6806.8638627228165;6066.211392519121;6084.939150608438;6127.693416507266;6238.812835614939;6289.96855015722;6032.75868965254;6092.238470191226;6110.908336374869;6122.326544080237;6126.23422072241;5776.797812076726;5787.421257874179;5800.883982320245;5830.912536311874;5837.153612726046;4132.958670413257;4160.439835061852;4245.702800803914;4258.488981322261;4333.371661109185;4202.7132325028915;4229.365595160751;4236.78816059202;4297.076128632359;4315.697901146889 09:09:53 INFO - PROCESS | 25078 | |4;prototype.html;277.57115256928057;278.4472821449423;282.7229315271034;283.0348511575528;289.6061356555086;4671.322658214557;4812.278158276256;4813.8796530086765;4860.246661767432;4872.683275587089;4646.442426908768;4716.316134160545;4743.928841067378;4746.572808447239;4752.2396416573265;3722.1997270586817;3737.364648009845;3741.494898188737;3741.9625803742024;3746.7939263340504;3589.0309616403556;3743.3262012837677;3755.071044585228;3757.3800322946818;3785.6560920873108;3483.2336885885065;3681.8711345102924;3698.278835627054;3715.2569486102752;3723.343112315021;3687.0597997510463;3702.315071711742;3711.740178187528;3717.1636381813873;3718.274936387419;3267.493538501536;3268.1339445047083;3268.869245230188;3271.8364081795817;3281.573395458599;4583;4625.514320996314;4652.325412815123;4722;4722.929156062662;4236.195122926634;4243.851465198703;4245.893852653709;4251.872443826659;4285.1931984550165;4935.111679897617;4943.332650092228;4948.406191257072;4956.281339205831;4983.700977941335;3349.581302337208;3471.756977011585;3495.2659941412335;3497.387957107496;3600.6317599312356;5167.276581278624;5189.558887494568;5193.792248310063;5196.740162991835;5211.296474975868;3480.5823301203513;3493.703035241982;3495.7378196635354;3499.3876071687355;3516.876909308162;3434.8110853903277;3532;3538.274653695986;3564.6791788739138;3577.6780089791523;4085.7946905662902;4105.692073094529;4106.486689163855;4132.710710250253;4132.710710250314;4958.330625365602;4959.454460009396;4968.950310496921;5000.874978125576;5018.146915024455;1154.1401655766508;1186.4364426897155;1213.1932265043824;1213.6055781870928;1226.693326668333;796.9003874515686;821.482466046387;824.723717554626;825.1995564302617;829.6432534010313;4169.2703776839535;4201.857052903041;4216.641585465209;4227.788610569459;4229.407882896397;4892.730899800474;4908.214685650279;4933.927750344864;4993.375828021497;5001.574866136347;4132.896677583084;4196.5803419658405;4265.189613973335;4274.337477690963;4288.292431748789;2666.9199924001923;2675.3980354420487;2679.4373181631686;2685.9194224173307;2691.9461610767676;4663.036419043786;4693.718376897329;4706.0587133041845;4722.433308003062;4738.32779595816;4900.508978218859;4955.554000140005;5033.672811267256;5074.873128171751;5121.513456221727;4667.556582124693;4668.649851261169;4694.746521669617;4700.177468942921;4706.647001474835;4957.950420495749;4968.527989840959;4994.275830004702;5005.023015908623;5019.196928491424;4740.786664600032;4833.88214601573;4862.933253367375;4877.9024419512125;4879.804447910285;4633.6524760642415;4650.860669048311;4652.906566956694;4666.64001918618;4670.602998745145;3445.9655403446645;3476.9478457823657;3492.4761285806317;3493.947590786191;3497.1257185703575;4729.327929719698;4921.827736029221;4926.630502712383;5009.874753131201;5028.9245661315845;4752.833650822205;4794.952050479451;4798.808047678193;4799.0401919615515;4811.446683631427;4759.595434388116;4795.664303498722;4849.80600775965;4864.73243971585;4865.1242776300605;4550.453945526558;4727.739974301447;4757.881052973703;4764.190087685032;4765.642576806684;4808.3027960946165;4869.683470574401;4881.8535443936735;4881.8535443936735;4889.266610008385;4725.952740472551;4745.9050818984115;4752.477227505041;4763.7141771493825;4767.213409787346 09:09:53 INFO - PROCESS | 25078 | |5;yui.html;605.8243109498246;649.3765984654734;665.6039656404438;718.7376607538248;726.5023458930633;11927.701807454818;12983.285919274436;13061.151025183368;13076.150050246728;13093.0834841561;12238.388080595956;12344.32106234159;12374.62876113718;12402.627921162357;12450.875491245084;600.1987346891883;618.1901708761515;722.072137303565;738.3834498194001;740.526063319476;740.8999785029006;742.9739959101432;749.2020997637526;750.9286617771303;750.9474336796427;798.7244400681756;802.2018091998469;802.4543310548854;802.5826570183501;802.9919700803005;629.6662768732579;648.345171376908;650.440621065883;653.389081209071;792.0178978067185;562.2887047884429;569.8233547600257;570.8316046766172;576.3919065386016;577.249575551781;12500.49998000079;12516.311602861839;12538.68653283666;12549.247045177228;12632;11917;12092.758144837142;12220.877791222063;12298.569550065704;12561.623151305384;10836;10896.40069796161;11076.169287303404;11210.439478026066;11594.130440217017;3990.201959608061;3999.5200575930785;4045.797710114512;4051.898702532431;4078.775667338295;42529.14941701149;45728.314075288894;45920.54079459196;46031.30953035707;46079;10287.794244115226;10304.742381440374;10350.948245258725;10367.32612380193;10418.062374386342;18074.277028918958;18082.728759068625;18198.181081851348;18303.084845757658;18343.991080490436;6581.670916454158;6606.636634985026;6614.272430032693;6725.899111513331;6766;3518.437050071976;3524.312759011968;3554.0937061049267;3560.127768696686;3656.232191239816;2699.3656490724666;2770.0720258713154;2784.679761827416;2802.621646077794;2839.474697181028;490.1398046428495;500.14225603090875;500.71459268217495;502.5878779400856;510.652756125838;528.8228443471403;585.2450339062647;597.9431953964366;618.4588485075559;619.8109576579096;7303;7672.309492145734;7744.49660772048;7806.92193078062;7807.258310460497;496.36713190682167;611.8195132435942;622.1103821535157;642.8971364581645;648.3257412291165;3588.2105936693883;3719.8326075326677;4018.3972404139613;4041.7170798043853;4380.664652567953;65087;68422;69002.3099769006;72432.27567724255;72628;62560;63178.36821631725;63411.36588634147;65611;66675.99818035534;55023.449765501835;57985;58404;58434.707826460595;60255;8319;8568.614412351335;8636.309095272489;8695.826083478421;8764.21122099014;38256.617433825304;38892.2221555573;38912.2217555653;39336.60663393444;41166.1766764669;46735.29897051479;52433.47566524438;53957.730211348695;54550.454495454534;56556.58608534819;10751.086157676373;10874.293170943864;10916.617918372818;10990.505427255634;11505.309681419141;11516.30902145874;11610.477528511068;11776.882231177578;11789.587364442203;11948.820767688665;10872.61945831892;10951.528717353087;11589.130815189063;11612.419379031184;11810.291382517076;11057.668269951915;11181.273217240854;11368.204225704452;11704.882951170379;11714.531418743154;10689.893101069201;11403.771924561628;11735.471903764523;11854.703632409259;11869.881301187223;9097.863532047157;9116.954415227881;9642.566084526074;9656.227501799698;10067.093961543203;8700.825983480421;8999.775005624912;9138.954305228697;9625.005622666515;9844.432791470137 09:09:53 INFO - PROCESS | 25078 | __end_tp_report 09:09:53 INFO - PROCESS | 25078 | __start_cc_report 09:09:53 INFO - PROCESS | 25078 | _x_x_mozilla_cycle_collect,1474 09:09:53 INFO - PROCESS | 25078 | __end_cc_report 09:09:53 INFO - PROCESS | 25078 | __startTimestamp1478884193021__endTimestamp 09:09:53 INFO - PROCESS | 25078 | 09:09:53 INFO - PROCESS | 25078 | ------- Summary: start ------- 09:09:53 INFO - PROCESS | 25078 | Number of tests: 6 09:09:53 INFO - PROCESS | 25078 | 09:09:53 INFO - PROCESS | 25078 | [#0] dojo.html Cycles:165 Average:4680.23 Median:4819.40 stddev:491.89 (10.2%) stddev-sans-first:465.46 09:09:53 INFO - PROCESS | 25078 | Values: 2596.8 2643.1 2643.8 2676.8 2689.2 4632.8 4720.6 4739.9 4790.0 4805.0 4697.6 4731.4 4764.6 4800.2 4841.8 4308.6 4325.5 4357.5 4360.9 4385.2 4410.8 4430.2 4432.0 4455.2 4489.6 4385.6 4436.0 4444.0 4447.6 4469.6 4253.4 4256.5 4280.3 4341.8 4345.6 4273.0 4290.2 4327.5 4333.5 4342.6 4644.3 4645.0 4693.2 4709.4 4724.9 4920.6 4976.8 5008.4 5015.5 5020.2 4997.3 5046.0 5049.5 5067.5 5133.5 4763.3 4768.1 4768.4 4811.8 4815.2 5234.7 5236.9 5237.4 5238.9 5271.6 4864.2 4873.0 4918.0 5000.4 5005.4 5062.4 5075.6 5122.3 5133.9 5179.3 5047.4 5084.3 5084.9 5114.8 5148.6 5054.2 5086.8 5093.3 5100.1 5142.4 4199.5 4256.0 4265.6 4396.3 4404.3 3700.7 3722.2 3729.6 3730.7 3776.4 4265.9 4272.9 4276.9 4293.7 4319.2 4967.1 4988.3 4989.6 4999.6 5042.8 4269.4 4305.3 4337.5 4342.7 4343.3 4624.8 4629.8 4630.7 4649.6 4673.3 4798.1 4801.2 4819.4 4831.1 4844.0 4890.4 4899.3 4935.9 5122.6 5131.4 4678.6 4714.9 4719.0 4722.3 4795.8 4978.3 4978.7 4985.0 5005.4 5030.7 4878.1 5021.8 5050.5 5051.7 5093.0 4809.2 4878.4 4922.3 4963.1 5021.7 4949.8 4969.8 4975.9 5008.6 5025.6 4900.0 4926.5 4929.5 4934.6 4967.2 4826.4 4848.8 4891.0 4945.5 4947.0 4872.4 4875.3 4877.0 4916.9 4927.8 09:09:53 INFO - PROCESS | 25078 | 09:09:53 INFO - PROCESS | 25078 | [#1] ext.html Cycles:180 Average:45589.16 Median:36776.45 stddev:78083.86 (212.3%) stddev-sans-first:78229.72 09:09:53 INFO - PROCESS | 25078 | Values: 560.7 569.1 585.8 588.2 592.9 28138.7 37918.0 38844.4 38861.4 43241.6 39354.0 39786.6 39801.0 39815.4 39872.4 7458.8 7608.7 7611.0 7611.8 7613.4 7343.8 7424.6 7430.5 7430.5 7432.5 7440.6 7490.7 7494.6 7498.0 7498.1 7423.0 7457.9 7462.6 7465.7 7467.1 7366.6 7427.3 7429.7 7429.7 7430.8 36651.3 36988.0 36996.4 37006.3 37020.0 2897.2 3008.2 3178.6 3605.6 3633.1 27888.2 27907.9 27970.9 27997.4 28206.2 3470.3 3531.9 3579.9 3634.8 3650.4 232469.0 233853.0 233934.0 236039.0 236104.8 51335.2 51857.0 51939.0 53630.7 55146.0 56620.2 57047.4 57156.4 57276.0 57329.7 15029.1 15299.3 15306.6 15310.8 15311.3 11515.3 11737.8 11744.6 11755.8 11757.4 17774.8 18063.5 18070.3 18082.0 18160.2 6869.8 6895.2 6924.2 7068.9 7296.6 734.7 832.2 870.8 897.8 996.6 25984.6 27029.6 27083.9 27542.2 27564.7 781.5 912.5 946.2 946.3 996.7 13439.5 14138.2 14154.9 14293.4 14407.0 344551.0 346569.0 347884.0 348245.0 348815.0 47887.3 48544.0 48606.8 48608.8 48664.5 1050.3 1076.7 1081.1 1156.8 1171.5 26374.0 28058.2 28912.6 31051.5 31262.5 45452.8 45881.3 45917.0 45961.5 46157.5 298210.0 300878.0 300894.0 302204.0 302738.0 32151.9 32257.7 36948.4 37011.8 37014.0 39847.6 40125.2 40148.2 40575.6 41603.2 34038.7 34121.7 34360.8 34421.0 34442.3 33154.8 33796.8 34220.5 34318.7 34476.7 30281.2 31037.8 34389.7 36901.6 37088.1 32161.4 36007.6 36335.0 36567.0 37848.8 27879.0 28774.7 28882.9 29296.1 29333.0 09:09:53 INFO - PROCESS | 25078 | 09:09:53 INFO - PROCESS | 25078 | [#2] jquery.html Cycles:180 Average:22159.62 Median:4222.24 stddev:57276.01 (1356.5%) stddev-sans-first:57413.26 09:09:53 INFO - PROCESS | 25078 | Values: 343.7 349.0 351.0 354.7 374.6 15540.2 16749.6 16935.7 17102.3 17193.2 15687.1 16407.3 16491.2 16507.6 16575.9 4226.9 4473.1 4500.8 4546.7 4554.0 3445.7 4520.6 4546.8 4549.8 4554.2 3531.8 3567.5 3723.1 5757.7 5874.8 5810.5 5837.0 5845.9 5848.9 5850.0 4459.7 4732.5 4755.9 4789.0 4799.1 11938.9 12004.3 12477.8 19061.6 19426.0 1657.2 1695.8 1717.9 1718.8 1795.7 8377.9 8657.6 8851.0 9363.3 11987.2 1591.6 1647.6 1657.7 1684.7 1707.6 64412.7 64616.7 65019.3 66448.0 66560.0 9327.3 9454.9 9659.5 9684.3 9781.1 13014.1 13028.7 13043.0 13048.5 13063.4 7016.6 7096.5 7227.9 7412.1 7425.3 7078.4 7091.9 7297.3 7344.6 7350.9 3995.6 4097.9 4114.1 4221.0 4223.5 1722.9 1761.8 1769.2 1835.3 1839.2 795.6 848.4 882.9 884.3 921.1 15686.0 16302.8 16336.8 16417.0 17055.3 823.4 863.3 863.5 870.1 872.6 5584.7 5820.1 5870.4 5956.9 8884.4 219866.0 237133.0 395849.0 402173.0 407336.0 79461.6 79673.0 79717.0 79999.0 82570.6 397.3 415.0 415.4 416.0 417.8 9552.9 9750.9 9971.7 10007.3 10182.9 37219.6 37999.8 38261.0 38545.8 39162.0 49736.8 51737.0 52408.5 52558.7 53229.5 4498.0 7076.0 7367.6 7530.3 7596.1 9745.4 11549.8 11705.2 11717.4 11847.8 9984.7 10114.7 10232.8 10600.2 10657.8 10199.4 10216.9 10301.5 10357.5 10396.5 9957.0 10354.9 10358.6 10571.8 10961.3 6884.4 7447.9 7574.9 7682.6 7776.0 8029.7 9495.0 10561.9 10606.3 10901.3 09:09:53 INFO - PROCESS | 25078 | 09:09:53 INFO - PROCESS | 25078 | [#3] mootools.html Cycles:180 Average:4548.13 Median:5449.09 stddev:2483.48 (45.6%) stddev-sans-first:2477.51 09:09:53 INFO - PROCESS | 25078 | Values: 1176.0 1285.9 1338.4 1374.9 1620.6 5962.6 6768.4 7015.1 7023.0 7195.2 7058.1 7116.3 7126.6 7128.1 7131.3 2067.4 2097.9 2101.3 2102.6 2105.2 1935.6 2005.6 2005.7 2007.4 2017.3 2030.6 2040.2 2051.9 2068.3 2068.5 1991.3 2009.1 2009.2 2009.7 2010.2 2006.2 2032.5 2041.3 2041.6 2047.0 6859.8 6947.8 7014.5 7020.7 7022.9 4150.1 4327.2 4333.7 4335.9 4337.3 2547.8 2745.4 2788.4 2802.6 2806.9 826.2 841.0 878.1 880.8 894.5 9034.9 9092.4 9101.5 9111.7 9115.4 3504.2 3527.1 3606.7 3673.6 3707.3 7222.0 7225.5 7231.7 7232.4 7235.7 4042.7 4047.7 4054.1 4059.7 4065.3 3368.4 3467.2 3811.6 3816.9 3930.5 2837.2 2912.2 3001.7 3025.0 3043.6 851.5 858.9 866.3 871.5 879.8 792.5 796.8 805.1 817.0 817.6 4775.2 4831.7 4853.7 4917.6 5086.1 379.8 384.3 387.0 390.4 394.2 3245.5 3254.1 3274.7 3299.2 3428.9 8059.1 8325.1 8404.2 8430.2 8438.7 8381.9 8389.2 8389.7 8390.8 8395.9 6122.8 6279.6 6342.0 6529.6 6534.1 4892.4 4994.4 5015.4 5024.8 5075.2 7462.6 7636.4 7666.6 7667.5 7688.6 7753.0 7765.1 7779.3 7840.1 7842.3 5121.4 6133.0 6238.1 6271.2 6288.1 5992.4 6397.1 6586.0 6624.1 6806.9 6066.2 6084.9 6127.7 6238.8 6290.0 6032.8 6092.2 6110.9 6122.3 6126.2 5776.8 5787.4 5800.9 5830.9 5837.2 4133.0 4160.4 4245.7 4258.5 4333.4 4202.7 4229.4 4236.8 4297.1 4315.7 09:09:53 INFO - PROCESS | 25078 | 09:09:53 INFO - PROCESS | 25078 | [#4] prototype.html Cycles:180 Average:4052.94 Median:4668.10 stddev:1175.30 (25.2%) stddev-sans-first:1143.93 09:09:53 INFO - PROCESS | 25078 | Values: 277.6 278.4 282.7 283.0 289.6 4671.3 4812.3 4813.9 4860.2 4872.7 4646.4 4716.3 4743.9 4746.6 4752.2 3722.2 3737.4 3741.5 3742.0 3746.8 3589.0 3743.3 3755.1 3757.4 3785.7 3483.2 3681.9 3698.3 3715.3 3723.3 3687.1 3702.3 3711.7 3717.2 3718.3 3267.5 3268.1 3268.9 3271.8 3281.6 4583.0 4625.5 4652.3 4722.0 4722.9 4236.2 4243.9 4245.9 4251.9 4285.2 4935.1 4943.3 4948.4 4956.3 4983.7 3349.6 3471.8 3495.3 3497.4 3600.6 5167.3 5189.6 5193.8 5196.7 5211.3 3480.6 3493.7 3495.7 3499.4 3516.9 3434.8 3532.0 3538.3 3564.7 3577.7 4085.8 4105.7 4106.5 4132.7 4132.7 4958.3 4959.5 4969.0 5000.9 5018.1 1154.1 1186.4 1213.2 1213.6 1226.7 796.9 821.5 824.7 825.2 829.6 4169.3 4201.9 4216.6 4227.8 4229.4 4892.7 4908.2 4933.9 4993.4 5001.6 4132.9 4196.6 4265.2 4274.3 4288.3 2666.9 2675.4 2679.4 2685.9 2691.9 4663.0 4693.7 4706.1 4722.4 4738.3 4900.5 4955.6 5033.7 5074.9 5121.5 4667.6 4668.6 4694.7 4700.2 4706.6 4958.0 4968.5 4994.3 5005.0 5019.2 4740.8 4833.9 4862.9 4877.9 4879.8 4633.7 4650.9 4652.9 4666.6 4670.6 3446.0 3476.9 3492.5 3493.9 3497.1 4729.3 4921.8 4926.6 5009.9 5028.9 4752.8 4795.0 4798.8 4799.0 4811.4 4759.6 4795.7 4849.8 4864.7 4865.1 4550.5 4727.7 4757.9 4764.2 4765.6 4808.3 4869.7 4881.9 4881.9 4889.3 4726.0 4745.9 4752.5 4763.7 4767.2 09:09:53 INFO - PROCESS | 25078 | 09:09:53 INFO - PROCESS | 25078 | [#5] yui.html Cycles:180 Average:14937.66 Median:46407.15 stddev:19026.43 (41.0%) stddev-sans-first:19049.37 09:09:53 INFO - PROCESS | 25078 | Values: 605.8 649.4 665.6 718.7 726.5 11927.7 12983.3 13061.2 13076.2 13093.1 12238.4 12344.3 12374.6 12402.6 12450.9 600.2 618.2 722.1 738.4 740.5 740.9 743.0 749.2 750.9 750.9 798.7 802.2 802.5 802.6 803.0 629.7 648.3 650.4 653.4 792.0 562.3 569.8 570.8 576.4 577.2 12500.5 12516.3 12538.7 12549.2 12632.0 11917.0 12092.8 12220.9 12298.6 12561.6 10836.0 10896.4 11076.2 11210.4 11594.1 3990.2 3999.5 4045.8 4051.9 4078.8 42529.1 45728.3 45920.5 46031.3 46079.0 10287.8 10304.7 10350.9 10367.3 10418.1 18074.3 18082.7 18198.2 18303.1 18344.0 6581.7 6606.6 6614.3 6725.9 6766.0 3518.4 3524.3 3554.1 3560.1 3656.2 2699.4 2770.1 2784.7 2802.6 2839.5 490.1 500.1 500.7 502.6 510.7 528.8 585.2 597.9 618.5 619.8 7303.0 7672.3 7744.5 7806.9 7807.3 496.4 611.8 622.1 642.9 648.3 3588.2 3719.8 4018.4 4041.7 4380.7 65087.0 68422.0 69002.3 72432.3 72628.0 62560.0 63178.4 63411.4 65611.0 66676.0 55023.4 57985.0 58404.0 58434.7 60255.0 8319.0 8568.6 8636.3 8695.8 8764.2 38256.6 38892.2 38912.2 39336.6 41166.2 46735.3 52433.5 53957.7 54550.5 56556.6 10751.1 10874.3 10916.6 10990.5 11505.3 11516.3 11610.5 11776.9 11789.6 11948.8 10872.6 10951.5 11589.1 11612.4 11810.3 11057.7 11181.3 11368.2 11704.9 11714.5 10689.9 11403.8 11735.5 11854.7 11869.9 9097.9 9117.0 9642.6 9656.2 10067.1 8700.8 8999.8 9139.0 9625.0 9844.4 09:09:53 INFO - PROCESS | 25078 | -------- Summary: end -------- 09:09:53 INFO - PROCESS | 25078 | 09:09:53 INFO - TEST-INFO | 25078: exit 0 09:09:54 INFO - TEST-OK | dromaeo_css | took 1121958ms 09:09:54 INFO - TEST-START | kraken 09:09:54 INFO - operating with platform_type : linux_ 09:09:54 INFO - Initialising browser for kraken test... 09:09:54 INFO - TEST-INFO | started process 25380 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpw_WwOg/profile http://localhost:37218/getInfo.html) 09:09:58 INFO - PROCESS | 25380 | __metrics Screen width/height:1600/1200 09:09:58 INFO - PROCESS | 25380 | colorDepth:24 09:09:58 INFO - PROCESS | 25380 | Browser inner width/height: 1024/697 09:09:58 INFO - PROCESS | 25380 | __metrics 09:09:58 INFO - PROCESS | 25380 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:09:58 INFO - PROCESS | 25380 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:09:59 INFO - TEST-INFO | 25380: exit 0 09:09:59 INFO - Browser initialized. 09:09:59 INFO - Running cycle 1/1 for kraken test... 09:09:59 INFO - TEST-INFO | started process 25463 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpw_WwOg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:10:12 INFO - PROCESS | 25463 | RSS: Main: 174714880 09:10:12 INFO - PROCESS | 25463 | 09:10:14 INFO - PROCESS | 25463 | Cycle 1(1): loaded http://localhost:37218/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37218/tests/kraken/driver.html?testName=audio-beat-detection) 09:10:15 INFO - PROCESS | 25463 | RSS: Main: 230875136 09:10:15 INFO - PROCESS | 25463 | 09:10:18 INFO - PROCESS | 25463 | Cycle 1(1): loaded http://localhost:37218/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37218/tests/kraken/driver.html?testName=audio-dft) 09:10:19 INFO - PROCESS | 25463 | RSS: Main: 217866240 09:10:19 INFO - PROCESS | 25463 | 09:10:22 INFO - PROCESS | 25463 | Cycle 1(1): loaded http://localhost:37218/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37218/tests/kraken/driver.html?testName=audio-fft) 09:10:23 INFO - PROCESS | 25463 | RSS: Main: 300400640 09:10:23 INFO - PROCESS | 25463 | 09:10:25 INFO - PROCESS | 25463 | Cycle 1(1): loaded http://localhost:37218/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37218/tests/kraken/driver.html?testName=audio-oscillator) 09:10:25 INFO - PROCESS | 25463 | RSS: Main: 208748544 09:10:25 INFO - PROCESS | 25463 | 09:10:28 INFO - PROCESS | 25463 | Cycle 1(1): loaded http://localhost:37218/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37218/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:10:28 INFO - PROCESS | 25463 | RSS: Main: 214097920 09:10:28 INFO - PROCESS | 25463 | 09:10:32 INFO - PROCESS | 25463 | Cycle 1(1): loaded http://localhost:37218/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37218/tests/kraken/driver.html?testName=imaging-darkroom) 09:10:32 INFO - PROCESS | 25463 | RSS: Main: 249434112 09:10:32 INFO - PROCESS | 25463 | 09:10:36 INFO - PROCESS | 25463 | Cycle 1(1): loaded http://localhost:37218/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37218/tests/kraken/driver.html?testName=imaging-desaturate) 09:10:36 INFO - PROCESS | 25463 | RSS: Main: 248512512 09:10:36 INFO - PROCESS | 25463 | 09:10:39 INFO - PROCESS | 25463 | Cycle 1(1): loaded http://localhost:37218/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37218/tests/kraken/driver.html?testName=json-parse-financial) 09:10:40 INFO - PROCESS | 25463 | RSS: Main: 247808000 09:10:40 INFO - PROCESS | 25463 | 09:10:41 INFO - PROCESS | 25463 | Cycle 1(1): loaded http://localhost:37218/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37218/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:10:42 INFO - PROCESS | 25463 | RSS: Main: 210415616 09:10:42 INFO - PROCESS | 25463 | 09:10:44 INFO - PROCESS | 25463 | Cycle 1(1): loaded http://localhost:37218/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37218/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:10:44 INFO - PROCESS | 25463 | RSS: Main: 217378816 09:10:44 INFO - PROCESS | 25463 | 09:10:47 INFO - PROCESS | 25463 | Cycle 1(1): loaded http://localhost:37218/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37218/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:10:47 INFO - PROCESS | 25463 | RSS: Main: 226762752 09:10:47 INFO - PROCESS | 25463 | 09:10:50 INFO - PROCESS | 25463 | Cycle 1(1): loaded http://localhost:37218/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37218/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:10:51 INFO - PROCESS | 25463 | RSS: Main: 235622400 09:10:51 INFO - PROCESS | 25463 | 09:10:54 INFO - PROCESS | 25463 | Cycle 1(1): loaded http://localhost:37218/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37218/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:10:55 INFO - PROCESS | 25463 | RSS: Main: 232067072 09:10:55 INFO - PROCESS | 25463 | 09:10:56 INFO - PROCESS | 25463 | Cycle 1(1): loaded http://localhost:37218/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37218/tests/kraken/driver.html?testName=ai-astar) 09:10:57 INFO - PROCESS | 25463 | RSS: Main: 283127808 09:10:57 INFO - PROCESS | 25463 | 09:10:57 INFO - PROCESS | 25463 | __start_tp_report 09:10:57 INFO - PROCESS | 25463 | _x_x_mozilla_page_load 09:10:57 INFO - PROCESS | 25463 | _x_x_mozilla_page_load_details 09:10:57 INFO - PROCESS | 25463 | |i|pagename|runs| 09:10:57 INFO - PROCESS | 25463 | |0;ai-astar;107;115;116;114;115;115;116;116;114;113 09:10:57 INFO - PROCESS | 25463 | |1;audio-beat-detection;158;130;135;186;129;128;131;131;166;127 09:10:57 INFO - PROCESS | 25463 | |2;audio-dft;161;160;161;161;161;162;162;160;162;163 09:10:57 INFO - PROCESS | 25463 | |3;audio-fft;76;76;75;105;89;78;77;77;102;77 09:10:57 INFO - PROCESS | 25463 | |4;audio-oscillator;83;84;114;84;84;83;108;84;84;119 09:10:57 INFO - PROCESS | 25463 | |5;imaging-gaussian-blur;118;117;118;117;118;117;119;118;118;117 09:10:57 INFO - PROCESS | 25463 | |6;imaging-darkroom;146;147;147;148;148;146;147;147;147;147 09:10:57 INFO - PROCESS | 25463 | |7;imaging-desaturate;85;84;85;84;84;84;84;85;85;85 09:10:57 INFO - PROCESS | 25463 | |8;json-parse-financial;64;64;63;64;66;66;64;66;73;64 09:10:57 INFO - PROCESS | 25463 | |9;json-stringify-tinderbox;66;66;67;66;67;66;67;66;67;67 09:10:57 INFO - PROCESS | 25463 | |10;stanford-crypto-aes;85;84;84;85;95;85;84;92;86;84 09:10:57 INFO - PROCESS | 25463 | |11;stanford-crypto-ccm;157;144;147;150;151;142;145;149;197;142 09:10:57 INFO - PROCESS | 25463 | |12;stanford-crypto-pbkdf2;185;183;186;181;186;182;178;180;185;180 09:10:57 INFO - PROCESS | 25463 | |13;stanford-crypto-sha256-iterative;70;71;71;69;69;73;70;76;76;71 09:10:57 INFO - PROCESS | 25463 | __end_tp_report 09:10:57 INFO - PROCESS | 25463 | __start_cc_report 09:10:57 INFO - PROCESS | 25463 | _x_x_mozilla_cycle_collect,1959 09:10:57 INFO - PROCESS | 25463 | __end_cc_report 09:10:57 INFO - PROCESS | 25463 | __startTimestamp1478884257121__endTimestamp 09:10:57 INFO - PROCESS | 25463 | 09:10:57 INFO - PROCESS | 25463 | ------- Summary: start ------- 09:10:57 INFO - PROCESS | 25463 | Number of tests: 14 09:10:57 INFO - PROCESS | 25463 | 09:10:57 INFO - PROCESS | 25463 | [#0] ai-astar Cycles:10 Average:114.10 Median:115.00 stddev:2.69 (2.3%) stddev-sans-first:1.05 09:10:57 INFO - PROCESS | 25463 | Values: 107.0 115.0 116.0 114.0 115.0 115.0 116.0 116.0 114.0 113.0 09:10:57 INFO - PROCESS | 25463 | 09:10:57 INFO - PROCESS | 25463 | [#1] audio-beat-detection Cycles:10 Average:142.10 Median:133.00 stddev:20.53 (15.4%) stddev-sans-first:20.95 09:10:57 INFO - PROCESS | 25463 | Values: 158.0 130.0 135.0 186.0 129.0 128.0 131.0 131.0 166.0 127.0 09:10:57 INFO - PROCESS | 25463 | 09:10:57 INFO - PROCESS | 25463 | [#2] audio-dft Cycles:10 Average:161.30 Median:161.50 stddev:0.95 (0.6%) stddev-sans-first:1.00 09:10:57 INFO - PROCESS | 25463 | Values: 161.0 160.0 161.0 161.0 161.0 162.0 162.0 160.0 162.0 163.0 09:10:57 INFO - PROCESS | 25463 | 09:10:57 INFO - PROCESS | 25463 | [#3] audio-fft Cycles:10 Average:83.20 Median:77.00 stddev:11.43 (14.8%) stddev-sans-first:11.82 09:10:57 INFO - PROCESS | 25463 | Values: 76.0 76.0 75.0 105.0 89.0 78.0 77.0 77.0 102.0 77.0 09:10:57 INFO - PROCESS | 25463 | 09:10:57 INFO - PROCESS | 25463 | [#4] audio-oscillator Cycles:10 Average:92.70 Median:84.00 stddev:14.70 (17.5%) stddev-sans-first:15.17 09:10:57 INFO - PROCESS | 25463 | Values: 83.0 84.0 114.0 84.0 84.0 83.0 108.0 84.0 84.0 119.0 09:10:57 INFO - PROCESS | 25463 | 09:10:57 INFO - PROCESS | 25463 | [#5] imaging-gaussian-blur Cycles:10 Average:117.70 Median:118.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 09:10:57 INFO - PROCESS | 25463 | Values: 118.0 117.0 118.0 117.0 118.0 117.0 119.0 118.0 118.0 117.0 09:10:57 INFO - PROCESS | 25463 | 09:10:57 INFO - PROCESS | 25463 | [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.00 stddev:0.67 (0.5%) stddev-sans-first:0.60 09:10:57 INFO - PROCESS | 25463 | Values: 146.0 147.0 147.0 148.0 148.0 146.0 147.0 147.0 147.0 147.0 09:10:57 INFO - PROCESS | 25463 | 09:10:57 INFO - PROCESS | 25463 | [#7] imaging-desaturate Cycles:10 Average:84.50 Median:85.00 stddev:0.53 (0.6%) stddev-sans-first:0.53 09:10:57 INFO - PROCESS | 25463 | Values: 85.0 84.0 85.0 84.0 84.0 84.0 84.0 85.0 85.0 85.0 09:10:57 INFO - PROCESS | 25463 | 09:10:57 INFO - PROCESS | 25463 | [#8] json-parse-financial Cycles:10 Average:65.40 Median:65.00 stddev:2.88 (4.4%) stddev-sans-first:3.00 09:10:57 INFO - PROCESS | 25463 | Values: 64.0 64.0 63.0 64.0 66.0 66.0 64.0 66.0 73.0 64.0 09:10:57 INFO - PROCESS | 25463 | 09:10:57 INFO - PROCESS | 25463 | [#9] json-stringify-tinderbox Cycles:10 Average:66.50 Median:67.00 stddev:0.53 (0.8%) stddev-sans-first:0.53 09:10:57 INFO - PROCESS | 25463 | Values: 66.0 66.0 67.0 66.0 67.0 66.0 67.0 66.0 67.0 67.0 09:10:57 INFO - PROCESS | 25463 | 09:10:57 INFO - PROCESS | 25463 | [#10] stanford-crypto-aes Cycles:10 Average:86.40 Median:85.00 stddev:3.86 (4.5%) stddev-sans-first:4.07 09:10:57 INFO - PROCESS | 25463 | Values: 85.0 84.0 84.0 85.0 95.0 85.0 84.0 92.0 86.0 84.0 09:10:57 INFO - PROCESS | 25463 | 09:10:57 INFO - PROCESS | 25463 | [#11] stanford-crypto-ccm Cycles:10 Average:152.40 Median:149.50 stddev:16.33 (10.9%) stddev-sans-first:17.24 09:10:57 INFO - PROCESS | 25463 | Values: 157.0 144.0 147.0 150.0 151.0 142.0 145.0 149.0 197.0 142.0 09:10:57 INFO - PROCESS | 25463 | 09:10:57 INFO - PROCESS | 25463 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:182.60 Median:184.00 stddev:2.84 (1.5%) stddev-sans-first:2.87 09:10:57 INFO - PROCESS | 25463 | Values: 185.0 183.0 186.0 181.0 186.0 182.0 178.0 180.0 185.0 180.0 09:10:57 INFO - PROCESS | 25463 | 09:10:57 INFO - PROCESS | 25463 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.60 Median:71.00 stddev:2.59 (3.6%) stddev-sans-first:2.68 09:10:57 INFO - PROCESS | 25463 | Values: 70.0 71.0 71.0 69.0 69.0 73.0 70.0 76.0 76.0 71.0 09:10:57 INFO - PROCESS | 25463 | -------- Summary: end -------- 09:10:57 INFO - PROCESS | 25463 | 09:10:58 INFO - TEST-INFO | 25463: exit 0 09:10:58 INFO - TEST-OK | kraken | took 64527ms 09:10:58 INFO - SUITE-END | took 1186s 09:10:58 INFO - Completed test suite (00:19:46) 09:10:58 INFO - javascript benchmark 09:10:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2596.8182227244097, 2643.140979181764, 2643.814932954694, 2676.759091681748, 2689.166358428886, 4632.837850675227, 4720.622350211984, 4739.90520189596, 4790.0419916016845, 4804.966932109595, 4697.553732395426, 4731.432228132629, 4764.618830493561, 4800.159972004903, 4841.8305359312435, 4308.633766129867, 4325.4593175853015, 4357.4771027476745, 4360.890977725567, 4385.232584297735, 4410.845620403286, 4430.158269928719, 4431.9778401108115, 4455.198064348416, 4489.6408287336935, 4385.583369579885, 4436.0240747035605, 4444.044530425957, 4447.599716025557, 4469.620082293009, 4253.3619957006695, 4256.4679415073115, 4280.336547835091, 4341.826326946918, 4345.630621397185, 4272.978635106836, 4290.163418133465, 4327.502337231227, 4333.544977777351, 4342.5874541918465, 4644.256918892995, 4644.976775116136, 4693.225617773063, 4709.387779588666, 4724.929126063112, 4920.6309526785635, 4976.776045077981, 5008.398992120932, 5015.548600625962, 5020.246962955549, 4997.275395067732, 5046.041252162077, 5049.469805670426, 5067.5185857343495, 5133.486651334837, 4763.309320148559, 4768.117898188777, 4768.380110585671, 4811.831585894512, 4815.2054910939305, 5234.659747116425, 5236.921446178234, 5237.423883372826, 5238.92141617876, 5271.6309858310315, 4864.197407427735, 4872.9512704873205, 4917.975410122926, 5000.374953130859, 5005.374328208974, 5062.443131255559, 5075.568576671024, 5122.334096567497, 5133.948660513422, 5179.326687530597, 5047.369078865142, 5084.313617661568, 5084.872878178076, 5114.846554603368, 5148.613853960968, 5054.216596427486, 5086.821961231339, 5093.286939828427, 5100.056489549445, 5142.357205349332, 4199.454070970815, 4255.957440425556, 4265.55211702773, 4396.27461468854, 4404.273294906368, 3700.703943684499, 3722.236941427001, 3729.645683660048, 3730.6642402183393, 3776.3957766757735, 4265.893352666146, 4272.87181384559, 4276.91446171081, 4293.699441039097, 4319.222539942778, 4967.105920934267, 4988.276699878497, 4989.625778066659, 4999.550040496373, 5042.823501177441, 4269.380939763779, 4305.268104422255, 4337.522872484024, 4342.6742994275555, 4343.326784348431, 4624.815007399667, 4629.791659375336, 4630.745309008037, 4649.628029757679, 4673.299005149255, 4798.088363210979, 4801.18379875415, 4819.397575303087, 4831.0820944020525, 4844.006978569314, 4890.413150421972, 4899.3385892904, 4935.876603084952, 5122.615803814654, 5131.435542090292, 4678.625709943264, 4714.9292760609305, 4719.009008108198, 4722.338872557776, 4795.784189711401, 4978.27814966835, 4978.651494395358, 4984.950150498448, 5005.399352077774, 5030.723310217827, 4878.0975519529, 5021.799128034838, 5050.469700681522, 5051.6716413433005, 5093.006863661551, 4809.2305231162845, 4878.414590249193, 4922.335484709662, 4963.131451995814, 5021.6735912165595, 4949.777260023236, 4969.751512424436, 4975.875603109951, 5008.649394542493, 5025.623078269071, 4900.044491324157, 4926.5073492650445, 4929.507049295185, 4934.5805606523845, 4967.180415231446, 4826.444958829639, 4848.80604775805, 4891.046245981999, 4945.455999840086, 4946.975265123651, 4872.43966943806, 4875.341828853059, 4877.0, 4916.877078072934, 4927.827526036572], "value": 4648.7342066138735, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [560.6972234993102, 569.1491220625164, 585.847679603303, 588.1765528260438, 592.8903152916708, 28138.718612813867, 37918.0, 38844.367566702844, 38861.41707874384, 43241.56758432415, 39354.0, 39786.60213397865, 39801.0, 39815.40276895849, 39872.40191397131, 7458.813529661761, 7608.7336943207, 7611.048618922635, 7611.771646850603, 7613.428992825533, 7343.77968660941, 7424.628768561577, 7430.479866409353, 7430.479866409353, 7432.479726419153, 7440.553566785983, 7490.700371985114, 7494.587797671126, 7497.987771650812, 7498.100227972651, 7423.035005449284, 7457.8508429831645, 7462.626868656545, 7465.664045117983, 7467.141278752904, 7366.558006519626, 7427.257274272583, 7429.7399591014055, 7429.739959101459, 7430.814229644248, 36651.266974660626, 36988.0, 36996.44505332422, 37006.25987480262, 37020.0, 2897.1887871396043, 3008.2329006103523, 3178.5867837181017, 3605.6214097519646, 3633.073566240618, 27888.16335509938, 27907.860460697768, 27970.860145699142, 27997.440051199064, 28206.153815385573, 3470.340635279289, 3531.9293614127832, 3579.8568057277676, 3634.800085995269, 3650.4159334506353, 232469.0, 233853.0, 233933.9999999983, 236039.0, 236104.81947590323, 51335.229971550456, 51857.0, 51939.0, 53630.731846341296, 55146.0, 56620.15069773957, 57047.42952570421, 57156.42843571594, 57276.0, 57329.71335143381, 15029.098254104789, 15299.311530981133, 15306.617334566503, 15310.770338444932, 15311.310991005432, 11515.25150865191, 11737.823932641017, 11744.58893938708, 11755.823662645067, 11757.412129393497, 17774.822251777317, 18063.54841128956, 18070.277188912558, 18082.0, 18160.1827917744, 6869.7595584154315, 6895.241523432418, 6924.203716572558, 7068.893966590403, 7296.562206267535, 734.6951015328685, 832.1886160993105, 870.7997160653085, 897.7755561109723, 996.6312464388222, 25984.610230846552, 27029.594556081676, 27083.86458067697, 27542.173734787586, 27564.724352756217, 781.4686013510867, 912.493566070837, 946.2477330522252, 946.2997381937316, 996.6860438961849, 13439.462421503225, 14138.151710897173, 14154.858451415354, 14293.428262869369, 14407.0, 344551.0, 346569.0, 347884.0, 348245.0, 348815.0, 47887.28169077467, 48544.0, 48606.75696621494, 48608.7569562157, 48664.51335486671, 1050.3120456101267, 1076.7146706122883, 1081.1296905990753, 1156.7628636129573, 1171.4611278811672, 26374.0, 28058.158255252376, 28912.566311504925, 31051.53422698616, 31262.53106203363, 45452.77273613611, 45881.31178032399, 45917.0, 45961.540384595726, 46157.538424615326, 298210.0, 300878.0, 300894.0, 302204.0, 302738.0, 32151.874684385934, 32257.677423226407, 36948.44577331289, 37011.81494092512, 37013.96734620413, 39847.60152398439, 40125.197496050496, 40148.1970360597, 40575.57985470494, 41603.1679366417, 34038.65961340454, 34121.658783412844, 34360.82819585886, 34421.0, 34442.31115377628, 33154.834225828716, 33796.831015845746, 34220.48669270013, 34318.656813431546, 34476.65523344835, 30281.24296892595, 31037.8448107758, 34389.65610343865, 36901.63098368982, 37088.07279817918, 32161.35677286488, 36007.63992360148, 36335.0, 36567.0, 37848.81075594604, 27879.0, 28774.712252878042, 28882.855585722777, 29296.121116366543, 29333.0], "value": 17451.113581769685, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [343.7129996452962, 348.99999999999994, 350.97192224622034, 354.7304048922818, 374.591695052393, 15540.222988850555, 16749.58126046848, 16935.745963810536, 17102.31590736372, 17193.226304816282, 15687.05877647342, 16407.261673224704, 16491.17544122795, 16507.58731031725, 16575.917120414382, 4226.852060177886, 4473.083017981322, 4500.842470513533, 4546.681732278742, 4553.977230113845, 3445.7415693822936, 4520.570545798144, 4546.795394207252, 4549.795259213343, 4554.180247555439, 3531.8234088295612, 3567.4648802679676, 3723.143676954302, 5757.712114394263, 5874.765009399619, 5810.477057064863, 5837.0, 5845.941540584582, 5848.912266316009, 5850.0, 4459.710118842298, 4732.455767586737, 4755.881102972418, 4788.95211047892, 4799.088173247072, 11938.880611193863, 12004.339761313124, 12477.75044499114, 19061.61876762471, 19426.0, 1657.1796960504507, 1695.7965044194775, 1717.939872104483, 1718.8367105124994, 1795.685754992884, 8377.916220837835, 8657.610407531676, 8851.0, 9363.297752668577, 11987.160898737093, 1591.554364777864, 1647.571631375839, 1657.693326734558, 1684.676422504891, 1707.5560354307845, 64412.677936610955, 64616.67691661511, 65019.3498065018, 66448.0, 66560.0, 9327.253819694408, 9454.90545094554, 9659.517024148765, 9684.32209745311, 9781.119699226962, 13014.089013769135, 13028.739425211443, 13043.0, 13048.54330098442, 13063.412146453242, 7016.5790052597, 7096.467764917652, 7227.855442891113, 7412.073490813648, 7425.331720145213, 7078.362947334765, 7091.92908070923, 7297.306755858185, 7344.632768361561, 7350.852982940311, 3995.6403923647013, 4097.918041639151, 4114.136031433372, 4220.957790422118, 4223.514295856015, 1722.879398442097, 1761.779777527809, 1769.2480695704273, 1835.2567210279858, 1839.1907560673528, 795.586295126531, 848.4103548034057, 882.9337799665051, 884.2793123604242, 921.1065266691298, 15686.0, 16302.83697163037, 16336.75494867578, 16417.01497910105, 17055.31778728862, 823.4112609484127, 863.3352318714681, 863.53369180643, 870.0907551608584, 872.6204101215991, 5584.748686309126, 5820.097884827774, 5870.442307980735, 5956.880862382728, 8884.37809353352, 219866.0, 237133.0, 395849.0, 402173.0, 407336.0, 79461.60269198618, 79673.0, 79717.0, 79999.0, 82570.58714706388, 397.32653152906124, 414.9875503734953, 415.42048841865426, 415.95216550096524, 417.7994562609903, 9552.90447095548, 9750.902490974999, 9971.650992215238, 10007.349522281029, 10182.898171018194, 37219.62780372162, 37999.81000095092, 38261.0, 38545.807270963465, 39162.0, 49736.751316243186, 51737.0, 52408.475915241885, 52558.73720631372, 53229.467705324, 4498.0, 7075.973983772427, 7367.557946523226, 7530.322270995418, 7596.126445458843, 9745.366551174435, 11549.82675259855, 11705.239159454608, 11717.414129293331, 11847.822282665938, 9984.650537231162, 10114.696559103239, 10232.795344092927, 10600.151987841109, 10657.840132398176, 10199.38803671782, 10216.948915255674, 10301.484925753832, 10357.533910973874, 10396.48017599132, 9957.0, 10354.948225258826, 10358.637447689294, 10571.788564228826, 10961.342319460859, 6884.449244060363, 7447.851042979219, 7574.886376704464, 7682.625286693004, 7775.961120194363, 8029.7189598363775, 9495.0, 10561.89438105609, 10606.310589811637, 10901.291416057931], "value": 7498.707163354077, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1175.9529618815247, 1285.8971282297414, 1338.4177882621061, 1374.8831349335312, 1620.5948512871776, 5962.64224146551, 6768.3908448239645, 7015.123109611299, 7023.0, 7195.208527062019, 7058.082449281599, 7116.288371162881, 7126.572405655665, 7128.073350464445, 7131.251218622035, 2067.3694523170466, 2097.905594248255, 2101.2960658179527, 2102.579484103178, 2105.1895020417173, 1935.5644979879555, 2005.6289586426485, 2005.7492813398326, 2007.3676791810533, 2017.273781438681, 2030.6141833051672, 2040.2247146084542, 2051.8871462069656, 2068.265765653194, 2068.513899233679, 1991.332903477337, 2009.1461129020108, 2009.2264478175862, 2009.6784514477613, 2010.1657812008073, 2006.197520991615, 2032.5020370009295, 2041.326362300452, 2041.622299874528, 2047.0276618606042, 6859.794206173823, 6947.826304342381, 7014.473914456436, 7020.684069216846, 7022.929770702279, 4150.128473020669, 4327.242732521796, 4333.739975601474, 4335.891602709926, 4337.306031035051, 2547.808914331414, 2745.409736906555, 2788.428372183718, 2802.5515917453313, 2806.943861122766, 826.2357319479518, 841.032812265893, 878.1218781218781, 880.7669263031743, 894.4767311123001, 9034.909650903539, 9092.363534552584, 9101.499417532099, 9111.726648200565, 9115.407498512643, 3504.212851445781, 3527.1358517162944, 3606.711463082947, 3673.577538583044, 3707.277080969185, 7221.96389018062, 7225.530340527849, 7231.674574644048, 7232.421406287484, 7235.710571577078, 4042.6765858731233, 4047.716659833842, 4054.0675644601315, 4059.715819892638, 4065.2682517147196, 3368.4105281575626, 3467.1505481156773, 3811.599782022903, 3816.904577385588, 3930.5283365995692, 2837.2197645647198, 2912.199145235035, 3001.669816320203, 3025.0471101602925, 3043.6195475565555, 851.5018714052349, 858.9012263589642, 866.3156106675782, 871.4575201892615, 879.8372301124184, 792.484884824857, 796.7888509544975, 805.070143983688, 816.995915020433, 817.5952903312898, 4775.164346239394, 4831.685940413932, 4853.684510506806, 4917.606591472673, 5086.0845047891, 379.7911148868167, 384.2602989245691, 386.95936926622863, 390.4455672944426, 394.1919065914863, 3245.4807230842953, 3254.1213872254834, 3274.721648659843, 3299.15871452778, 3428.9142771430415, 8059.113497515269, 8325.084240733515, 8404.159584041668, 8430.241278284984, 8438.74683759476, 8381.916180838236, 8389.203025712548, 8389.706360277483, 8390.790230244293, 8395.916040839636, 6122.846928826726, 6279.560430769893, 6342.0, 6529.575577587537, 6534.052562378429, 4892.3884514435695, 4994.425641051325, 5015.3730783652045, 5024.773885175103, 5075.2387141929, 7462.626868656437, 7636.350910172698, 7666.6166691664075, 7667.539947603162, 7688.615569221628, 7752.961235193788, 7765.06665870151, 7779.260970207822, 7840.059192896889, 7842.254985776342, 5121.385433747974, 6133.0, 6238.095476156022, 6271.184745982993, 6288.088227207121, 5992.43071908168, 6397.136386587751, 6586.045023471665, 6624.072629831731, 6806.8638627228165, 6066.211392519121, 6084.939150608438, 6127.693416507266, 6238.812835614939, 6289.96855015722, 6032.75868965254, 6092.238470191226, 6110.908336374869, 6122.326544080237, 6126.23422072241, 5776.797812076726, 5787.421257874179, 5800.883982320245, 5830.912536311874, 5837.153612726046, 4132.958670413257, 4160.439835061852, 4245.702800803914, 4258.488981322261, 4333.371661109185, 4202.7132325028915, 4229.365595160751, 4236.78816059202, 4297.076128632359, 4315.697901146889], "value": 3635.0691959664223, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [277.57115256928057, 278.4472821449423, 282.7229315271034, 283.0348511575528, 289.6061356555086, 4671.322658214557, 4812.278158276256, 4813.8796530086765, 4860.246661767432, 4872.683275587089, 4646.442426908768, 4716.316134160545, 4743.928841067378, 4746.572808447239, 4752.2396416573265, 3722.1997270586817, 3737.364648009845, 3741.494898188737, 3741.9625803742024, 3746.7939263340504, 3589.0309616403556, 3743.3262012837677, 3755.071044585228, 3757.3800322946818, 3785.6560920873108, 3483.2336885885065, 3681.8711345102924, 3698.278835627054, 3715.2569486102752, 3723.343112315021, 3687.0597997510463, 3702.315071711742, 3711.740178187528, 3717.1636381813873, 3718.274936387419, 3267.493538501536, 3268.1339445047083, 3268.869245230188, 3271.8364081795817, 3281.573395458599, 4583.0, 4625.514320996314, 4652.325412815123, 4722.0, 4722.929156062662, 4236.195122926634, 4243.851465198703, 4245.893852653709, 4251.872443826659, 4285.1931984550165, 4935.111679897617, 4943.332650092228, 4948.406191257072, 4956.281339205831, 4983.700977941335, 3349.581302337208, 3471.756977011585, 3495.2659941412335, 3497.387957107496, 3600.6317599312356, 5167.276581278624, 5189.558887494568, 5193.792248310063, 5196.740162991835, 5211.296474975868, 3480.5823301203513, 3493.703035241982, 3495.7378196635354, 3499.3876071687355, 3516.876909308162, 3434.8110853903277, 3532.0, 3538.274653695986, 3564.6791788739138, 3577.6780089791523, 4085.7946905662902, 4105.692073094529, 4106.486689163855, 4132.710710250253, 4132.710710250314, 4958.330625365602, 4959.454460009396, 4968.950310496921, 5000.874978125576, 5018.146915024455, 1154.1401655766508, 1186.4364426897155, 1213.1932265043824, 1213.6055781870928, 1226.693326668333, 796.9003874515686, 821.482466046387, 824.723717554626, 825.1995564302617, 829.6432534010313, 4169.2703776839535, 4201.857052903041, 4216.641585465209, 4227.788610569459, 4229.407882896397, 4892.730899800474, 4908.214685650279, 4933.927750344864, 4993.375828021497, 5001.574866136347, 4132.896677583084, 4196.5803419658405, 4265.189613973335, 4274.337477690963, 4288.292431748789, 2666.9199924001923, 2675.3980354420487, 2679.4373181631686, 2685.9194224173307, 2691.9461610767676, 4663.036419043786, 4693.718376897329, 4706.0587133041845, 4722.433308003062, 4738.32779595816, 4900.508978218859, 4955.554000140005, 5033.672811267256, 5074.873128171751, 5121.513456221727, 4667.556582124693, 4668.649851261169, 4694.746521669617, 4700.177468942921, 4706.647001474835, 4957.950420495749, 4968.527989840959, 4994.275830004702, 5005.023015908623, 5019.196928491424, 4740.786664600032, 4833.88214601573, 4862.933253367375, 4877.9024419512125, 4879.804447910285, 4633.6524760642415, 4650.860669048311, 4652.906566956694, 4666.64001918618, 4670.602998745145, 3445.9655403446645, 3476.9478457823657, 3492.4761285806317, 3493.947590786191, 3497.1257185703575, 4729.327929719698, 4921.827736029221, 4926.630502712383, 5009.874753131201, 5028.9245661315845, 4752.833650822205, 4794.952050479451, 4798.808047678193, 4799.0401919615515, 4811.446683631427, 4759.595434388116, 4795.664303498722, 4849.80600775965, 4864.73243971585, 4865.1242776300605, 4550.453945526558, 4727.739974301447, 4757.881052973703, 4764.190087685032, 4765.642576806684, 4808.3027960946165, 4869.683470574401, 4881.8535443936735, 4881.8535443936735, 4889.266610008385, 4725.952740472551, 4745.9050818984115, 4752.477227505041, 4763.7141771493825, 4767.213409787346], "value": 3674.45495496059, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [605.8243109498246, 649.3765984654734, 665.6039656404438, 718.7376607538248, 726.5023458930633, 11927.701807454818, 12983.285919274436, 13061.151025183368, 13076.150050246728, 13093.0834841561, 12238.388080595956, 12344.32106234159, 12374.62876113718, 12402.627921162357, 12450.875491245084, 600.1987346891883, 618.1901708761515, 722.072137303565, 738.3834498194001, 740.526063319476, 740.8999785029006, 742.9739959101432, 749.2020997637526, 750.9286617771303, 750.9474336796427, 798.7244400681756, 802.2018091998469, 802.4543310548854, 802.5826570183501, 802.9919700803005, 629.6662768732579, 648.345171376908, 650.440621065883, 653.389081209071, 792.0178978067185, 562.2887047884429, 569.8233547600257, 570.8316046766172, 576.3919065386016, 577.249575551781, 12500.49998000079, 12516.311602861839, 12538.68653283666, 12549.247045177228, 12632.0, 11917.0, 12092.758144837142, 12220.877791222063, 12298.569550065704, 12561.623151305384, 10836.0, 10896.40069796161, 11076.169287303404, 11210.439478026066, 11594.130440217017, 3990.201959608061, 3999.5200575930785, 4045.797710114512, 4051.898702532431, 4078.775667338295, 42529.14941701149, 45728.314075288894, 45920.54079459196, 46031.30953035707, 46079.0, 10287.794244115226, 10304.742381440374, 10350.948245258725, 10367.32612380193, 10418.062374386342, 18074.277028918958, 18082.728759068625, 18198.181081851348, 18303.084845757658, 18343.991080490436, 6581.670916454158, 6606.636634985026, 6614.272430032693, 6725.899111513331, 6766.0, 3518.437050071976, 3524.312759011968, 3554.0937061049267, 3560.127768696686, 3656.232191239816, 2699.3656490724666, 2770.0720258713154, 2784.679761827416, 2802.621646077794, 2839.474697181028, 490.1398046428495, 500.14225603090875, 500.71459268217495, 502.5878779400856, 510.652756125838, 528.8228443471403, 585.2450339062647, 597.9431953964366, 618.4588485075559, 619.8109576579096, 7303.0, 7672.309492145734, 7744.49660772048, 7806.92193078062, 7807.258310460497, 496.36713190682167, 611.8195132435942, 622.1103821535157, 642.8971364581645, 648.3257412291165, 3588.2105936693883, 3719.8326075326677, 4018.3972404139613, 4041.7170798043853, 4380.664652567953, 65087.0, 68422.0, 69002.3099769006, 72432.27567724255, 72628.0, 62560.0, 63178.36821631725, 63411.36588634147, 65611.0, 66675.99818035534, 55023.449765501835, 57985.0, 58404.0, 58434.707826460595, 60255.0, 8319.0, 8568.614412351335, 8636.309095272489, 8695.826083478421, 8764.21122099014, 38256.617433825304, 38892.2221555573, 38912.2217555653, 39336.60663393444, 41166.1766764669, 46735.29897051479, 52433.47566524438, 53957.730211348695, 54550.454495454534, 56556.58608534819, 10751.086157676373, 10874.293170943864, 10916.617918372818, 10990.505427255634, 11505.309681419141, 11516.30902145874, 11610.477528511068, 11776.882231177578, 11789.587364442203, 11948.820767688665, 10872.61945831892, 10951.528717353087, 11589.130815189063, 11612.419379031184, 11810.291382517076, 11057.668269951915, 11181.273217240854, 11368.204225704452, 11704.882951170379, 11714.531418743154, 10689.893101069201, 11403.771924561628, 11735.471903764523, 11854.703632409259, 11869.881301187223, 9097.863532047157, 9116.954415227881, 9642.566084526074, 9656.227501799698, 10067.093961543203, 8700.825983480421, 8999.775005624912, 9138.954305228697, 9625.005622666515, 9844.432791470137], "value": 6168.849278354761, "unit": "score"}], "name": "dromaeo_css", "value": 6072.276361848577, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 115.0, 116.0, 114.0, 115.0, 115.0, 116.0, 116.0, 114.0, 113.0], "value": 114.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 130.0, 135.0, 186.0, 129.0, 128.0, 131.0, 131.0, 166.0, 127.0], "value": 142.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 161.0, 161.0, 161.0, 162.0, 162.0, 160.0, 162.0, 163.0], "value": 161.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 75.0, 105.0, 89.0, 78.0, 77.0, 77.0, 102.0, 77.0], "value": 83.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 114.0, 84.0, 84.0, 83.0, 108.0, 84.0, 84.0, 119.0], "value": 92.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 118.0, 117.0, 118.0, 117.0, 119.0, 118.0, 118.0, 117.0], "value": 117.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 147.0, 148.0, 148.0, 146.0, 147.0, 147.0, 147.0, 147.0], "value": 147.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 85.0, 84.0, 84.0, 84.0, 84.0, 85.0, 85.0, 85.0], "value": 84.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 63.0, 64.0, 66.0, 66.0, 64.0, 66.0, 73.0, 64.0], "value": 65.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 67.0, 66.0, 67.0, 66.0, 67.0, 66.0, 67.0, 67.0], "value": 66.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 84.0, 85.0, 95.0, 85.0, 84.0, 92.0, 86.0, 84.0], "value": 86.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 144.0, 147.0, 150.0, 151.0, 142.0, 145.0, 149.0, 197.0, 142.0], "value": 152.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 183.0, 186.0, 181.0, 186.0, 182.0, 178.0, 180.0, 185.0, 180.0], "value": 182.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 71.0, 71.0, 69.0, 69.0, 73.0, 70.0, 76.0, 76.0, 71.0], "value": 71.6, "unit": "score"}], "name": "kraken", "value": 1567.5, "alertThreshold": 2.0}]} 09:10:58 INFO - Return code: 0 09:10:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:10:58 INFO - # TBPL SUCCESS # 09:10:58 INFO - Running post-action listener: _resource_record_post_action 09:10:58 INFO - [mozharness: 2016-11-11 17:10:58.912527Z] Finished run-tests step (success) 09:10:58 INFO - Running post-run listener: _resource_record_post_run 09:10:58 INFO - Total resource usage - Wall time: 1203s; CPU: 13.0%; Read bytes: 0; Write bytes: 403161088; Read time: 0; Write time: 247960 09:10:58 INFO - TinderboxPrint: CPU usage
13.1% 09:10:58 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 09:10:58 INFO - TinderboxPrint: I/O write bytes / time
403,161,088 / 247,960 09:10:58 INFO - TinderboxPrint: CPU idle
8,339.1 (86.9%) 09:10:58 INFO - TinderboxPrint: CPU user
1,211.9 (12.6%) 09:10:58 INFO - TinderboxPrint: Swap in / out
0 / 0 09:10:58 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 99897344; Read time: 0; Write time: 66144 09:10:59 INFO - run-tests - Wall time: 1187s; CPU: 13.0%; Read bytes: 0; Write bytes: 291946496; Read time: 0; Write time: 179844 09:10:59 INFO - Running post-run listener: _upload_blobber_files 09:10:59 INFO - Blob upload gear active. 09:10:59 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:10:59 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 09:10:59 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'] 09:10:59 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 09:10:59 INFO - (blobuploader) - INFO - Open directory for files ... 09:10:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:10:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:10:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:11:03 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:11:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:11:03 INFO - (blobuploader) - INFO - Done attempting. 09:11:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:11:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:11:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:11:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:11:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:11:03 INFO - (blobuploader) - INFO - Done attempting. 09:11:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:11:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:11:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:11:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:11:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:11:04 INFO - (blobuploader) - INFO - Done attempting. 09:11:04 INFO - (blobuploader) - INFO - Iteration through files over. 09:11:04 INFO - Return code: 0 09:11:04 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:11:04 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:11:04 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4bedd3e2806e0740b357e5194c35f4043784e9fc64bc52265e0da8aa1d81e254e495e34eeb3d821ab5ae7b61e209580417da5b3c0145d54487d267afcc8f8bc0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/dd43ce978ed75fee76e7e087841c38d24b4b1b982af818c9a4c4ae46ed735f3e6b8cf93ba4838bf7aaeacf267db3f3deadc704be87ad88965fdf3e639b641bc2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8c30f9cc440d81c21f3930a01c9448ac6860a066a15a7ad2a530ab87b9df3078e0f761540ab60703f8d3a114199fcd5d5a2b371557ba269f308bac6ed595864c"} 09:11:04 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:11:04 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:11:04 INFO - Contents: 09:11:04 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4bedd3e2806e0740b357e5194c35f4043784e9fc64bc52265e0da8aa1d81e254e495e34eeb3d821ab5ae7b61e209580417da5b3c0145d54487d267afcc8f8bc0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/dd43ce978ed75fee76e7e087841c38d24b4b1b982af818c9a4c4ae46ed735f3e6b8cf93ba4838bf7aaeacf267db3f3deadc704be87ad88965fdf3e639b641bc2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8c30f9cc440d81c21f3930a01c9448ac6860a066a15a7ad2a530ab87b9df3078e0f761540ab60703f8d3a114199fcd5d5a2b371557ba269f308bac6ed595864c"} 09:11:04 INFO - Running post-run listener: copy_logs_to_upload_dir 09:11:04 INFO - Copying logs to upload dir... 09:11:04 INFO - mkdir: /builds/slave/test/build/upload/logs 09:11:04 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.115145 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-11-11 09:11:04.327026) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-11 09:11:04.330515) ========= 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-1478881625.57469-2121917952 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/4bedd3e2806e0740b357e5194c35f4043784e9fc64bc52265e0da8aa1d81e254e495e34eeb3d821ab5ae7b61e209580417da5b3c0145d54487d267afcc8f8bc0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/dd43ce978ed75fee76e7e087841c38d24b4b1b982af818c9a4c4ae46ed735f3e6b8cf93ba4838bf7aaeacf267db3f3deadc704be87ad88965fdf3e639b641bc2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8c30f9cc440d81c21f3930a01c9448ac6860a066a15a7ad2a530ab87b9df3078e0f761540ab60703f8d3a114199fcd5d5a2b371557ba269f308bac6ed595864c"} build_url:https://queue.taskcluster.net/v1/task/ZI7JOZs5RnW2CrtFnU4v0g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011226 build_url: 'https://queue.taskcluster.net/v1/task/ZI7JOZs5RnW2CrtFnU4v0g/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/4bedd3e2806e0740b357e5194c35f4043784e9fc64bc52265e0da8aa1d81e254e495e34eeb3d821ab5ae7b61e209580417da5b3c0145d54487d267afcc8f8bc0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/dd43ce978ed75fee76e7e087841c38d24b4b1b982af818c9a4c4ae46ed735f3e6b8cf93ba4838bf7aaeacf267db3f3deadc704be87ad88965fdf3e639b641bc2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8c30f9cc440d81c21f3930a01c9448ac6860a066a15a7ad2a530ab87b9df3078e0f761540ab60703f8d3a114199fcd5d5a2b371557ba269f308bac6ed595864c"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-11 09:11:04.355629) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-11 09:11:04.355917) ========= 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-1478881625.57469-2121917952 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004417 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-11 09:11:04.438687) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-11 09:11:04.438980) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-11 09:11:04.439269) ========= ========= Total master_lag: 0.17 =========