builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-064 starttime: 1477838659.87 results: success (0) buildid: 20161030060922 builduid: ea1784631f55438c9296ea283f27e9ee revision: f4f6435ed714df693381b80184f26f297ec1a461 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-30 07:44:19.870756) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-30 07:44:19.871340) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-30 07:44:19.871791) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-30 07:44:19.886897) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-30 07:44:19.887365) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a12cd81e0ef515edd9e0d800000001bb-1477838660.893373-1808162773 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-30 07:44:21-- 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% 30.4M=0s 2016-10-30 07:44:21 (30.4 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.081069 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-30 07:44:19.982243) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-30 07:44:19.982572) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a12cd81e0ef515edd9e0d800000001bb-1477838660.893373-1808162773 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020871 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-30 07:44:20.032341) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-30 07:44:20.032697) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev f4f6435ed714df693381b80184f26f297ec1a461 --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 f4f6435ed714df693381b80184f26f297ec1a461 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a12cd81e0ef515edd9e0d800000001bb-1477838660.893373-1808162773 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-30 07:44:21,760 truncating revision to first 12 chars 2016-10-30 07:44:21,760 Setting DEBUG logging. 2016-10-30 07:44:21,760 attempt 1/10 2016-10-30 07:44:21,760 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/f4f6435ed714?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-30 07:44:22,843 unpacking tar archive at: mozilla-central-f4f6435ed714/testing/mozharness/ program finished with exit code 0 elapsedTime=1.677607 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-30 07:44:21.722667) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-30 07:44:21.723001) ========= script_repo_revision: f4f6435ed714df693381b80184f26f297ec1a461 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-30 07:44:21.723471) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-30 07:44:21.723743) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-30 07:44:21.731577) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-10-30 07:44:21.731917) ========= /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=a12cd81e0ef515edd9e0d800000001bb-1477838660.893373-1808162773 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:44:23 INFO - MultiFileLogger online at 20161030 07:44:23 in /builds/slave/test 07:44:23 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 07:44:23 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:44:23 INFO - {'append_to_log': False, 07:44:23 INFO - 'base_work_dir': '/builds/slave/test', 07:44:23 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 07:44:23 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:44:23 INFO - 'branch': 'Firefox-Non-PGO', 07:44:23 INFO - 'buildbot_json_path': 'buildprops.json', 07:44:23 INFO - 'config_files': ('talos/linux_config.py',), 07:44:23 INFO - 'default_actions': ('clobber', 07:44:23 INFO - 'read-buildbot-config', 07:44:23 INFO - 'download-and-extract', 07:44:23 INFO - 'populate-webroot', 07:44:23 INFO - 'create-virtualenv', 07:44:23 INFO - 'install', 07:44:23 INFO - 'run-tests'), 07:44:23 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:44:23 INFO - 'download_minidump_stackwalk': True, 07:44:23 INFO - 'download_symbols': 'ondemand', 07:44:23 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:44:23 INFO - 'tooltool.py': '/tools/tooltool.py', 07:44:23 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:44:23 INFO - '/tools/misc-python/virtualenv.py')}, 07:44:23 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:44:23 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:44:23 INFO - 'installer_path': 'installer.exe', 07:44:23 INFO - 'log_level': 'info', 07:44:23 INFO - 'log_name': 'talos', 07:44:23 INFO - 'log_to_console': True, 07:44:23 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:44:23 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:44:23 INFO - 'opt_config_files': (), 07:44:23 INFO - 'pip_index': False, 07:44:23 INFO - 'sps_profile': False, 07:44:23 INFO - 'sps_profile_interval': 0, 07:44:23 INFO - 'suite': 'dromaeojs', 07:44:23 INFO - 'system_bits': '32', 07:44:23 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:44:23 INFO - 'title': 'talos-linux64-ix-064', 07:44:23 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:44:23 INFO - 'use_talos_json': True, 07:44:23 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:44:23 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:44:23 INFO - 'work_dir': 'build'} 07:44:23 INFO - [mozharness: 2016-10-30 14:44:23.554564Z] Running clobber step. 07:44:23 INFO - Running pre-action listener: _resource_record_pre_action 07:44:23 INFO - Running main action method: clobber 07:44:23 INFO - rmtree: /builds/slave/test/build 07:44:23 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:44:24 INFO - Running post-action listener: _resource_record_post_action 07:44:24 INFO - [mozharness: 2016-10-30 14:44:24.534428Z] Finished clobber step (success) 07:44:24 INFO - [mozharness: 2016-10-30 14:44:24.534528Z] Running read-buildbot-config step. 07:44:24 INFO - Running pre-action listener: _resource_record_pre_action 07:44:24 INFO - Running main action method: read_buildbot_config 07:44:24 INFO - Using buildbot properties: 07:44:24 INFO - { 07:44:24 INFO - "project": "", 07:44:24 INFO - "product": "firefox", 07:44:24 INFO - "script_repo_revision": "production", 07:44:24 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 07:44:24 INFO - "repository": "", 07:44:24 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 07:44:24 INFO - "buildid": "20161030060922", 07:44:24 INFO - "pgo_build": "False", 07:44:24 INFO - "basedir": "/builds/slave/test", 07:44:24 INFO - "buildnumber": 700, 07:44:24 INFO - "slavename": "talos-linux64-ix-064", 07:44:24 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 07:44:24 INFO - "platform": "ubuntu64_hw", 07:44:24 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 07:44:24 INFO - "branch": "mozilla-central", 07:44:24 INFO - "repo_path": "mozilla-central", 07:44:24 INFO - "revision": "f4f6435ed714df693381b80184f26f297ec1a461", 07:44:24 INFO - "stage_platform": "linux64", 07:44:24 INFO - "builduid": "ea1784631f55438c9296ea283f27e9ee", 07:44:24 INFO - "slavebuilddir": "test" 07:44:24 INFO - } 07:44:24 INFO - Found installer url https://queue.taskcluster.net/v1/task/Y2r8ZAIBSEKUNiMHtiOQaQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 07:44:24 INFO - Running post-action listener: _resource_record_post_action 07:44:24 INFO - [mozharness: 2016-10-30 14:44:24.536953Z] Finished read-buildbot-config step (success) 07:44:24 INFO - [mozharness: 2016-10-30 14:44:24.537041Z] Running download-and-extract step. 07:44:24 INFO - Running pre-action listener: _resource_record_pre_action 07:44:24 INFO - Running main action method: download_and_extract 07:44:24 INFO - mkdir: /builds/slave/test/build/tests 07:44:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:44:24 INFO - trying https://queue.taskcluster.net/v1/task/Y2r8ZAIBSEKUNiMHtiOQaQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 07:44:24 INFO - Downloading https://queue.taskcluster.net/v1/task/Y2r8ZAIBSEKUNiMHtiOQaQ/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 07:44:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Y2r8ZAIBSEKUNiMHtiOQaQ/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 07:44:25 INFO - Downloaded 1361 bytes. 07:44:25 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 07:44:25 INFO - Using the following test package requirements: 07:44:25 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 07:44:25 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 07:44:25 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:44:25 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 07:44:25 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:44:25 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 07:44:25 INFO - u'jsshell-linux-x86_64.zip'], 07:44:25 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 07:44:25 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:44:25 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 07:44:25 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 07:44:25 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:44:25 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 07:44:25 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:44:25 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 07:44:25 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:44:25 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 07:44:25 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:44:25 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:44:25 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Y2r8ZAIBSEKUNiMHtiOQaQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 07:44:25 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Y2r8ZAIBSEKUNiMHtiOQaQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:44:25 INFO - Fetch https://queue.taskcluster.net/v1/task/Y2r8ZAIBSEKUNiMHtiOQaQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 07:44:25 INFO - Http code: 200 07:44:25 INFO - via: 1.1 ff555a0cc6346f82fe74596f8ed6cc33.cloudfront.net (CloudFront) 07:44:25 INFO - x-amz-cf-id: 9C-6858U7jXTCAN-FG4o6vx2P01NZfCfPHogderAOttbDI72_nY4wg== 07:44:25 INFO - x-amz-version-id: D0u6PS7srlw9NynJKaCiVLlTFBiWhydk 07:44:26 INFO - Expected file size: 20439025 07:44:26 INFO - Obtained file size: 20439025 07:44:30 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 07:44:30 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Y2r8ZAIBSEKUNiMHtiOQaQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 07:44:30 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Y2r8ZAIBSEKUNiMHtiOQaQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:44:30 INFO - Fetch https://queue.taskcluster.net/v1/task/Y2r8ZAIBSEKUNiMHtiOQaQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 07:44:30 INFO - Http code: 200 07:44:30 INFO - via: 1.1 ff555a0cc6346f82fe74596f8ed6cc33.cloudfront.net (CloudFront) 07:44:30 INFO - x-amz-cf-id: dpUTz4rTKyY4EXK7zyHCsc1XdFLxu1HfMqWrSXVLDjlYqspnEy3x5A== 07:44:30 INFO - x-amz-version-id: D0u6PS7srlw9NynJKaCiVLlTFBiWhydk 07:44:30 INFO - Expected file size: 20439025 07:44:30 INFO - Obtained file size: 20439025 07:44:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Y2r8ZAIBSEKUNiMHtiOQaQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 07:44:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Y2r8ZAIBSEKUNiMHtiOQaQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 07:44:35 INFO - Fetch https://queue.taskcluster.net/v1/task/Y2r8ZAIBSEKUNiMHtiOQaQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 07:44:35 INFO - Http code: 200 07:44:35 INFO - via: 1.1 d2bd759914e30b1d5aee2929535c55f9.cloudfront.net (CloudFront) 07:44:35 INFO - x-amz-cf-id: GvTR9Yv_4bOhdYs8sTSfv8T2ErAuScbLXefJwU7WKxtm0Z88tK-_ow== 07:44:35 INFO - x-amz-version-id: HT.CZ9rytQ2i31YptskWBLwYwfg30NEA 07:44:36 INFO - Expected file size: 14409038 07:44:36 INFO - Obtained file size: 14409038 07:44: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')]} 07:44:36 INFO - trying https://queue.taskcluster.net/v1/task/Y2r8ZAIBSEKUNiMHtiOQaQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 07:44:36 INFO - Downloading https://queue.taskcluster.net/v1/task/Y2r8ZAIBSEKUNiMHtiOQaQ/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 07:44:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Y2r8ZAIBSEKUNiMHtiOQaQ/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 07:44:37 INFO - Downloaded 55742282 bytes. 07:44:37 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Y2r8ZAIBSEKUNiMHtiOQaQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 07:44:37 INFO - mkdir: /builds/slave/test/properties 07:44:37 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:44:37 INFO - Writing to file /builds/slave/test/properties/build_url 07:44:37 INFO - Contents: 07:44:37 INFO - build_url:https://queue.taskcluster.net/v1/task/Y2r8ZAIBSEKUNiMHtiOQaQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 07:44:38 INFO - Running post-action listener: _resource_record_post_action 07:44:38 INFO - Running post-action listener: set_extra_try_arguments 07:44:38 INFO - [mozharness: 2016-10-30 14:44:38.176564Z] Finished download-and-extract step (success) 07:44:38 INFO - [mozharness: 2016-10-30 14:44:38.176795Z] Running populate-webroot step. 07:44:38 INFO - Running pre-action listener: _resource_record_pre_action 07:44:38 INFO - Running main action method: populate_webroot 07:44:38 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:44:38 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:44:38 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:44:38 INFO - '--tppagecycles', 07:44:38 INFO - '7'], 07:44:38 INFO - 'tests': ['tsvgm']}}, 07:44:38 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:44:38 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:44:38 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:44:38 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:44:38 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:44:38 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:44:38 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:44:38 INFO - 'talos_options': ['--disable-e10s'], 07:44:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:44:38 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:44:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:44:38 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:44:38 INFO - 'talos_options': ['--disable-e10s'], 07:44:38 INFO - 'tests': ['damp', 'tps']}, 07:44:38 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:44:38 INFO - 'tests': ['damp', 'tps']}, 07:44:38 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:44:38 INFO - 'tests': ['dromaeo_dom']}, 07:44:38 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:44:38 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:44:38 INFO - 'tests': ['basic_compositor_video']}, 07:44:38 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:44:38 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:44:38 INFO - 'tests': ['a11yr', 07:44:38 INFO - 'ts_paint', 07:44:38 INFO - 'tpaint', 07:44:38 INFO - 'sessionrestore', 07:44:38 INFO - 'sessionrestore_no_auto_restore', 07:44:38 INFO - 'tabpaint']}, 07:44:38 INFO - 'other-e10s': {'tests': ['a11yr', 07:44:38 INFO - 'ts_paint', 07:44:38 INFO - 'tpaint', 07:44:38 INFO - 'sessionrestore', 07:44:38 INFO - 'sessionrestore_no_auto_restore', 07:44:38 INFO - 'tabpaint']}, 07:44:38 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:44:38 INFO - 'ts_paint', 07:44:38 INFO - 'tpaint', 07:44:38 INFO - 'sessionrestore', 07:44:38 INFO - 'sessionrestore_no_auto_restore', 07:44:38 INFO - 'tabpaint']}, 07:44:38 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:44:38 INFO - 'ts_paint', 07:44:38 INFO - 'tpaint', 07:44:38 INFO - 'sessionrestore', 07:44:38 INFO - 'sessionrestore_no_auto_restore', 07:44:38 INFO - 'tabpaint']}, 07:44:38 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:44:38 INFO - 'tests': ['a11yr', 07:44:38 INFO - 'ts_paint', 07:44:38 INFO - 'tpaint', 07:44:38 INFO - 'sessionrestore', 07:44:38 INFO - 'sessionrestore_no_auto_restore', 07:44:38 INFO - 'tabpaint']}, 07:44:38 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:44:38 INFO - 'tests': ['a11yr', 07:44:38 INFO - 'ts_paint', 07:44:38 INFO - 'tpaint', 07:44:38 INFO - 'sessionrestore', 07:44:38 INFO - 'sessionrestore_no_auto_restore', 07:44:38 INFO - 'tabpaint']}, 07:44:38 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:44:38 INFO - 'tests': ['tsvgx', 07:44:38 INFO - 'tsvgr_opacity', 07:44:38 INFO - 'tart', 07:44:38 INFO - 'tscrollx', 07:44:38 INFO - 'cart']}, 07:44:38 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:44:38 INFO - 'tsvgr_opacity', 07:44:38 INFO - 'tart', 07:44:38 INFO - 'tscrollx', 07:44:38 INFO - 'cart']}, 07:44:38 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:44:38 INFO - 'talos_options': ['--disable-e10s'], 07:44:38 INFO - 'tests': ['tp5o']}, 07:44:38 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:44:38 INFO - 'tests': ['tp5o']}, 07:44:38 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:44:38 INFO - 'talos_options': ['--disable-e10s', 07:44:38 INFO - '--xperf_path', 07:44:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:44:38 INFO - 'tests': ['tp5n']}, 07:44:38 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:44:38 INFO - 'talos_options': ['--xperf_path', 07:44:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:44:38 INFO - 'tests': ['tp5n']}}, 07:44:38 INFO - 'talos.zip': {'path': '', 07:44:38 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:44:38 INFO - Running post-action listener: _resource_record_post_action 07:44:38 INFO - [mozharness: 2016-10-30 14:44:38.198099Z] Finished populate-webroot step (success) 07:44:38 INFO - [mozharness: 2016-10-30 14:44:38.198188Z] Running create-virtualenv step. 07:44:38 INFO - Running pre-action listener: _resource_record_pre_action 07:44:38 INFO - Running main action method: create_virtualenv 07:44:38 INFO - Creating virtualenv /builds/slave/test/build/venv 07:44:38 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 07:44:38 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:44:38 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:44:38 INFO - Using real prefix '/usr' 07:44:38 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:44:38 INFO - Installing distribute.............................................................................................................................................................................................done. 07:44:40 INFO - Installing pip.................done. 07:44:40 INFO - Return code: 0 07:44:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 07:44:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 07:44:40 INFO - Reading from file tmpfile_stdout 07:44:40 INFO - Output received: 07:44:40 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) 07:44:40 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:44:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:44:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:44:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:44:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:44:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:44:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:44:40 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 0x7ff7176fdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x210d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21daca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21d7f60>, '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 0x21d8d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21d91d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1477838660.893373-1808162773', '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 07:44:40 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 07:44:40 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 07:44:40 INFO - Using env: {'DISPLAY': ':0', 07:44:40 INFO - 'HOME': '/home/cltbld', 07:44:40 INFO - 'LANG': 'en_US.UTF-8', 07:44:40 INFO - 'LANGUAGE': 'en_US:en', 07:44:40 INFO - 'LOGNAME': 'cltbld', 07:44:40 INFO - 'MAIL': '/var/mail/cltbld', 07:44:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:44:40 INFO - 'MOZ_NO_REMOTE': '1', 07:44:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:44:40 INFO - 'NO_EM_RESTART': '1', 07:44:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:44:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:44:40 INFO - 'PWD': '/builds/slave/test', 07:44:40 INFO - 'SHELL': '/bin/bash', 07:44:40 INFO - 'SHLVL': '1', 07:44:40 INFO - 'TERM': 'linux', 07:44:40 INFO - 'TMOUT': '86400', 07:44:40 INFO - 'USER': 'cltbld', 07:44:40 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1477838660.893373-1808162773', 07:44:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:44:40 INFO - '_': '/tools/buildbot/bin/python'} 07:44:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:44:41 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 07:44:41 INFO - Cleaning up... 07:44:41 INFO - Return code: 0 07:44:41 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:44: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')]} 07:44:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:44:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:44: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')]} 07:44:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:44:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:44: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', '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 0x7ff7176fdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x210d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21daca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21d7f60>, '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 0x21d8d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21d91d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1477838660.893373-1808162773', '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 07:44: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', 'psutil>=3.1.1'] in /builds/slave/test/build 07:44: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 psutil>=3.1.1 07:44:41 INFO - Using env: {'DISPLAY': ':0', 07:44:41 INFO - 'HOME': '/home/cltbld', 07:44:41 INFO - 'LANG': 'en_US.UTF-8', 07:44:41 INFO - 'LANGUAGE': 'en_US:en', 07:44:41 INFO - 'LOGNAME': 'cltbld', 07:44:41 INFO - 'MAIL': '/var/mail/cltbld', 07:44:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:44:41 INFO - 'MOZ_NO_REMOTE': '1', 07:44:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:44:41 INFO - 'NO_EM_RESTART': '1', 07:44:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:44:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:44:41 INFO - 'PWD': '/builds/slave/test', 07:44:41 INFO - 'SHELL': '/bin/bash', 07:44:41 INFO - 'SHLVL': '1', 07:44:41 INFO - 'TERM': 'linux', 07:44:41 INFO - 'TMOUT': '86400', 07:44:41 INFO - 'USER': 'cltbld', 07:44:41 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1477838660.893373-1808162773', 07:44:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:44:41 INFO - '_': '/tools/buildbot/bin/python'} 07:44:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:44:41 INFO - Downloading/unpacking psutil>=3.1.1 07:44: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 07:44: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 07:44: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 07:44: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 07:44: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 07:44: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 07:44:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:44:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:44:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:44:43 INFO - Installing collected packages: psutil 07:44:43 INFO - Running setup.py install for psutil 07:44:43 INFO - building 'psutil._psutil_linux' extension 07:44:43 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 07:44:43 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 07:44:43 INFO - building 'psutil._psutil_posix' extension 07:44:43 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 07:44:43 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 07:44:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:44:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:44:43 INFO - Successfully installed psutil 07:44:43 INFO - Cleaning up... 07:44:44 INFO - Return code: 0 07:44:44 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:44: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')]} 07:44:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:44:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:44: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')]} 07:44:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:44:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:44: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff7176fdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x210d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21daca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21d7f60>, '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 0x21d8d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21d91d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1477838660.893373-1808162773', '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 07:44: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 07:44: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 mozsystemmonitor==0.3 07:44:44 INFO - Using env: {'DISPLAY': ':0', 07:44:44 INFO - 'HOME': '/home/cltbld', 07:44:44 INFO - 'LANG': 'en_US.UTF-8', 07:44:44 INFO - 'LANGUAGE': 'en_US:en', 07:44:44 INFO - 'LOGNAME': 'cltbld', 07:44:44 INFO - 'MAIL': '/var/mail/cltbld', 07:44:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:44:44 INFO - 'MOZ_NO_REMOTE': '1', 07:44:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:44:44 INFO - 'NO_EM_RESTART': '1', 07:44:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:44:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:44:44 INFO - 'PWD': '/builds/slave/test', 07:44:44 INFO - 'SHELL': '/bin/bash', 07:44:44 INFO - 'SHLVL': '1', 07:44:44 INFO - 'TERM': 'linux', 07:44:44 INFO - 'TMOUT': '86400', 07:44:44 INFO - 'USER': 'cltbld', 07:44:44 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1477838660.893373-1808162773', 07:44:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:44:44 INFO - '_': '/tools/buildbot/bin/python'} 07:44:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:44:44 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:44: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 07:44: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 07:44: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 07:44: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 07:44: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 07:44: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 07:44:46 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:44:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:44:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:44:46 INFO - Installing collected packages: mozsystemmonitor 07:44:46 INFO - Running setup.py install for mozsystemmonitor 07:44:46 INFO - Successfully installed mozsystemmonitor 07:44:46 INFO - Cleaning up... 07:44:46 INFO - Return code: 0 07:44:46 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:44:46 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')]} 07:44:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:44:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:44:46 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')]} 07:44:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:44:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:44:46 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 0x7ff7176fdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x210d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21daca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21d7f60>, '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 0x21d8d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21d91d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1477838660.893373-1808162773', '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 07:44:46 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 07:44:46 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 07:44:46 INFO - Using env: {'DISPLAY': ':0', 07:44:46 INFO - 'HOME': '/home/cltbld', 07:44:46 INFO - 'LANG': 'en_US.UTF-8', 07:44:46 INFO - 'LANGUAGE': 'en_US:en', 07:44:46 INFO - 'LOGNAME': 'cltbld', 07:44:46 INFO - 'MAIL': '/var/mail/cltbld', 07:44:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:44:46 INFO - 'MOZ_NO_REMOTE': '1', 07:44:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:44:46 INFO - 'NO_EM_RESTART': '1', 07:44:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:44:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:44:46 INFO - 'PWD': '/builds/slave/test', 07:44:46 INFO - 'SHELL': '/bin/bash', 07:44:46 INFO - 'SHLVL': '1', 07:44:46 INFO - 'TERM': 'linux', 07:44:46 INFO - 'TMOUT': '86400', 07:44:46 INFO - 'USER': 'cltbld', 07:44:46 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1477838660.893373-1808162773', 07:44:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:44:46 INFO - '_': '/tools/buildbot/bin/python'} 07:44:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:44:46 INFO - Downloading/unpacking jsonschema==2.5.1 07:44: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 07:44: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 07:44: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 07:44: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 07:44: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 07:44: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 07:44:48 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:44:48 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:44:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:44:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:44:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:44:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:44:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:44:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:44:48 INFO - Downloading functools32-3.2.3-2.tar.gz 07:44:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:44:48 INFO - warning: no files found matching '*.txt' 07:44:48 INFO - no previously-included directories found matching 'build' 07:44:48 INFO - no previously-included directories found matching 'dist' 07:44:48 INFO - no previously-included directories found matching '.git*' 07:44:48 INFO - Installing collected packages: jsonschema, functools32 07:44:48 INFO - Running setup.py install for functools32 07:44:48 INFO - warning: no files found matching '*.txt' 07:44:48 INFO - no previously-included directories found matching 'build' 07:44:48 INFO - no previously-included directories found matching 'dist' 07:44:48 INFO - no previously-included directories found matching '.git*' 07:44:48 INFO - Successfully installed jsonschema functools32 07:44:48 INFO - Cleaning up... 07:44:48 INFO - Return code: 0 07:44:48 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:44:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:44:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:44:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:44:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:44:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:44:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:44:48 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 0x7ff7176fdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x210d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21daca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21d7f60>, '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 0x21d8d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21d91d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1477838660.893373-1808162773', '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 07:44:48 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 07:44:48 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 07:44:48 INFO - Using env: {'DISPLAY': ':0', 07:44:48 INFO - 'HOME': '/home/cltbld', 07:44:48 INFO - 'LANG': 'en_US.UTF-8', 07:44:48 INFO - 'LANGUAGE': 'en_US:en', 07:44:48 INFO - 'LOGNAME': 'cltbld', 07:44:48 INFO - 'MAIL': '/var/mail/cltbld', 07:44:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:44:48 INFO - 'MOZ_NO_REMOTE': '1', 07:44:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:44:48 INFO - 'NO_EM_RESTART': '1', 07:44:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:44:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:44:48 INFO - 'PWD': '/builds/slave/test', 07:44:48 INFO - 'SHELL': '/bin/bash', 07:44:48 INFO - 'SHLVL': '1', 07:44:48 INFO - 'TERM': 'linux', 07:44:48 INFO - 'TMOUT': '86400', 07:44:48 INFO - 'USER': 'cltbld', 07:44:48 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1477838660.893373-1808162773', 07:44:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:44:48 INFO - '_': '/tools/buildbot/bin/python'} 07:44:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:44:49 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:44:49 INFO - Cleaning up... 07:44:49 INFO - Return code: 0 07:44:49 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:44:49 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')]} 07:44:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:44:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:44:49 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')]} 07:44:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:44:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:44:49 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 0x7ff7176fdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x210d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21daca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21d7f60>, '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 0x21d8d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21d91d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1477838660.893373-1808162773', '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 07:44:49 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 07:44:49 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 07:44:49 INFO - Using env: {'DISPLAY': ':0', 07:44:49 INFO - 'HOME': '/home/cltbld', 07:44:49 INFO - 'LANG': 'en_US.UTF-8', 07:44:49 INFO - 'LANGUAGE': 'en_US:en', 07:44:49 INFO - 'LOGNAME': 'cltbld', 07:44:49 INFO - 'MAIL': '/var/mail/cltbld', 07:44:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:44:49 INFO - 'MOZ_NO_REMOTE': '1', 07:44:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:44:49 INFO - 'NO_EM_RESTART': '1', 07:44:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:44:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:44:49 INFO - 'PWD': '/builds/slave/test', 07:44:49 INFO - 'SHELL': '/bin/bash', 07:44:49 INFO - 'SHLVL': '1', 07:44:49 INFO - 'TERM': 'linux', 07:44:49 INFO - 'TMOUT': '86400', 07:44:49 INFO - 'USER': 'cltbld', 07:44:49 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1477838660.893373-1808162773', 07:44:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:44:49 INFO - '_': '/tools/buildbot/bin/python'} 07:44:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:44:49 INFO - Downloading/unpacking blobuploader==1.2.4 07:44:49 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 07:44:49 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 07:44:49 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 07:44:49 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 07:44:49 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 07:44:49 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 07:44:51 INFO - Downloading blobuploader-1.2.4.tar.gz 07:44:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:44:51 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:44:51 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 07:44:51 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 07:44:51 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 07:44:51 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 07:44:51 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 07:44:51 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 07:44:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:44:51 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:44:51 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 07:44:51 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 07:44:51 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 07:44:51 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 07:44:51 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 07:44:51 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 07:44:52 INFO - Downloading docopt-0.6.1.tar.gz 07:44:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:44:52 INFO - Installing collected packages: blobuploader, requests, docopt 07:44:52 INFO - Running setup.py install for blobuploader 07:44:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:44:52 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:44:52 INFO - Running setup.py install for requests 07:44:52 INFO - Running setup.py install for docopt 07:44:52 INFO - Successfully installed blobuploader requests docopt 07:44:52 INFO - Cleaning up... 07:44:52 INFO - Return code: 0 07:44:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:44:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:44:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:44:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:44:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:44:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:44:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:44:52 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 0x7ff7176fdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x210d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21daca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21d7f60>, '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 0x21d8d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21d91d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1477838660.893373-1808162773', '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 07:44:52 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 07:44:52 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 07:44:52 INFO - Using env: {'DISPLAY': ':0', 07:44:52 INFO - 'HOME': '/home/cltbld', 07:44:52 INFO - 'LANG': 'en_US.UTF-8', 07:44:52 INFO - 'LANGUAGE': 'en_US:en', 07:44:52 INFO - 'LOGNAME': 'cltbld', 07:44:52 INFO - 'MAIL': '/var/mail/cltbld', 07:44:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:44:52 INFO - 'MOZ_NO_REMOTE': '1', 07:44:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:44:52 INFO - 'NO_EM_RESTART': '1', 07:44:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:44:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:44:52 INFO - 'PWD': '/builds/slave/test', 07:44:52 INFO - 'SHELL': '/bin/bash', 07:44:52 INFO - 'SHLVL': '1', 07:44:52 INFO - 'TERM': 'linux', 07:44:52 INFO - 'TMOUT': '86400', 07:44:52 INFO - 'USER': 'cltbld', 07:44:52 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1477838660.893373-1808162773', 07:44:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:44:52 INFO - '_': '/tools/buildbot/bin/python'} 07:44:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:44:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:44:52 INFO - Running setup.py (path:/tmp/pip-BygJdh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:44:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:44:52 INFO - Running setup.py (path:/tmp/pip-Ti2qnC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:44:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:44:53 INFO - Running setup.py (path:/tmp/pip-Rxvo0d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:44:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:44:53 INFO - Running setup.py (path:/tmp/pip-FaGxoa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:44:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:44:53 INFO - Running setup.py (path:/tmp/pip-ImIVKO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:44:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:44:53 INFO - Running setup.py (path:/tmp/pip-B7neRI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:44:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:44:53 INFO - Running setup.py (path:/tmp/pip-VGXVDt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:44:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:44:53 INFO - Running setup.py (path:/tmp/pip-840CAX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:44:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:44:53 INFO - Running setup.py (path:/tmp/pip-ZRhPYK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:44:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:44:53 INFO - Running setup.py (path:/tmp/pip-i8OU6f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:44:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:44:53 INFO - Running setup.py (path:/tmp/pip-5tUU_0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:44:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:44:53 INFO - Running setup.py (path:/tmp/pip-e34vf7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:44:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:44:53 INFO - Running setup.py (path:/tmp/pip-rkRq39-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:44:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:44:53 INFO - Running setup.py (path:/tmp/pip-GG3FMP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:44:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:44:53 INFO - Running setup.py (path:/tmp/pip-voSXtC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:44:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:44:54 INFO - Running setup.py (path:/tmp/pip-xG7DuC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:44:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:44:54 INFO - Running setup.py (path:/tmp/pip-fgINPo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:44:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:44:54 INFO - Running setup.py install for manifestparser 07:44:54 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:44:54 INFO - Running setup.py install for mozcrash 07:44:54 INFO - Running setup.py install for mozdebug 07:44:54 INFO - Running setup.py install for mozdevice 07:44:54 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:44:54 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:44:54 INFO - Running setup.py install for mozfile 07:44:54 INFO - Running setup.py install for mozhttpd 07:44:54 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:44:54 INFO - Running setup.py install for mozinfo 07:44:54 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:44:54 INFO - Running setup.py install for mozInstall 07:44:54 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:44:54 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:44:54 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:44:54 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:44:54 INFO - Running setup.py install for mozleak 07:44:55 INFO - Running setup.py install for mozlog 07:44:55 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:44:55 INFO - Running setup.py install for moznetwork 07:44:55 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:44:55 INFO - Running setup.py install for mozprocess 07:44:55 INFO - Running setup.py install for mozprofile 07:44:55 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:44:55 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:44:55 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:44:55 INFO - Running setup.py install for mozrunner 07:44:55 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:44:55 INFO - Running setup.py install for mozscreenshot 07:44:55 INFO - Running setup.py install for moztest 07:44:55 INFO - Running setup.py install for mozversion 07:44:55 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:44:55 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:44:55 INFO - Cleaning up... 07:44:55 INFO - Return code: 0 07:44:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:44: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')]} 07:44:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:44:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:44: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')]} 07:44:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:44:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:44:55 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 0x7ff7176fdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x210d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21daca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21d7f60>, '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 0x21d8d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21d91d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1477838660.893373-1808162773', '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 07:44:55 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 07:44:55 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 07:44:55 INFO - Using env: {'DISPLAY': ':0', 07:44:55 INFO - 'HOME': '/home/cltbld', 07:44:55 INFO - 'LANG': 'en_US.UTF-8', 07:44:55 INFO - 'LANGUAGE': 'en_US:en', 07:44:55 INFO - 'LOGNAME': 'cltbld', 07:44:55 INFO - 'MAIL': '/var/mail/cltbld', 07:44:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:44:55 INFO - 'MOZ_NO_REMOTE': '1', 07:44:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:44:55 INFO - 'NO_EM_RESTART': '1', 07:44:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:44:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:44:55 INFO - 'PWD': '/builds/slave/test', 07:44:55 INFO - 'SHELL': '/bin/bash', 07:44:55 INFO - 'SHLVL': '1', 07:44:55 INFO - 'TERM': 'linux', 07:44:55 INFO - 'TMOUT': '86400', 07:44:55 INFO - 'USER': 'cltbld', 07:44:55 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1477838660.893373-1808162773', 07:44:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:44:55 INFO - '_': '/tools/buildbot/bin/python'} 07:44:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:44:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:44:56 INFO - Running setup.py (path:/tmp/pip-ww1pZa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:44:56 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)) 07:44:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:44:56 INFO - Running setup.py (path:/tmp/pip-5OI9ny-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:44:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:44:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:44:56 INFO - Running setup.py (path:/tmp/pip-zCKqIy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:44:56 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)) 07:44:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:44:56 INFO - Running setup.py (path:/tmp/pip-fHrXlc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:44:56 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)) 07:44:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:44:56 INFO - Running setup.py (path:/tmp/pip-a52fXh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:44:56 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)) 07:44:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:44:56 INFO - Running setup.py (path:/tmp/pip-X1suAk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:44:56 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)) 07:44:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:44:56 INFO - Running setup.py (path:/tmp/pip-MDEmkg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:44:56 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)) 07:44:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:44:56 INFO - Running setup.py (path:/tmp/pip-qgIvwU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:44:56 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)) 07:44:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:44:56 INFO - Running setup.py (path:/tmp/pip-a3ZxkG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:44:56 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)) 07:44:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:44:56 INFO - Running setup.py (path:/tmp/pip-pMv7aH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:44:56 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)) 07:44:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:44:56 INFO - Running setup.py (path:/tmp/pip-BN6tqP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:44:56 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)) 07:44:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:44:56 INFO - Running setup.py (path:/tmp/pip-45vysy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:44:57 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)) 07:44:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:44:57 INFO - Running setup.py (path:/tmp/pip-P6iAl6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:44:57 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)) 07:44:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:44:57 INFO - Running setup.py (path:/tmp/pip-0h9hSE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:44:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 07:44:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:44:57 INFO - Running setup.py (path:/tmp/pip-gvR2dl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:44:57 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)) 07:44:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:44:57 INFO - Running setup.py (path:/tmp/pip-ZsUiyz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:44:57 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)) 07:44:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:44:57 INFO - Running setup.py (path:/tmp/pip-tlNETd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:44:57 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)) 07:44:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:44:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:44:57 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)) 07:44:57 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)) 07:44:57 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)) 07:44:57 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:44:57 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 07:44:57 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 07:44:57 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 07:44:57 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 07:44:57 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 07:44:57 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 07:44:59 INFO - Downloading blessings-1.6.tar.gz 07:44:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:44:59 INFO - Installing collected packages: blessings 07:44:59 INFO - Running setup.py install for blessings 07:44:59 INFO - Successfully installed blessings 07:44:59 INFO - Cleaning up... 07:44:59 INFO - Return code: 0 07:44:59 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:44:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:44:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:44:59 INFO - Reading from file tmpfile_stdout 07:44:59 INFO - Current package versions: 07:44:59 INFO - argparse == 1.2.1 07:44:59 INFO - blessings == 1.6 07:44:59 INFO - blobuploader == 1.2.4 07:44:59 INFO - docopt == 0.6.1 07:44:59 INFO - functools32 == 3.2.3-2 07:44:59 INFO - jsonschema == 2.5.1 07:44:59 INFO - manifestparser == 1.1 07:44:59 INFO - mozInstall == 1.12 07:44:59 INFO - mozcrash == 0.17 07:44:59 INFO - mozdebug == 0.1 07:44:59 INFO - mozdevice == 0.48 07:44:59 INFO - mozfile == 1.2 07:44:59 INFO - mozhttpd == 0.7 07:44:59 INFO - mozinfo == 0.9 07:44:59 INFO - mozleak == 0.1 07:44:59 INFO - mozlog == 3.4 07:44:59 INFO - moznetwork == 0.27 07:44:59 INFO - mozprocess == 0.23 07:44:59 INFO - mozprofile == 0.28 07:44:59 INFO - mozrunner == 6.12 07:44:59 INFO - mozscreenshot == 0.1 07:44:59 INFO - mozsystemmonitor == 0.3 07:44:59 INFO - moztest == 0.7 07:44:59 INFO - mozversion == 1.4 07:44:59 INFO - psutil == 3.1.1 07:44:59 INFO - requests == 1.2.3 07:44:59 INFO - wsgiref == 0.1.2 07:44:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:44:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:44:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:44:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:44:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:44:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:44:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:44:59 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 0x7ff7176fdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x210d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21daca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21d7f60>, '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 0x21d8d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21d91d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1477838660.893373-1808162773', '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 07:44:59 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 07:44:59 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 07:44:59 INFO - Using env: {'DISPLAY': ':0', 07:44:59 INFO - 'HOME': '/home/cltbld', 07:44:59 INFO - 'LANG': 'en_US.UTF-8', 07:44:59 INFO - 'LANGUAGE': 'en_US:en', 07:44:59 INFO - 'LOGNAME': 'cltbld', 07:44:59 INFO - 'MAIL': '/var/mail/cltbld', 07:44:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:44:59 INFO - 'MOZ_NO_REMOTE': '1', 07:44:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:44:59 INFO - 'NO_EM_RESTART': '1', 07:44:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:44:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:44:59 INFO - 'PWD': '/builds/slave/test', 07:44:59 INFO - 'SHELL': '/bin/bash', 07:44:59 INFO - 'SHLVL': '1', 07:44:59 INFO - 'TERM': 'linux', 07:44:59 INFO - 'TMOUT': '86400', 07:44:59 INFO - 'USER': 'cltbld', 07:44:59 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1477838660.893373-1808162773', 07:44:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:44:59 INFO - '_': '/tools/buildbot/bin/python'} 07:45:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:45:00 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)) 07:45:00 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)) 07:45:00 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)) 07:45:00 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)) 07:45:00 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)) 07:45:00 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)) 07:45:00 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)) 07:45:00 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)) 07:45:00 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)) 07:45:00 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)) 07:45:00 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)) 07:45:00 INFO - Cleaning up... 07:45:00 INFO - Return code: 0 07:45:00 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:45:00 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')]} 07:45:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:45:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:45:00 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')]} 07:45:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:45:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:45:00 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 0x7ff7176fdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x210d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21daca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21d7f60>, '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 0x21d8d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21d91d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1477838660.893373-1808162773', '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 07:45:00 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 07:45:00 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 07:45:00 INFO - Using env: {'DISPLAY': ':0', 07:45:00 INFO - 'HOME': '/home/cltbld', 07:45:00 INFO - 'LANG': 'en_US.UTF-8', 07:45:00 INFO - 'LANGUAGE': 'en_US:en', 07:45:00 INFO - 'LOGNAME': 'cltbld', 07:45:00 INFO - 'MAIL': '/var/mail/cltbld', 07:45:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:45:00 INFO - 'MOZ_NO_REMOTE': '1', 07:45:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:45:00 INFO - 'NO_EM_RESTART': '1', 07:45:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:45:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:45:00 INFO - 'PWD': '/builds/slave/test', 07:45:00 INFO - 'SHELL': '/bin/bash', 07:45:00 INFO - 'SHLVL': '1', 07:45:00 INFO - 'TERM': 'linux', 07:45:00 INFO - 'TMOUT': '86400', 07:45:00 INFO - 'USER': 'cltbld', 07:45:00 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1477838660.893373-1808162773', 07:45:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:45:00 INFO - '_': '/tools/buildbot/bin/python'} 07:45:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:45:00 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:45:00 INFO - Cleaning up... 07:45:00 INFO - Return code: 0 07:45:00 INFO - Running post-action listener: _resource_record_post_action 07:45:00 INFO - Running post-action listener: _start_resource_monitoring 07:45:00 INFO - Starting resource monitoring. 07:45:00 INFO - [mozharness: 2016-10-30 14:45:00.335441Z] Finished create-virtualenv step (success) 07:45:00 INFO - [mozharness: 2016-10-30 14:45:00.335944Z] Running install step. 07:45:00 INFO - Running pre-action listener: _resource_record_pre_action 07:45:00 INFO - Running main action method: install 07:45:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:45:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:45:00 INFO - Reading from file tmpfile_stdout 07:45:00 INFO - Detecting whether we're running mozinstall >=1.0... 07:45:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:45:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:45:00 INFO - Reading from file tmpfile_stdout 07:45:00 INFO - Output received: 07:45:00 INFO - Usage: mozinstall [options] installer 07:45:00 INFO - Options: 07:45:00 INFO - -h, --help show this help message and exit 07:45:00 INFO - -d DEST, --destination=DEST 07:45:00 INFO - Directory to install application into. [default: 07:45:00 INFO - "/builds/slave/test"] 07:45:00 INFO - --app=APP Application being installed. [default: firefox] 07:45:00 INFO - mkdir: /builds/slave/test/build/application 07:45:00 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'] 07:45:00 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 07:45:16 INFO - Reading from file tmpfile_stdout 07:45:16 INFO - Output received: 07:45:16 INFO - /builds/slave/test/build/application/firefox/firefox 07:45:16 INFO - Running post-action listener: _resource_record_post_action 07:45:16 INFO - [mozharness: 2016-10-30 14:45:16.738727Z] Finished install step (success) 07:45:16 INFO - [mozharness: 2016-10-30 14:45:16.738971Z] Running run-tests step. 07:45:16 INFO - Running pre-action listener: _resource_record_pre_action 07:45:16 INFO - Running main action method: run_tests 07:45:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:45:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:45:16 INFO - Python 2.7.3 07:45:16 INFO - Return code: 0 07:45:16 INFO - grabbing minidump binary from tooltool 07:45:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:45:16 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 0x21d7f60>, '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 0x21d8d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21d91d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:45:16 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 07:45:16 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 07:45:16 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 07:45:16 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:45:16 INFO - Return code: 0 07:45:16 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:45:16 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:45:16 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:45:16 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:45:16 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:45:16 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/Y2r8ZAIBSEKUNiMHtiOQaQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 07:45:16 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/Y2r8ZAIBSEKUNiMHtiOQaQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-064 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 07:45:16 INFO - Using env: {'DISPLAY': ':0', 07:45:16 INFO - 'HOME': '/home/cltbld', 07:45:16 INFO - 'LANG': 'en_US.UTF-8', 07:45:16 INFO - 'LANGUAGE': 'en_US:en', 07:45:16 INFO - 'LOGNAME': 'cltbld', 07:45:16 INFO - 'MAIL': '/var/mail/cltbld', 07:45:16 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:45:16 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:45:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:45:16 INFO - 'MOZ_NO_REMOTE': '1', 07:45:16 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:45:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:45:16 INFO - 'NO_EM_RESTART': '1', 07:45:16 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:45:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:45:16 INFO - 'PWD': '/builds/slave/test', 07:45:16 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:45:16 INFO - 'SHELL': '/bin/bash', 07:45:16 INFO - 'SHLVL': '1', 07:45:16 INFO - 'TERM': 'linux', 07:45:16 INFO - 'TMOUT': '86400', 07:45:16 INFO - 'USER': 'cltbld', 07:45:16 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1477838660.893373-1808162773', 07:45:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:45:16 INFO - '_': '/tools/buildbot/bin/python'} 07:45:16 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/Y2r8ZAIBSEKUNiMHtiOQaQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 07:45:17 INFO - mozversion application_buildid: 20161030060922 07:45:17 INFO - mozversion application_changeset: f4f6435ed714df693381b80184f26f297ec1a461 07:45:17 INFO - mozversion application_display_name: Nightly 07:45:17 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:45:17 INFO - mozversion application_name: Firefox 07:45:17 INFO - mozversion application_remotingname: firefox 07:45:17 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 07:45:17 INFO - mozversion application_vendor: Mozilla 07:45:17 INFO - mozversion application_version: 52.0a1 07:45:17 INFO - mozversion platform_buildid: 20161030060922 07:45:17 INFO - mozversion platform_changeset: f4f6435ed714df693381b80184f26f297ec1a461 07:45:17 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 07:45:17 INFO - mozversion platform_version: 52.0a1 07:45:17 INFO - using testdate: 1477838717 07:45:17 INFO - actual date: 1477838717 07:45:17 INFO - starting webserver on 'localhost:53794' 07:45:17 INFO - SUITE-START | Running 2 tests 07:45:17 INFO - TEST-START | dromaeo_css 07:45:17 INFO - operating with platform_type : linux_ 07:45:17 INFO - Initialising browser for dromaeo_css test... 07:45:17 INFO - TEST-INFO | started process 13238 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpm_yCfV/profile http://localhost:53794/getInfo.html) 07:45:21 INFO - PROCESS | 13238 | __metrics Screen width/height:1600/1200 07:45:21 INFO - PROCESS | 13238 | colorDepth:24 07:45:21 INFO - PROCESS | 13238 | Browser inner width/height: 1024/697 07:45:21 INFO - PROCESS | 13238 | __metrics 07:45:22 INFO - PROCESS | 13238 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 07:45:22 INFO - PROCESS | 13238 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 205: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:45:23 INFO - PROCESS | 13238 | console.error: PushService: 07:45:23 INFO - PROCESS | 13238 | stateChangeProcessEnqueue: Error transitioning state 07:45:23 INFO - PROCESS | 13238 | UnknownError 07:45:23 INFO - TEST-INFO | 13238: exit 0 07:45:23 INFO - Browser initialized. 07:45:23 INFO - Running cycle 1/1 for dromaeo_css test... 07:45:23 INFO - TEST-INFO | started process 13323 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpm_yCfV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:45:36 INFO - PROCESS | 13323 | RSS: Main: 175607808 07:45:36 INFO - PROCESS | 13323 | 07:46:27 INFO - PROCESS | 13323 | 1477838787514 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] 07:48:39 INFO - PROCESS | 13323 | Cycle 1(1): loaded http://localhost:53794/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53794/tests/dromaeo/cssquery-ext.html) 07:48:43 INFO - PROCESS | 13323 | RSS: Main: 448688128 07:48:43 INFO - PROCESS | 13323 | 07:51:46 INFO - PROCESS | 13323 | Cycle 1(1): loaded http://localhost:53794/tests/dromaeo/cssquery-ext.html (next: http://localhost:53794/tests/dromaeo/cssquery-jquery.html) 07:51:46 INFO - PROCESS | 13323 | RSS: Main: 287551488 07:51:46 INFO - PROCESS | 13323 | 07:54:48 INFO - PROCESS | 13323 | Cycle 1(1): loaded http://localhost:53794/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53794/tests/dromaeo/cssquery-mootools.html) 07:54:49 INFO - PROCESS | 13323 | RSS: Main: 243052544 07:54:49 INFO - PROCESS | 13323 | 07:57:51 INFO - PROCESS | 13323 | Cycle 1(1): loaded http://localhost:53794/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53794/tests/dromaeo/cssquery-prototype.html) 07:57:52 INFO - PROCESS | 13323 | RSS: Main: 222412800 07:57:52 INFO - PROCESS | 13323 | 08:00:55 INFO - PROCESS | 13323 | Cycle 1(1): loaded http://localhost:53794/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53794/tests/dromaeo/cssquery-yui.html) 08:00:56 INFO - PROCESS | 13323 | RSS: Main: 218898432 08:00:56 INFO - PROCESS | 13323 | 08:03:58 INFO - PROCESS | 13323 | Cycle 1(1): loaded http://localhost:53794/tests/dromaeo/cssquery-yui.html (next: http://localhost:53794/tests/dromaeo/cssquery-dojo.html) 08:03:59 INFO - PROCESS | 13323 | RSS: Main: 311107584 08:03:59 INFO - PROCESS | 13323 | 08:03:59 INFO - PROCESS | 13323 | __start_tp_report 08:03:59 INFO - PROCESS | 13323 | _x_x_mozilla_page_load 08:03:59 INFO - PROCESS | 13323 | _x_x_mozilla_page_load_details 08:03:59 INFO - PROCESS | 13323 | |i|pagename|runs| 08:03:59 INFO - PROCESS | 13323 | |0;dojo.html;2486.191987604029;2502.7497250274987;2529.1021687301013;2539.1113110411357;2550.566403711368;4471.619912307454;4480.932786008212;4491.034427598066;4500.639948804096;4533.523979982104;4577.748223847695;4592.334111553822;4596.0578081493295;4603.079384123181;4604.378408914796;4193.350030745231;4210.094829611633;4224.197402493532;4275.572442755731;4299.91400171998;4177.979110104445;4202.096549241913;4221.472315960505;4222.746635201883;4227.365895115727;4197.4753155855515;4218.409422680827;4245.617894389505;4255.765932873691;4286.057067445157;4260.595243451867;4287.871363859089;4293.377460268243;4294.720843145185;4314.050908800059;4105.774182419966;4139.710220284582;4155.8753237402925;4180.811863466151;4272.636825869805;4594.035252596958;4602.792874320664;4607.838725644619;4620.838270660511;4675.859724208279;4877.3903262092235;4880.682755620909;4906.484819093979;4927.457979622239;4964.702117872939;4783.425988881322;4837.346958160639;4928.1129396708575;4960.975195124001;5014.949850501521;4630.259158534618;4668.883277918011;4671.392718946515;4707.882302942454;4722.173619616553;5114.897702045938;5116.897662046738;5117.181250999822;5119.769610367543;5171.63798534099;4711.764411779466;4775.355327030876;4898.314236006961;4906.31311616374;4969.055879382906;4884.877878053006;4926.556609905126;4944.085344211332;4966.553010229097;5032.521910418504;4900.387451568554;4920.72935988524;4923.630727695366;4924.852254432372;4983.6760610560195;4710.858674239778;4884.877878053077;4898.681585696918;4903.190973489405;4963.280324353021;4063.126427817974;4081.1225586499045;4088.141490287073;4102.466679331667;4134.193832202752;3607.314610224049;3618.457231415309;3647.4164133739005;3653.0867283179205;3661.7436779425184;4154.667626589866;4161.2301724181125;4162.62536371728;4173.436586060903;4190.979045104816;4634.768261586907;4727.976360118246;4738.715677059387;4798.760061996886;4808.134535783593;4092.877213683594;4097.549269580344;4109.958900411018;4112.732672376345;4116.526599441103;4291.334843099325;4299.226139294894;4300.1399720056115;4303.139372125587;4304.655627549789;4462.709923855004;4473.642108631237;4476.9104617906805;4479.776011199492;4485.349624304523;4786.712797232177;4790.041991601764;4791.712497250176;4793.520647935318;4794.664373493962;4506.0987802440295;4509.3686883835635;4515.051839113823;4529.184746745485;4530.977345113253;4817.614590832655;4849.709017458964;4852.369192005017;4901.975490122527;4906.63200259989;4904.779284932258;4919.409670839522;4928.8767780805765;4935;4995.300657907823;4597.908041839078;4644.60520855731;4806.2310030394965;4813.95186048135;4878.048780487771;4684.695494792828;4694.906101878011;4697.765111744331;4698.083873644743;4702.15361234981;4606.769661516843;4614.423197100363;4621.699589526805;4626.8149274028665;4629.976850115728;4717.103750287434;4727.527247275245;4734.4081989751285;4743.051389722001;4746.78639461232;4651.697639653412;4663.137319595886;4664.696794708333;4664.720116793003;4665.4168228971375 08:03:59 INFO - PROCESS | 13323 | |1;ext.html;547.1164070026905;547.9424660410657;554.3541773833483;561.4778256221712;562.1006389776355;27831.582526262097;38267;39778;39929;43053.56946430535;39518;39905.40141897874;39998.20003599926;40000.79999599998;40023.59976400235;7206.17129030163;7568.167501574822;7697.114831794332;7723.72966946157;7726.652300646456;7445.106587209515;7533.54798712079;7544.849103017937;7545.471816972814;9872.111509964101;9548.045195480467;9861.11249987501;9866.062724041205;9879;9880.604775808959;10004.299699021072;10050.849237261375;10053.095221430034;10066.899331006669;10071.34536255141;9681.515924203832;9683.564239609235;9732.2214222862;9738.756531086708;9748.95125524375;36976.630233697586;37326.813365933;37334;37397.43903841444;37406.43890341647;2941.0735618280387;3044.9342730044527;3059.6175478065243;3282.2286762610765;3295.555100061485;27413.31466713348;27725.722742772516;27858.3035424114;28482.145535633757;29547;2941.0735618280387;2968.525035994252;3462.0998540379683;3479.0042095950816;3601.693856022215;243420;243608;245143;245235;245878.99999999822;32319.838400808316;51201.74399127981;51726.741366292925;51806.22290665643;51856.740716296175;32773;32927.176820579196;32996.67003329984;33018.17454563655;33032.174195644824;12821.423035963404;12868.678283042998;12929.418176182095;12929.870701293055;12930.935345323402;10590.682279531626;10640.946795265974;10652.786944261072;10667.466626668636;10671.092957098734;7198.316159964795;7390.7413240536325;7473.140588832245;7795.415343849234;7800.726974555863;3050.7491928309287;3063.081075677288;3078.569000339954;3081.3683194944983;3125.0624812556143;791.3945831438954;844.7676888855491;855.4482358878488;876.9780755481164;888.2494292322976;24536.877315613307;26018.479630407284;26601.46797064048;27062.729372706413;27077.458450830873;888.5868071346855;919.793046564531;933.5985526223789;936.6581197862868;947.7346343023964;13364.131331463424;13855.792163117561;14042.508512202025;14051.156930584199;14385.568432946819;351243;353281;354459;355596;410567;42010.78994605008;45746.680531114864;47325.29012064822;47381.76309118432;53363;1142.7485953090306;1175.7178277213407;1198.077086276531;1200.7898617742035;1203.7953547896702;26933.326666833487;27714.307142321602;27976.440471190053;28044.43911121807;28925;41071;41556.58443415527;41573.168536628495;41595.37606935959;41610.167796644506;313982;314891;315833;316217;316507;24303;24735.50528989446;24800.627990580517;24817.62773558362;24822;39950;40576.59423405728;40576.79711601423;41296.1740765189;42275.7886210567;34521.30957380889;34630.82684586561;34894.30211395707;35047.12382190466;35281.29437411186;33599.328013440085;33603.66396336005;34091.31817363589;34141.317173655894;34266.82866585651;34132.488012680325;34309.65690343164;34486.655133448345;34628.826855866566;35422.64577354193;28580.285492862844;31408.52887206648;31516.842415787774;31568.210794729395;31718;23911.52176956486;23994.40013999664;24661.50676986486;25230.116945906804;25445.745542544337 08:03:59 INFO - PROCESS | 13323 | |2;jquery.html;322.4051624752331;339.7214284286884;339.7265201512783;344.81552369482324;364.54431960049936;12485.812712809304;13513.05408621397;15833.524994250176;16834.326626934908;17819.64360712785;15712.921435392807;15989.92005039976;16091.034537927733;16110.838891611109;16484.67030659386;4092.3656833190753;4903.19097348937;4922.040202160571;5170.612204084689;5172.146595811687;4771.618270538349;5186.844394668166;5188.740562971855;5190.532852043315;5190.584753219733;4899.706017638935;5148.588112950955;5159.071367153911;5163.406208286039;5193.740312984354;5045.697258164503;5118.769655365518;5121.974390128063;5122.410922743895;5127.461616530267;4330.588594083557;4542.6138778203895;4546.204414227497;4552.590266875997;4553.408056952608;20344.287949921683;20579.588408231903;20632.58734825295;20682.379528614165;20684;1743.8779285450023;1750.6673731990882;1757.2443849144863;2189.8248140148908;2363.066588697455;12077.637670869888;13034.283114428703;13434.126781759252;13610.727785444236;13647.86352136476;1542.2288855572215;1627.5768300241905;1659.6514731906314;1740.1647209339587;1860.897650629215;64933;67280.32719672838;67612;68686.65656671734;69069.65465172642;9324.160825525736;9376.515223465787;9473.431594104239;9526.666566670272;9765.218782497383;12870.742585148431;12928.612141635766;12928.676783080498;12941.676458088623;12984;6527.629197868501;6703.798886033427;6857.074294970215;6889.621070841052;6890.899095406987;6397.584157029778;6519.543631945813;6593.439557637558;6626.9337306627285;6701.497387695942;3834.5206849143856;3859;3889.416587511896;3970.967548437427;4009.3384591542067;1622.5619082847566;1659.1289572974285;1689.2651696512057;1692.5091723400076;1704.4971733338696;827.2967977219315;875.4790899414838;878.9604467798964;884.3544212724747;907.6188001039579;16278.67442651164;16417.1791410429;16557.58606034859;16706.4152754653;16982.660346792996;819.9262066414051;833.3791325462569;841.1168273312996;850.953197574127;903.3089686389917;8758.525921299188;9103;9284.62861485533;9348.672796452092;9464.432134071978;349048;351880.8119188112;356049;359624;361595;72738.63630681812;73657;74285.62857185787;74295.62852185704;79148.6042569795;898.1647068226612;900.7162743735702;908.9000209976897;912.1790388650268;917.6696389299847;14301.213433261271;14673.413063477341;14725.779113313523;14989.367660835867;15012.774808377664;34211.82894085613;34607.30785384228;35130.64869351274;35368.46947295741;35624.46563301501;46661.766691167686;47350.763246183546;47520;47665.28502072541;49183;6623.437007854386;6880.759173429106;6990.196127445409;7002.1947476040905;7004.264552221944;9864.408135511892;10431.217658675781;10537.42044187577;10566.841497377392;10820.67537973862;8841.336899732674;9015.594298256463;9127.77180570491;9137.086291371075;9228;9121.726348209564;9198.988111307885;9258.675946341846;9287.349885507949;9399.34204605671;8927.151920567536;9397.389169703947;9451.291153163678;9489.620415183315;9657.951710241405;6993.265707100884;7062.858742825012;7174.246704095995;7185;7243.0946131733535;7654.655540500802;9012.594433250651;9193.310501712265;9417.48203848795;9761.56072976732 08:03:59 INFO - PROCESS | 13323 | |3;mootools.html;1203.127732394014;1341.1550723044484;1349.3253373313341;1440.3734375546637;1651.9917400413003;5809.477147056764;6172.105044768506;6421.13314702515;6643.933560664392;6651.434628056609;6764.526483146182;6831.385175334219;6840.315968403157;6870.690818913148;6908.067410899527;2033.9491512712189;2046.1406209392092;2058.3310424112146;2060.1450398084776;2061.8453615978788;2033.176563491788;2068.5552606189667;2073.139647046474;2088.58228354329;2088.885111318877;2031.7257170282044;2056.7634722006937;2084.6768750843644;2086.7078608994752;2089.8328133749264;1957.7748558915764;1959.6472634925708;1983.5437849294742;1983.980160198394;1984.861059725827;1960.2746983616012;1980.7028945658124;2021.1006102284489;2021.6462119129094;2027.543802644408;6574.539782215247;6684.665766711693;6709.5303328767;6730.663466826639;6730.697118629673;3902.746321489094;4073.124278280184;4076.8776936691947;4129.525104612948;4137.751734895915;2527.1786669332355;2713.7014928357867;2763.198672385006;2763.4196818668106;2765.6542932133484;789.5302295134443;795.5783434779576;800.3317230112863;804.1275216390223;826.396730386815;8308.792280192984;8420.368472364537;8442;8460.915390846136;8462.280706139985;3437.123533498942;3551.538300020981;3584.7811744007163;3592.2276710507367;3597.892063238107;6974.860502789916;6985.476089293222;6989.580625162506;6996.615186164708;6998.405135563432;4065.10567675111;4066.6340029397497;4069.267531844237;4069.9389509157386;4071.328230841937;3303.289792694582;3413.2661477782394;3624.818759062089;3777.1879046005242;3863;3052.0538633023834;3072.078376487045;3100.8449577521033;3120.6255249369765;3131.060681795452;911.6216770040492;916.0701887584107;918.6187732091241;933.290699068699;941.2846236859899;707.6391040569347;784.1335324466496;789.8775689768095;807.8909347238048;811.8701007838717;4656.674032817738;4664.55686709762;4674.275487299474;4722.834700785456;4849.127157111683;379.71900793413226;389.90447340401784;395.8594698881856;399.0522509041028;402.5089390943045;3115.049909777494;3152.0543836848856;3170.5719727836445;3192;3202.5356323333453;7424.517406368569;7822.882656760153;7823.804404889924;7843.6470358833985;7844.058712954482;7782.066152061676;7787.883181752279;7794.2985131338455;7851.568163751049;7874.133845277015;6222.844428889314;6288.968555157195;6302.212223472066;6305.779297724557;6306.243250809932;4436.467623885154;4442.444694413199;4506.526814684411;4520.118576877478;4594.793234304398;7170.42636589082;7194.208637050025;7209.170945341143;7229.855402892018;7234.493585449179;7309.780706578811;7333.230010848784;7407.851842963219;7418.480706350504;7450.776476705708;5282.735863206901;5391.245225668488;5395.325584301962;5403.486668766461;5407.918881216863;5484.506394424521;5692.231548741032;6109.175261339662;6382.936170638234;6394.680265986775;5820.359760426434;5834.658028653349;5896.64620122794;5930.673812940329;5932.5550583705535;5802.854928626818;5850.473457388855;5878.059510478303;5907.172995780508;5991.460768530853;5298.761555730079;5321.3880403754065;5381.192821076713;5505.614606977473;5557.972210138923;4171.416001759817;4202.873913782591;4222.493300803923;4300.827966881289;4402.207602631557;4066.755994640331;4114.567970363189;4202.705810593229;4223.113146239324;4319.697621166488 08:03:59 INFO - PROCESS | 13323 | |4;prototype.html;282.55779704762045;289.78845442826736;291.7767907550724;291.8526144297129;293.97942144049927;4668.883277918049;4724.338592597039;4743.90512189756;4756.143894099061;4761.904761904764;4673.644643053519;4684.695494792836;4689;4706.69406488578;4708.811647534095;3480.1647604574973;3591.6767490925813;3592.119930616989;3730.6082861299647;3739.551253849542;3576.284743051387;3606.4049431843714;3612.4581312803157;3694.685951694109;3704.2219734527444;3663.3955397359405;3672.559292884844;3681.687056600192;3684.336819372512;3686.8156592170417;3663;3680.2271522980204;3682.2451397463587;3685.4656074869126;3693.981530092359;3166.8099914005234;3216.6140063192333;3231.111444352798;3251.64231934487;3261.8369081546066;4601.539846015372;4620.214563524209;4622.86131416058;4628.935344870699;4630.143423466636;4208.85269015583;4210.32634778434;4214.325707886754;4221.345691417804;4224.598663126998;4763.832051685625;4880.707157570557;4881.438634557036;4892.535209155125;4943;3522.5068490411363;3524.6958625308544;3529.858805647771;3531.788092714445;3536.398812201932;5137.865901799899;5139.974300128512;5145;5148.768305426227;5183.403908550527;3633.6548027937833;3637.3998290281806;3648.8175591220333;3649.525561676965;3656.4698118773163;3541.486484459739;3682.760620559655;3694.685951694082;3700.796456194881;3720.795356255378;4197.97901010493;4200.886765007275;4203.70574059819;4211.894702632398;4213.852515161954;4923.803047878117;4926.926096108561;4934.55588996992;4956.107900577858;4962.057209130254;1241.3296819717252;1269.7904845700357;1279.9888088410237;1285.7878450055823;1291.9793363242932;803.7066470738256;817.4032955942076;819.9709364747204;821.7863355527605;827.230675471817;3883.708721845873;3908.2769687607883;3908.4723562318723;4180.829367777027;4300.61294483498;4958.925616115761;5077.9238311424615;5110.4123025852505;5115.437301896788;5122.462141475166;4342.71889792512;4365.301551751704;4374.168907907488;4374.715643483163;4377.4678862397905;2596.883140258693;2696.474187533412;2698.7060998151806;2713.199606116161;2721.102036328007;4789.880252993703;4797.232442809134;4825.1555977703765;4825.1555977703765;4827.155247831615;5163.432022477525;5177.559907407837;5198.16829307309;5272.868178295574;5279.736013199325;4603.148417542765;4739.715617062987;4767.380240568704;4772.475027746945;4773.973595676876;5110.744462776772;5119;5120.02719483297;5126.026055049529;5134.512221338967;5001.374828146481;5005.5745261653165;5023;5025.864007796745;5076.543111120017;4611;4744.810207591658;4750.691205071659;4751.812046988253;4793.23308270675;3624.9487648581617;3661.2860492203763;3670.6879915207505;3685.299793039314;3712.276106159273;5133.10170720115;5148.43367229612;5149.150390185728;5149.845504634867;5151.665141765773;4869.415670119608;4908.386451693538;4935.136351138464;4979.925301120414;4996.200607902718;4855.878603034952;4890.828820991248;4904.681195722266;4912.606991440748;4941.5058494151735;4836.903261934812;4859.781309840995;4861.149298872754;4876.5854902333695;4890.462049174659;4836.758162091811;4928.314068832567;4945.703257804544;4969.254611808257;4991.6006719463085;4665.6734028617675;4786.664933454625;4795.160846851857;4796.865394899236;4800.303766100154 08:03:59 INFO - PROCESS | 13323 | |5;yui.html;626.8401557602812;678.9728410863565;684.8972654101885;705.7917914215305;749.7788152495013;10823.891761082386;11596.652100437;11618.477168527426;11629.883701162986;11645.18483706141;10936.890631093687;11426.885731142685;11524.769504609903;11690.883091169086;11697.473613687383;789.2107892107892;810.2748040503745;811.0227176252602;811.2495941254346;811.4441607498882;804.3685706720225;808.4825711544617;808.5270116981543;809.3080416244114;809.6194788449449;854.7948492361819;856.1994535109661;856.2935578148022;856.8971723393202;857.0829212742368;851.3487182305541;851.4040171879709;851.7657644147847;852.2202185000717;852.2202185000717;612.9732697731326;617.6232498176109;618.483566222205;618.5670030978333;619.2847261413075;10296.742581435448;10416.42709650969;11066.944665276702;11136.777264454746;11164.497597608128;8937.662967379309;9207.079292070806;9222.492762898039;9512.571934262905;9619.038096190396;7789.961050194713;7839.608019599054;7879.290863822226;8270.338372930151;8294.917050829476;2794.329360953377;2807.3964097718886;2809.2555472799722;2829.547272436421;2920.2845302900714;47394.526054739355;47644;47648.28527572089;48185.75907120477;48654.51345486535;6707.195136583544;6798.116244888133;6804.3195680432555;6843.349881761224;6845.623490707959;14436;14439.783403248959;14475.78286325706;14475.78286325706;14533.747269173295;5841.123831425235;5889.352171261158;6003.759849605967;6006.249218847644;6069.393060693984;2900.3329234276234;3098.550710147016;3162.22525481254;3246.935061298761;3285.4743241081314;2576.549103906809;2664.0942079692995;2674.6389237453086;2681.0616284300727;2681.209043332222;418.89318223852723;437.1344737419926;438.9495208051115;444.9510553839075;456.3178048816973;475.3036801086356;522.9790808367623;523.588982648619;534.2040359863774;542.481929757081;7176.425885929113;7397.334239918433;7551.660175292125;7800.609969501502;7821.608919554;480.5962991087503;508.141702921069;538.2545174932668;562.2522045679236;570.5777724483852;3568.928621427557;3635.182084031072;3646.4894914711963;3667.972967569085;3807.5430948286385;68833;69166.65416672984;70091;73602;73665.6316718413;19943.401697948793;20337;31625.683743162735;58289.11080357235;61415.692921536;55166.72416637971;55298;55586.72206638941;55731.72134139304;56494.717526412926;6616.305287944697;6943.236244013256;7208.819779505554;7283.490155689051;7533.171351151478;34040;34590.82704586461;35190.648093518736;35294.64705352914;35830;47846.52153478421;48835;49975.25037124519;51488.742556286976;52217;8484.745457636282;9725.58153423528;9817.950910245403;9899.1585715215;9946.154576861049;11727.706807329885;11803.409829508662;11847;12259.69350766238;12612.621621351374;11316.83024754613;11350.886491134983;11419.543218271509;11765.411729413667;12074.335911524951;10881.238313317992;11409.543618255177;11556.248843825124;11613.941930290632;11635.301881886775;10702.571897124028;10840.566377344818;11200.83198752003;11224.494897729459;11990.400479975791;8950.597223125105;9032.819343613222;9181.908180918106;9511.476868772284;9546.95226523863;9014.459132452073;9200.585973631336;9442.48066356357;9505.714828555154;9701.70894873155 08:03:59 INFO - PROCESS | 13323 | __end_tp_report 08:03:59 INFO - PROCESS | 13323 | __start_cc_report 08:03:59 INFO - PROCESS | 13323 | _x_x_mozilla_cycle_collect,3327 08:03:59 INFO - PROCESS | 13323 | __end_cc_report 08:03:59 INFO - PROCESS | 13323 | __startTimestamp1477839839177__endTimestamp 08:03:59 INFO - PROCESS | 13323 | 08:03:59 INFO - PROCESS | 13323 | ------- Summary: start ------- 08:03:59 INFO - PROCESS | 13323 | Number of tests: 6 08:03:59 INFO - PROCESS | 13323 | 08:03:59 INFO - PROCESS | 13323 | [#0] dojo.html Cycles:165 Average:4506.34 Median:4621.70 stddev:483.02 (10.5%) stddev-sans-first:457.77 08:03:59 INFO - PROCESS | 13323 | Values: 2486.2 2502.7 2529.1 2539.1 2550.6 4471.6 4480.9 4491.0 4500.6 4533.5 4577.7 4592.3 4596.1 4603.1 4604.4 4193.4 4210.1 4224.2 4275.6 4299.9 4178.0 4202.1 4221.5 4222.7 4227.4 4197.5 4218.4 4245.6 4255.8 4286.1 4260.6 4287.9 4293.4 4294.7 4314.1 4105.8 4139.7 4155.9 4180.8 4272.6 4594.0 4602.8 4607.8 4620.8 4675.9 4877.4 4880.7 4906.5 4927.5 4964.7 4783.4 4837.3 4928.1 4961.0 5014.9 4630.3 4668.9 4671.4 4707.9 4722.2 5114.9 5116.9 5117.2 5119.8 5171.6 4711.8 4775.4 4898.3 4906.3 4969.1 4884.9 4926.6 4944.1 4966.6 5032.5 4900.4 4920.7 4923.6 4924.9 4983.7 4710.9 4884.9 4898.7 4903.2 4963.3 4063.1 4081.1 4088.1 4102.5 4134.2 3607.3 3618.5 3647.4 3653.1 3661.7 4154.7 4161.2 4162.6 4173.4 4191.0 4634.8 4728.0 4738.7 4798.8 4808.1 4092.9 4097.5 4110.0 4112.7 4116.5 4291.3 4299.2 4300.1 4303.1 4304.7 4462.7 4473.6 4476.9 4479.8 4485.3 4786.7 4790.0 4791.7 4793.5 4794.7 4506.1 4509.4 4515.1 4529.2 4531.0 4817.6 4849.7 4852.4 4902.0 4906.6 4904.8 4919.4 4928.9 4935.0 4995.3 4597.9 4644.6 4806.2 4814.0 4878.0 4684.7 4694.9 4697.8 4698.1 4702.2 4606.8 4614.4 4621.7 4626.8 4630.0 4717.1 4727.5 4734.4 4743.1 4746.8 4651.7 4663.1 4664.7 4664.7 4665.4 08:03:59 INFO - PROCESS | 13323 | 08:03:59 INFO - PROCESS | 13323 | [#1] ext.html Cycles:180 Average:44991.70 Median:34398.16 stddev:82348.71 (239.4%) stddev-sans-first:82512.11 08:03:59 INFO - PROCESS | 13323 | Values: 547.1 547.9 554.4 561.5 562.1 27831.6 38267.0 39778.0 39929.0 43053.6 39518.0 39905.4 39998.2 40000.8 40023.6 7206.2 7568.2 7697.1 7723.7 7726.7 7445.1 7533.5 7544.8 7545.5 9872.1 9548.0 9861.1 9866.1 9879.0 9880.6 10004.3 10050.8 10053.1 10066.9 10071.3 9681.5 9683.6 9732.2 9738.8 9749.0 36976.6 37326.8 37334.0 37397.4 37406.4 2941.1 3044.9 3059.6 3282.2 3295.6 27413.3 27725.7 27858.3 28482.1 29547.0 2941.1 2968.5 3462.1 3479.0 3601.7 243420.0 243608.0 245143.0 245235.0 245879.0 32319.8 51201.7 51726.7 51806.2 51856.7 32773.0 32927.2 32996.7 33018.2 33032.2 12821.4 12868.7 12929.4 12929.9 12930.9 10590.7 10640.9 10652.8 10667.5 10671.1 7198.3 7390.7 7473.1 7795.4 7800.7 3050.7 3063.1 3078.6 3081.4 3125.1 791.4 844.8 855.4 877.0 888.2 24536.9 26018.5 26601.5 27062.7 27077.5 888.6 919.8 933.6 936.7 947.7 13364.1 13855.8 14042.5 14051.2 14385.6 351243.0 353281.0 354459.0 355596.0 410567.0 42010.8 45746.7 47325.3 47381.8 53363.0 1142.7 1175.7 1198.1 1200.8 1203.8 26933.3 27714.3 27976.4 28044.4 28925.0 41071.0 41556.6 41573.2 41595.4 41610.2 313982.0 314891.0 315833.0 316217.0 316507.0 24303.0 24735.5 24800.6 24817.6 24822.0 39950.0 40576.6 40576.8 41296.2 42275.8 34521.3 34630.8 34894.3 35047.1 35281.3 33599.3 33603.7 34091.3 34141.3 34266.8 34132.5 34309.7 34486.7 34628.8 35422.6 28580.3 31408.5 31516.8 31568.2 31718.0 23911.5 23994.4 24661.5 25230.1 25445.7 08:03:59 INFO - PROCESS | 13323 | 08:03:59 INFO - PROCESS | 13323 | [#2] jquery.html Cycles:180 Average:22781.52 Median:5120.37 stddev:58898.70 (1150.3%) stddev-sans-first:59039.78 08:03:59 INFO - PROCESS | 13323 | Values: 322.4 339.7 339.7 344.8 364.5 12485.8 13513.1 15833.5 16834.3 17819.6 15712.9 15989.9 16091.0 16110.8 16484.7 4092.4 4903.2 4922.0 5170.6 5172.1 4771.6 5186.8 5188.7 5190.5 5190.6 4899.7 5148.6 5159.1 5163.4 5193.7 5045.7 5118.8 5122.0 5122.4 5127.5 4330.6 4542.6 4546.2 4552.6 4553.4 20344.3 20579.6 20632.6 20682.4 20684.0 1743.9 1750.7 1757.2 2189.8 2363.1 12077.6 13034.3 13434.1 13610.7 13647.9 1542.2 1627.6 1659.7 1740.2 1860.9 64933.0 67280.3 67612.0 68686.7 69069.7 9324.2 9376.5 9473.4 9526.7 9765.2 12870.7 12928.6 12928.7 12941.7 12984.0 6527.6 6703.8 6857.1 6889.6 6890.9 6397.6 6519.5 6593.4 6626.9 6701.5 3834.5 3859.0 3889.4 3971.0 4009.3 1622.6 1659.1 1689.3 1692.5 1704.5 827.3 875.5 879.0 884.4 907.6 16278.7 16417.2 16557.6 16706.4 16982.7 819.9 833.4 841.1 851.0 903.3 8758.5 9103.0 9284.6 9348.7 9464.4 349048.0 351880.8 356049.0 359624.0 361595.0 72738.6 73657.0 74285.6 74295.6 79148.6 898.2 900.7 908.9 912.2 917.7 14301.2 14673.4 14725.8 14989.4 15012.8 34211.8 34607.3 35130.6 35368.5 35624.5 46661.8 47350.8 47520.0 47665.3 49183.0 6623.4 6880.8 6990.2 7002.2 7004.3 9864.4 10431.2 10537.4 10566.8 10820.7 8841.3 9015.6 9127.8 9137.1 9228.0 9121.7 9199.0 9258.7 9287.3 9399.3 8927.2 9397.4 9451.3 9489.6 9658.0 6993.3 7062.9 7174.2 7185.0 7243.1 7654.7 9012.6 9193.3 9417.5 9761.6 08:03:59 INFO - PROCESS | 13323 | 08:03:59 INFO - PROCESS | 13323 | [#3] mootools.html Cycles:180 Average:4351.94 Median:5290.75 stddev:2300.29 (43.5%) stddev-sans-first:2294.57 08:03:59 INFO - PROCESS | 13323 | Values: 1203.1 1341.2 1349.3 1440.4 1652.0 5809.5 6172.1 6421.1 6643.9 6651.4 6764.5 6831.4 6840.3 6870.7 6908.1 2033.9 2046.1 2058.3 2060.1 2061.8 2033.2 2068.6 2073.1 2088.6 2088.9 2031.7 2056.8 2084.7 2086.7 2089.8 1957.8 1959.6 1983.5 1984.0 1984.9 1960.3 1980.7 2021.1 2021.6 2027.5 6574.5 6684.7 6709.5 6730.7 6730.7 3902.7 4073.1 4076.9 4129.5 4137.8 2527.2 2713.7 2763.2 2763.4 2765.7 789.5 795.6 800.3 804.1 826.4 8308.8 8420.4 8442.0 8460.9 8462.3 3437.1 3551.5 3584.8 3592.2 3597.9 6974.9 6985.5 6989.6 6996.6 6998.4 4065.1 4066.6 4069.3 4069.9 4071.3 3303.3 3413.3 3624.8 3777.2 3863.0 3052.1 3072.1 3100.8 3120.6 3131.1 911.6 916.1 918.6 933.3 941.3 707.6 784.1 789.9 807.9 811.9 4656.7 4664.6 4674.3 4722.8 4849.1 379.7 389.9 395.9 399.1 402.5 3115.0 3152.1 3170.6 3192.0 3202.5 7424.5 7822.9 7823.8 7843.6 7844.1 7782.1 7787.9 7794.3 7851.6 7874.1 6222.8 6289.0 6302.2 6305.8 6306.2 4436.5 4442.4 4506.5 4520.1 4594.8 7170.4 7194.2 7209.2 7229.9 7234.5 7309.8 7333.2 7407.9 7418.5 7450.8 5282.7 5391.2 5395.3 5403.5 5407.9 5484.5 5692.2 6109.2 6382.9 6394.7 5820.4 5834.7 5896.6 5930.7 5932.6 5802.9 5850.5 5878.1 5907.2 5991.5 5298.8 5321.4 5381.2 5505.6 5558.0 4171.4 4202.9 4222.5 4300.8 4402.2 4066.8 4114.6 4202.7 4223.1 4319.7 08:03:59 INFO - PROCESS | 13323 | 08:03:59 INFO - PROCESS | 13323 | [#4] prototype.html Cycles:180 Average:4098.21 Median:4686.85 stddev:1192.66 (25.4%) stddev-sans-first:1161.11 08:03:59 INFO - PROCESS | 13323 | Values: 282.6 289.8 291.8 291.9 294.0 4668.9 4724.3 4743.9 4756.1 4761.9 4673.6 4684.7 4689.0 4706.7 4708.8 3480.2 3591.7 3592.1 3730.6 3739.6 3576.3 3606.4 3612.5 3694.7 3704.2 3663.4 3672.6 3681.7 3684.3 3686.8 3663.0 3680.2 3682.2 3685.5 3694.0 3166.8 3216.6 3231.1 3251.6 3261.8 4601.5 4620.2 4622.9 4628.9 4630.1 4208.9 4210.3 4214.3 4221.3 4224.6 4763.8 4880.7 4881.4 4892.5 4943.0 3522.5 3524.7 3529.9 3531.8 3536.4 5137.9 5140.0 5145.0 5148.8 5183.4 3633.7 3637.4 3648.8 3649.5 3656.5 3541.5 3682.8 3694.7 3700.8 3720.8 4198.0 4200.9 4203.7 4211.9 4213.9 4923.8 4926.9 4934.6 4956.1 4962.1 1241.3 1269.8 1280.0 1285.8 1292.0 803.7 817.4 820.0 821.8 827.2 3883.7 3908.3 3908.5 4180.8 4300.6 4958.9 5077.9 5110.4 5115.4 5122.5 4342.7 4365.3 4374.2 4374.7 4377.5 2596.9 2696.5 2698.7 2713.2 2721.1 4789.9 4797.2 4825.2 4825.2 4827.2 5163.4 5177.6 5198.2 5272.9 5279.7 4603.1 4739.7 4767.4 4772.5 4774.0 5110.7 5119.0 5120.0 5126.0 5134.5 5001.4 5005.6 5023.0 5025.9 5076.5 4611.0 4744.8 4750.7 4751.8 4793.2 3624.9 3661.3 3670.7 3685.3 3712.3 5133.1 5148.4 5149.2 5149.8 5151.7 4869.4 4908.4 4935.1 4979.9 4996.2 4855.9 4890.8 4904.7 4912.6 4941.5 4836.9 4859.8 4861.1 4876.6 4890.5 4836.8 4928.3 4945.7 4969.3 4991.6 4665.7 4786.7 4795.2 4796.9 4800.3 08:03:59 INFO - PROCESS | 13323 | 08:03:59 INFO - PROCESS | 13323 | [#5] yui.html Cycles:180 Average:13439.36 Median:27854.60 stddev:17727.51 (63.6%) stddev-sans-first:17751.14 08:03:59 INFO - PROCESS | 13323 | Values: 626.8 679.0 684.9 705.8 749.8 10823.9 11596.7 11618.5 11629.9 11645.2 10936.9 11426.9 11524.8 11690.9 11697.5 789.2 810.3 811.0 811.2 811.4 804.4 808.5 808.5 809.3 809.6 854.8 856.2 856.3 856.9 857.1 851.3 851.4 851.8 852.2 852.2 613.0 617.6 618.5 618.6 619.3 10296.7 10416.4 11066.9 11136.8 11164.5 8937.7 9207.1 9222.5 9512.6 9619.0 7790.0 7839.6 7879.3 8270.3 8294.9 2794.3 2807.4 2809.3 2829.5 2920.3 47394.5 47644.0 47648.3 48185.8 48654.5 6707.2 6798.1 6804.3 6843.3 6845.6 14436.0 14439.8 14475.8 14475.8 14533.7 5841.1 5889.4 6003.8 6006.2 6069.4 2900.3 3098.6 3162.2 3246.9 3285.5 2576.5 2664.1 2674.6 2681.1 2681.2 418.9 437.1 438.9 445.0 456.3 475.3 523.0 523.6 534.2 542.5 7176.4 7397.3 7551.7 7800.6 7821.6 480.6 508.1 538.3 562.3 570.6 3568.9 3635.2 3646.5 3668.0 3807.5 68833.0 69166.7 70091.0 73602.0 73665.6 19943.4 20337.0 31625.7 58289.1 61415.7 55166.7 55298.0 55586.7 55731.7 56494.7 6616.3 6943.2 7208.8 7283.5 7533.2 34040.0 34590.8 35190.6 35294.6 35830.0 47846.5 48835.0 49975.3 51488.7 52217.0 8484.7 9725.6 9818.0 9899.2 9946.2 11727.7 11803.4 11847.0 12259.7 12612.6 11316.8 11350.9 11419.5 11765.4 12074.3 10881.2 11409.5 11556.2 11613.9 11635.3 10702.6 10840.6 11200.8 11224.5 11990.4 8950.6 9032.8 9181.9 9511.5 9547.0 9014.5 9200.6 9442.5 9505.7 9701.7 08:03:59 INFO - PROCESS | 13323 | -------- Summary: end -------- 08:03:59 INFO - PROCESS | 13323 | 08:04:00 INFO - TEST-INFO | 13323: exit 0 08:04:00 INFO - TEST-OK | dromaeo_css | took 1123189ms 08:04:00 INFO - TEST-START | kraken 08:04:00 INFO - operating with platform_type : linux_ 08:04:00 INFO - Initialising browser for kraken test... 08:04:00 INFO - TEST-INFO | started process 13625 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTN5REE/profile http://localhost:53794/getInfo.html) 08:04:04 INFO - PROCESS | 13625 | __metrics Screen width/height:1600/1200 08:04:04 INFO - PROCESS | 13625 | colorDepth:24 08:04:04 INFO - PROCESS | 13625 | Browser inner width/height: 1024/697 08:04:04 INFO - PROCESS | 13625 | __metrics 08:04:05 INFO - PROCESS | 13625 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:04:05 INFO - PROCESS | 13625 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 205: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:04:06 INFO - PROCESS | 13625 | console.error: PushService: 08:04:06 INFO - PROCESS | 13625 | stateChangeProcessEnqueue: Error transitioning state 08:04:06 INFO - PROCESS | 13625 | UnknownError 08:04:06 INFO - TEST-INFO | 13625: exit 0 08:04:06 INFO - Browser initialized. 08:04:06 INFO - Running cycle 1/1 for kraken test... 08:04:06 INFO - TEST-INFO | started process 13705 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTN5REE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:04:18 INFO - PROCESS | 13705 | RSS: Main: 176037888 08:04:18 INFO - PROCESS | 13705 | 08:04:21 INFO - PROCESS | 13705 | Cycle 1(1): loaded http://localhost:53794/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53794/tests/kraken/driver.html?testName=audio-beat-detection) 08:04:22 INFO - PROCESS | 13705 | RSS: Main: 232321024 08:04:22 INFO - PROCESS | 13705 | 08:04:25 INFO - PROCESS | 13705 | Cycle 1(1): loaded http://localhost:53794/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53794/tests/kraken/driver.html?testName=audio-dft) 08:04:26 INFO - PROCESS | 13705 | RSS: Main: 219279360 08:04:26 INFO - PROCESS | 13705 | 08:04:29 INFO - PROCESS | 13705 | Cycle 1(1): loaded http://localhost:53794/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53794/tests/kraken/driver.html?testName=audio-fft) 08:04:29 INFO - PROCESS | 13705 | RSS: Main: 301776896 08:04:29 INFO - PROCESS | 13705 | 08:04:32 INFO - PROCESS | 13705 | Cycle 1(1): loaded http://localhost:53794/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53794/tests/kraken/driver.html?testName=audio-oscillator) 08:04:32 INFO - PROCESS | 13705 | RSS: Main: 212205568 08:04:32 INFO - PROCESS | 13705 | 08:04:35 INFO - PROCESS | 13705 | Cycle 1(1): loaded http://localhost:53794/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53794/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:04:35 INFO - PROCESS | 13705 | RSS: Main: 214421504 08:04:35 INFO - PROCESS | 13705 | 08:04:38 INFO - PROCESS | 13705 | Cycle 1(1): loaded http://localhost:53794/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53794/tests/kraken/driver.html?testName=imaging-darkroom) 08:04:39 INFO - PROCESS | 13705 | RSS: Main: 251576320 08:04:39 INFO - PROCESS | 13705 | 08:04:42 INFO - PROCESS | 13705 | Cycle 1(1): loaded http://localhost:53794/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53794/tests/kraken/driver.html?testName=imaging-desaturate) 08:04:43 INFO - PROCESS | 13705 | RSS: Main: 250146816 08:04:43 INFO - PROCESS | 13705 | 08:04:46 INFO - PROCESS | 13705 | Cycle 1(1): loaded http://localhost:53794/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53794/tests/kraken/driver.html?testName=json-parse-financial) 08:04:46 INFO - PROCESS | 13705 | RSS: Main: 250040320 08:04:46 INFO - PROCESS | 13705 | 08:04:48 INFO - PROCESS | 13705 | Cycle 1(1): loaded http://localhost:53794/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53794/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:04:49 INFO - PROCESS | 13705 | RSS: Main: 212295680 08:04:49 INFO - PROCESS | 13705 | 08:04:51 INFO - PROCESS | 13705 | Cycle 1(1): loaded http://localhost:53794/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53794/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:04:51 INFO - PROCESS | 13705 | RSS: Main: 219873280 08:04:51 INFO - PROCESS | 13705 | 08:04:53 INFO - PROCESS | 13705 | Cycle 1(1): loaded http://localhost:53794/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53794/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:04:54 INFO - PROCESS | 13705 | RSS: Main: 229105664 08:04:54 INFO - PROCESS | 13705 | 08:04:57 INFO - PROCESS | 13705 | Cycle 1(1): loaded http://localhost:53794/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53794/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:04:58 INFO - PROCESS | 13705 | RSS: Main: 237056000 08:04:58 INFO - PROCESS | 13705 | 08:05:01 INFO - PROCESS | 13705 | Cycle 1(1): loaded http://localhost:53794/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53794/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:05:01 INFO - PROCESS | 13705 | RSS: Main: 234078208 08:05:01 INFO - PROCESS | 13705 | 08:05:03 INFO - PROCESS | 13705 | Cycle 1(1): loaded http://localhost:53794/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53794/tests/kraken/driver.html?testName=ai-astar) 08:05:03 INFO - PROCESS | 13705 | RSS: Main: 283627520 08:05:03 INFO - PROCESS | 13705 | 08:05:03 INFO - PROCESS | 13705 | __start_tp_report 08:05:03 INFO - PROCESS | 13705 | _x_x_mozilla_page_load 08:05:03 INFO - PROCESS | 13705 | _x_x_mozilla_page_load_details 08:05:03 INFO - PROCESS | 13705 | |i|pagename|runs| 08:05:03 INFO - PROCESS | 13705 | |0;ai-astar;110;117;118;117;117;117;117;116;117;116 08:05:03 INFO - PROCESS | 13705 | |1;audio-beat-detection;154;132;132;169;132;128;130;126;166;127 08:05:03 INFO - PROCESS | 13705 | |2;audio-dft;162;159;161;162;162;160;160;160;160;160 08:05:03 INFO - PROCESS | 13705 | |3;audio-fft;84;77;77;108;77;78;77;77;119;77 08:05:03 INFO - PROCESS | 13705 | |4;audio-oscillator;84;83;116;85;85;85;112;84;83;113 08:05:03 INFO - PROCESS | 13705 | |5;imaging-gaussian-blur;117;117;117;117;117;116;117;117;117;117 08:05:03 INFO - PROCESS | 13705 | |6;imaging-darkroom;148;147;148;148;147;147;148;147;147;147 08:05:03 INFO - PROCESS | 13705 | |7;imaging-desaturate;84;85;84;84;85;86;85;84;85;85 08:05:03 INFO - PROCESS | 13705 | |8;json-parse-financial;63;62;62;62;63;64;63;64;63;64 08:05:03 INFO - PROCESS | 13705 | |9;json-stringify-tinderbox;67;66;66;67;67;67;67;66;68;67 08:05:03 INFO - PROCESS | 13705 | |10;stanford-crypto-aes;83;85;83;83;84;82;83;84;84;93 08:05:03 INFO - PROCESS | 13705 | |11;stanford-crypto-ccm;146;143;148;140;151;150;143;141;183;149 08:05:03 INFO - PROCESS | 13705 | |12;stanford-crypto-pbkdf2;183;180;180;184;180;182;177;175;177;176 08:05:03 INFO - PROCESS | 13705 | |13;stanford-crypto-sha256-iterative;71;70;71;69;69;70;68;68;68;73 08:05:03 INFO - PROCESS | 13705 | __end_tp_report 08:05:03 INFO - PROCESS | 13705 | __start_cc_report 08:05:03 INFO - PROCESS | 13705 | _x_x_mozilla_cycle_collect,1987 08:05:03 INFO - PROCESS | 13705 | __end_cc_report 08:05:03 INFO - PROCESS | 13705 | __startTimestamp1477839903764__endTimestamp 08:05:03 INFO - PROCESS | 13705 | 08:05:03 INFO - PROCESS | 13705 | ------- Summary: start ------- 08:05:03 INFO - PROCESS | 13705 | Number of tests: 14 08:05:03 INFO - PROCESS | 13705 | 08:05:03 INFO - PROCESS | 13705 | [#0] ai-astar Cycles:10 Average:116.20 Median:117.00 stddev:2.25 (1.9%) stddev-sans-first:0.60 08:05:03 INFO - PROCESS | 13705 | Values: 110.0 117.0 118.0 117.0 117.0 117.0 117.0 116.0 117.0 116.0 08:05:03 INFO - PROCESS | 13705 | 08:05:03 INFO - PROCESS | 13705 | [#1] audio-beat-detection Cycles:10 Average:139.60 Median:132.00 stddev:16.71 (12.7%) stddev-sans-first:16.89 08:05:03 INFO - PROCESS | 13705 | Values: 154.0 132.0 132.0 169.0 132.0 128.0 130.0 126.0 166.0 127.0 08:05:03 INFO - PROCESS | 13705 | 08:05:03 INFO - PROCESS | 13705 | [#2] audio-dft Cycles:10 Average:160.60 Median:160.50 stddev:1.07 (0.7%) stddev-sans-first:1.01 08:05:03 INFO - PROCESS | 13705 | Values: 162.0 159.0 161.0 162.0 162.0 160.0 160.0 160.0 160.0 160.0 08:05:03 INFO - PROCESS | 13705 | 08:05:03 INFO - PROCESS | 13705 | [#3] audio-fft Cycles:10 Average:85.10 Median:77.00 stddev:15.34 (19.9%) stddev-sans-first:16.27 08:05:03 INFO - PROCESS | 13705 | Values: 84.0 77.0 77.0 108.0 77.0 78.0 77.0 77.0 119.0 77.0 08:05:03 INFO - PROCESS | 13705 | 08:05:03 INFO - PROCESS | 13705 | [#4] audio-oscillator Cycles:10 Average:93.00 Median:84.00 stddev:14.31 (17.0%) stddev-sans-first:14.81 08:05:03 INFO - PROCESS | 13705 | Values: 84.0 83.0 116.0 85.0 85.0 85.0 112.0 84.0 83.0 113.0 08:05:03 INFO - PROCESS | 13705 | 08:05:03 INFO - PROCESS | 13705 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 08:05:03 INFO - PROCESS | 13705 | Values: 117.0 117.0 117.0 117.0 117.0 116.0 117.0 117.0 117.0 117.0 08:05:03 INFO - PROCESS | 13705 | 08:05:03 INFO - PROCESS | 13705 | [#6] imaging-darkroom Cycles:10 Average:147.40 Median:147.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 08:05:03 INFO - PROCESS | 13705 | Values: 148.0 147.0 148.0 148.0 147.0 147.0 148.0 147.0 147.0 147.0 08:05:03 INFO - PROCESS | 13705 | 08:05:03 INFO - PROCESS | 13705 | [#7] imaging-desaturate Cycles:10 Average:84.70 Median:85.00 stddev:0.67 (0.8%) stddev-sans-first:0.67 08:05:03 INFO - PROCESS | 13705 | Values: 84.0 85.0 84.0 84.0 85.0 86.0 85.0 84.0 85.0 85.0 08:05:03 INFO - PROCESS | 13705 | 08:05:03 INFO - PROCESS | 13705 | [#8] json-parse-financial Cycles:10 Average:63.00 Median:63.00 stddev:0.82 (1.3%) stddev-sans-first:0.87 08:05:03 INFO - PROCESS | 13705 | Values: 63.0 62.0 62.0 62.0 63.0 64.0 63.0 64.0 63.0 64.0 08:05:03 INFO - PROCESS | 13705 | 08:05:03 INFO - PROCESS | 13705 | [#9] json-stringify-tinderbox Cycles:10 Average:66.80 Median:67.00 stddev:0.63 (0.9%) stddev-sans-first:0.67 08:05:03 INFO - PROCESS | 13705 | Values: 67.0 66.0 66.0 67.0 67.0 67.0 67.0 66.0 68.0 67.0 08:05:03 INFO - PROCESS | 13705 | 08:05:03 INFO - PROCESS | 13705 | [#10] stanford-crypto-aes Cycles:10 Average:84.40 Median:84.00 stddev:3.13 (3.7%) stddev-sans-first:3.28 08:05:03 INFO - PROCESS | 13705 | Values: 83.0 85.0 83.0 83.0 84.0 82.0 83.0 84.0 84.0 93.0 08:05:03 INFO - PROCESS | 13705 | 08:05:03 INFO - PROCESS | 13705 | [#11] stanford-crypto-ccm Cycles:10 Average:149.40 Median:148.50 stddev:12.41 (8.4%) stddev-sans-first:13.10 08:05:03 INFO - PROCESS | 13705 | Values: 146.0 143.0 148.0 140.0 151.0 150.0 143.0 141.0 183.0 149.0 08:05:03 INFO - PROCESS | 13705 | 08:05:03 INFO - PROCESS | 13705 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:179.40 Median:180.00 stddev:3.06 (1.7%) stddev-sans-first:2.96 08:05:03 INFO - PROCESS | 13705 | Values: 183.0 180.0 180.0 184.0 180.0 182.0 177.0 175.0 177.0 176.0 08:05:03 INFO - PROCESS | 13705 | 08:05:03 INFO - PROCESS | 13705 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.70 Median:70.00 stddev:1.64 (2.3%) stddev-sans-first:1.67 08:05:03 INFO - PROCESS | 13705 | Values: 71.0 70.0 71.0 69.0 69.0 70.0 68.0 68.0 68.0 73.0 08:05:03 INFO - PROCESS | 13705 | -------- Summary: end -------- 08:05:03 INFO - PROCESS | 13705 | 08:05:05 INFO - TEST-INFO | 13705: exit 0 08:05:05 INFO - TEST-OK | kraken | took 64895ms 08:05:05 INFO - SUITE-END | took 1188s 08:05:05 INFO - Completed test suite (00:19:48) 08:05:05 INFO - javascript benchmark 08:05:05 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2486.191987604029, 2502.7497250274987, 2529.1021687301013, 2539.1113110411357, 2550.566403711368, 4471.619912307454, 4480.932786008212, 4491.034427598066, 4500.639948804096, 4533.523979982104, 4577.748223847695, 4592.334111553822, 4596.0578081493295, 4603.079384123181, 4604.378408914796, 4193.350030745231, 4210.094829611633, 4224.197402493532, 4275.572442755731, 4299.91400171998, 4177.979110104445, 4202.096549241913, 4221.472315960505, 4222.746635201883, 4227.365895115727, 4197.4753155855515, 4218.409422680827, 4245.617894389505, 4255.765932873691, 4286.057067445157, 4260.595243451867, 4287.871363859089, 4293.377460268243, 4294.720843145185, 4314.050908800059, 4105.774182419966, 4139.710220284582, 4155.8753237402925, 4180.811863466151, 4272.636825869805, 4594.035252596958, 4602.792874320664, 4607.838725644619, 4620.838270660511, 4675.859724208279, 4877.3903262092235, 4880.682755620909, 4906.484819093979, 4927.457979622239, 4964.702117872939, 4783.425988881322, 4837.346958160639, 4928.1129396708575, 4960.975195124001, 5014.949850501521, 4630.259158534618, 4668.883277918011, 4671.392718946515, 4707.882302942454, 4722.173619616553, 5114.897702045938, 5116.897662046738, 5117.181250999822, 5119.769610367543, 5171.63798534099, 4711.764411779466, 4775.355327030876, 4898.314236006961, 4906.31311616374, 4969.055879382906, 4884.877878053006, 4926.556609905126, 4944.085344211332, 4966.553010229097, 5032.521910418504, 4900.387451568554, 4920.72935988524, 4923.630727695366, 4924.852254432372, 4983.6760610560195, 4710.858674239778, 4884.877878053077, 4898.681585696918, 4903.190973489405, 4963.280324353021, 4063.126427817974, 4081.1225586499045, 4088.141490287073, 4102.466679331667, 4134.193832202752, 3607.314610224049, 3618.457231415309, 3647.4164133739005, 3653.0867283179205, 3661.7436779425184, 4154.667626589866, 4161.2301724181125, 4162.62536371728, 4173.436586060903, 4190.979045104816, 4634.768261586907, 4727.976360118246, 4738.715677059387, 4798.760061996886, 4808.134535783593, 4092.877213683594, 4097.549269580344, 4109.958900411018, 4112.732672376345, 4116.526599441103, 4291.334843099325, 4299.226139294894, 4300.1399720056115, 4303.139372125587, 4304.655627549789, 4462.709923855004, 4473.642108631237, 4476.9104617906805, 4479.776011199492, 4485.349624304523, 4786.712797232177, 4790.041991601764, 4791.712497250176, 4793.520647935318, 4794.664373493962, 4506.0987802440295, 4509.3686883835635, 4515.051839113823, 4529.184746745485, 4530.977345113253, 4817.614590832655, 4849.709017458964, 4852.369192005017, 4901.975490122527, 4906.63200259989, 4904.779284932258, 4919.409670839522, 4928.8767780805765, 4935.0, 4995.300657907823, 4597.908041839078, 4644.60520855731, 4806.2310030394965, 4813.95186048135, 4878.048780487771, 4684.695494792828, 4694.906101878011, 4697.765111744331, 4698.083873644743, 4702.15361234981, 4606.769661516843, 4614.423197100363, 4621.699589526805, 4626.8149274028665, 4629.976850115728, 4717.103750287434, 4727.527247275245, 4734.4081989751285, 4743.051389722001, 4746.78639461232, 4651.697639653412, 4663.137319595886, 4664.696794708333, 4664.720116793003, 4665.4168228971375], "value": 4474.874523453329, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [547.1164070026905, 547.9424660410657, 554.3541773833483, 561.4778256221712, 562.1006389776355, 27831.582526262097, 38267.0, 39778.0, 39929.0, 43053.56946430535, 39518.0, 39905.40141897874, 39998.20003599926, 40000.79999599998, 40023.59976400235, 7206.17129030163, 7568.167501574822, 7697.114831794332, 7723.72966946157, 7726.652300646456, 7445.106587209515, 7533.54798712079, 7544.849103017937, 7545.471816972814, 9872.111509964101, 9548.045195480467, 9861.11249987501, 9866.062724041205, 9879.0, 9880.604775808959, 10004.299699021072, 10050.849237261375, 10053.095221430034, 10066.899331006669, 10071.34536255141, 9681.515924203832, 9683.564239609235, 9732.2214222862, 9738.756531086708, 9748.95125524375, 36976.630233697586, 37326.813365933, 37334.0, 37397.43903841444, 37406.43890341647, 2941.0735618280387, 3044.9342730044527, 3059.6175478065243, 3282.2286762610765, 3295.555100061485, 27413.31466713348, 27725.722742772516, 27858.3035424114, 28482.145535633757, 29547.0, 2941.0735618280387, 2968.525035994252, 3462.0998540379683, 3479.0042095950816, 3601.693856022215, 243420.0, 243608.0, 245143.0, 245235.0, 245878.99999999822, 32319.838400808316, 51201.74399127981, 51726.741366292925, 51806.22290665643, 51856.740716296175, 32773.0, 32927.176820579196, 32996.67003329984, 33018.17454563655, 33032.174195644824, 12821.423035963404, 12868.678283042998, 12929.418176182095, 12929.870701293055, 12930.935345323402, 10590.682279531626, 10640.946795265974, 10652.786944261072, 10667.466626668636, 10671.092957098734, 7198.316159964795, 7390.7413240536325, 7473.140588832245, 7795.415343849234, 7800.726974555863, 3050.7491928309287, 3063.081075677288, 3078.569000339954, 3081.3683194944983, 3125.0624812556143, 791.3945831438954, 844.7676888855491, 855.4482358878488, 876.9780755481164, 888.2494292322976, 24536.877315613307, 26018.479630407284, 26601.46797064048, 27062.729372706413, 27077.458450830873, 888.5868071346855, 919.793046564531, 933.5985526223789, 936.6581197862868, 947.7346343023964, 13364.131331463424, 13855.792163117561, 14042.508512202025, 14051.156930584199, 14385.568432946819, 351243.0, 353281.0, 354459.0, 355596.0, 410567.0, 42010.78994605008, 45746.680531114864, 47325.29012064822, 47381.76309118432, 53363.0, 1142.7485953090306, 1175.7178277213407, 1198.077086276531, 1200.7898617742035, 1203.7953547896702, 26933.326666833487, 27714.307142321602, 27976.440471190053, 28044.43911121807, 28925.0, 41071.0, 41556.58443415527, 41573.168536628495, 41595.37606935959, 41610.167796644506, 313982.0, 314891.0, 315833.0, 316217.0, 316507.0, 24303.0, 24735.50528989446, 24800.627990580517, 24817.62773558362, 24822.0, 39950.0, 40576.59423405728, 40576.79711601423, 41296.1740765189, 42275.7886210567, 34521.30957380889, 34630.82684586561, 34894.30211395707, 35047.12382190466, 35281.29437411186, 33599.328013440085, 33603.66396336005, 34091.31817363589, 34141.317173655894, 34266.82866585651, 34132.488012680325, 34309.65690343164, 34486.655133448345, 34628.826855866566, 35422.64577354193, 28580.285492862844, 31408.52887206648, 31516.842415787774, 31568.210794729395, 31718.0, 23911.52176956486, 23994.40013999664, 24661.50676986486, 25230.116945906804, 25445.745542544337], "value": 16303.399501777025, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [322.4051624752331, 339.7214284286884, 339.7265201512783, 344.81552369482324, 364.54431960049936, 12485.812712809304, 13513.05408621397, 15833.524994250176, 16834.326626934908, 17819.64360712785, 15712.921435392807, 15989.92005039976, 16091.034537927733, 16110.838891611109, 16484.67030659386, 4092.3656833190753, 4903.19097348937, 4922.040202160571, 5170.612204084689, 5172.146595811687, 4771.618270538349, 5186.844394668166, 5188.740562971855, 5190.532852043315, 5190.584753219733, 4899.706017638935, 5148.588112950955, 5159.071367153911, 5163.406208286039, 5193.740312984354, 5045.697258164503, 5118.769655365518, 5121.974390128063, 5122.410922743895, 5127.461616530267, 4330.588594083557, 4542.6138778203895, 4546.204414227497, 4552.590266875997, 4553.408056952608, 20344.287949921683, 20579.588408231903, 20632.58734825295, 20682.379528614165, 20684.0, 1743.8779285450023, 1750.6673731990882, 1757.2443849144863, 2189.8248140148908, 2363.066588697455, 12077.637670869888, 13034.283114428703, 13434.126781759252, 13610.727785444236, 13647.86352136476, 1542.2288855572215, 1627.5768300241905, 1659.6514731906314, 1740.1647209339587, 1860.897650629215, 64933.0, 67280.32719672838, 67612.0, 68686.65656671734, 69069.65465172642, 9324.160825525736, 9376.515223465787, 9473.431594104239, 9526.666566670272, 9765.218782497383, 12870.742585148431, 12928.612141635766, 12928.676783080498, 12941.676458088623, 12984.0, 6527.629197868501, 6703.798886033427, 6857.074294970215, 6889.621070841052, 6890.899095406987, 6397.584157029778, 6519.543631945813, 6593.439557637558, 6626.9337306627285, 6701.497387695942, 3834.5206849143856, 3859.0, 3889.416587511896, 3970.967548437427, 4009.3384591542067, 1622.5619082847566, 1659.1289572974285, 1689.2651696512057, 1692.5091723400076, 1704.4971733338696, 827.2967977219315, 875.4790899414838, 878.9604467798964, 884.3544212724747, 907.6188001039579, 16278.67442651164, 16417.1791410429, 16557.58606034859, 16706.4152754653, 16982.660346792996, 819.9262066414051, 833.3791325462569, 841.1168273312996, 850.953197574127, 903.3089686389917, 8758.525921299188, 9103.0, 9284.62861485533, 9348.672796452092, 9464.432134071978, 349048.0, 351880.8119188112, 356049.0, 359624.0, 361595.0, 72738.63630681812, 73657.0, 74285.62857185787, 74295.62852185704, 79148.6042569795, 898.1647068226612, 900.7162743735702, 908.9000209976897, 912.1790388650268, 917.6696389299847, 14301.213433261271, 14673.413063477341, 14725.779113313523, 14989.367660835867, 15012.774808377664, 34211.82894085613, 34607.30785384228, 35130.64869351274, 35368.46947295741, 35624.46563301501, 46661.766691167686, 47350.763246183546, 47520.0, 47665.28502072541, 49183.0, 6623.437007854386, 6880.759173429106, 6990.196127445409, 7002.1947476040905, 7004.264552221944, 9864.408135511892, 10431.217658675781, 10537.42044187577, 10566.841497377392, 10820.67537973862, 8841.336899732674, 9015.594298256463, 9127.77180570491, 9137.086291371075, 9228.0, 9121.726348209564, 9198.988111307885, 9258.675946341846, 9287.349885507949, 9399.34204605671, 8927.151920567536, 9397.389169703947, 9451.291153163678, 9489.620415183315, 9657.951710241405, 6993.265707100884, 7062.858742825012, 7174.246704095995, 7185.0, 7243.0946131733535, 7654.655540500802, 9012.594433250651, 9193.310501712265, 9417.48203848795, 9761.56072976732], "value": 7801.022545278947, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1203.127732394014, 1341.1550723044484, 1349.3253373313341, 1440.3734375546637, 1651.9917400413003, 5809.477147056764, 6172.105044768506, 6421.13314702515, 6643.933560664392, 6651.434628056609, 6764.526483146182, 6831.385175334219, 6840.315968403157, 6870.690818913148, 6908.067410899527, 2033.9491512712189, 2046.1406209392092, 2058.3310424112146, 2060.1450398084776, 2061.8453615978788, 2033.176563491788, 2068.5552606189667, 2073.139647046474, 2088.58228354329, 2088.885111318877, 2031.7257170282044, 2056.7634722006937, 2084.6768750843644, 2086.7078608994752, 2089.8328133749264, 1957.7748558915764, 1959.6472634925708, 1983.5437849294742, 1983.980160198394, 1984.861059725827, 1960.2746983616012, 1980.7028945658124, 2021.1006102284489, 2021.6462119129094, 2027.543802644408, 6574.539782215247, 6684.665766711693, 6709.5303328767, 6730.663466826639, 6730.697118629673, 3902.746321489094, 4073.124278280184, 4076.8776936691947, 4129.525104612948, 4137.751734895915, 2527.1786669332355, 2713.7014928357867, 2763.198672385006, 2763.4196818668106, 2765.6542932133484, 789.5302295134443, 795.5783434779576, 800.3317230112863, 804.1275216390223, 826.396730386815, 8308.792280192984, 8420.368472364537, 8442.0, 8460.915390846136, 8462.280706139985, 3437.123533498942, 3551.538300020981, 3584.7811744007163, 3592.2276710507367, 3597.892063238107, 6974.860502789916, 6985.476089293222, 6989.580625162506, 6996.615186164708, 6998.405135563432, 4065.10567675111, 4066.6340029397497, 4069.267531844237, 4069.9389509157386, 4071.328230841937, 3303.289792694582, 3413.2661477782394, 3624.818759062089, 3777.1879046005242, 3863.0, 3052.0538633023834, 3072.078376487045, 3100.8449577521033, 3120.6255249369765, 3131.060681795452, 911.6216770040492, 916.0701887584107, 918.6187732091241, 933.290699068699, 941.2846236859899, 707.6391040569347, 784.1335324466496, 789.8775689768095, 807.8909347238048, 811.8701007838717, 4656.674032817738, 4664.55686709762, 4674.275487299474, 4722.834700785456, 4849.127157111683, 379.71900793413226, 389.90447340401784, 395.8594698881856, 399.0522509041028, 402.5089390943045, 3115.049909777494, 3152.0543836848856, 3170.5719727836445, 3192.0, 3202.5356323333453, 7424.517406368569, 7822.882656760153, 7823.804404889924, 7843.6470358833985, 7844.058712954482, 7782.066152061676, 7787.883181752279, 7794.2985131338455, 7851.568163751049, 7874.133845277015, 6222.844428889314, 6288.968555157195, 6302.212223472066, 6305.779297724557, 6306.243250809932, 4436.467623885154, 4442.444694413199, 4506.526814684411, 4520.118576877478, 4594.793234304398, 7170.42636589082, 7194.208637050025, 7209.170945341143, 7229.855402892018, 7234.493585449179, 7309.780706578811, 7333.230010848784, 7407.851842963219, 7418.480706350504, 7450.776476705708, 5282.735863206901, 5391.245225668488, 5395.325584301962, 5403.486668766461, 5407.918881216863, 5484.506394424521, 5692.231548741032, 6109.175261339662, 6382.936170638234, 6394.680265986775, 5820.359760426434, 5834.658028653349, 5896.64620122794, 5930.673812940329, 5932.5550583705535, 5802.854928626818, 5850.473457388855, 5878.059510478303, 5907.172995780508, 5991.460768530853, 5298.761555730079, 5321.3880403754065, 5381.192821076713, 5505.614606977473, 5557.972210138923, 4171.416001759817, 4202.873913782591, 4222.493300803923, 4300.827966881289, 4402.207602631557, 4066.755994640331, 4114.567970363189, 4202.705810593229, 4223.113146239324, 4319.697621166488], "value": 3524.05847511366, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [282.55779704762045, 289.78845442826736, 291.7767907550724, 291.8526144297129, 293.97942144049927, 4668.883277918049, 4724.338592597039, 4743.90512189756, 4756.143894099061, 4761.904761904764, 4673.644643053519, 4684.695494792836, 4689.0, 4706.69406488578, 4708.811647534095, 3480.1647604574973, 3591.6767490925813, 3592.119930616989, 3730.6082861299647, 3739.551253849542, 3576.284743051387, 3606.4049431843714, 3612.4581312803157, 3694.685951694109, 3704.2219734527444, 3663.3955397359405, 3672.559292884844, 3681.687056600192, 3684.336819372512, 3686.8156592170417, 3663.0, 3680.2271522980204, 3682.2451397463587, 3685.4656074869126, 3693.981530092359, 3166.8099914005234, 3216.6140063192333, 3231.111444352798, 3251.64231934487, 3261.8369081546066, 4601.539846015372, 4620.214563524209, 4622.86131416058, 4628.935344870699, 4630.143423466636, 4208.85269015583, 4210.32634778434, 4214.325707886754, 4221.345691417804, 4224.598663126998, 4763.832051685625, 4880.707157570557, 4881.438634557036, 4892.535209155125, 4943.0, 3522.5068490411363, 3524.6958625308544, 3529.858805647771, 3531.788092714445, 3536.398812201932, 5137.865901799899, 5139.974300128512, 5145.0, 5148.768305426227, 5183.403908550527, 3633.6548027937833, 3637.3998290281806, 3648.8175591220333, 3649.525561676965, 3656.4698118773163, 3541.486484459739, 3682.760620559655, 3694.685951694082, 3700.796456194881, 3720.795356255378, 4197.97901010493, 4200.886765007275, 4203.70574059819, 4211.894702632398, 4213.852515161954, 4923.803047878117, 4926.926096108561, 4934.55588996992, 4956.107900577858, 4962.057209130254, 1241.3296819717252, 1269.7904845700357, 1279.9888088410237, 1285.7878450055823, 1291.9793363242932, 803.7066470738256, 817.4032955942076, 819.9709364747204, 821.7863355527605, 827.230675471817, 3883.708721845873, 3908.2769687607883, 3908.4723562318723, 4180.829367777027, 4300.61294483498, 4958.925616115761, 5077.9238311424615, 5110.4123025852505, 5115.437301896788, 5122.462141475166, 4342.71889792512, 4365.301551751704, 4374.168907907488, 4374.715643483163, 4377.4678862397905, 2596.883140258693, 2696.474187533412, 2698.7060998151806, 2713.199606116161, 2721.102036328007, 4789.880252993703, 4797.232442809134, 4825.1555977703765, 4825.1555977703765, 4827.155247831615, 5163.432022477525, 5177.559907407837, 5198.16829307309, 5272.868178295574, 5279.736013199325, 4603.148417542765, 4739.715617062987, 4767.380240568704, 4772.475027746945, 4773.973595676876, 5110.744462776772, 5119.0, 5120.02719483297, 5126.026055049529, 5134.512221338967, 5001.374828146481, 5005.5745261653165, 5023.0, 5025.864007796745, 5076.543111120017, 4611.0, 4744.810207591658, 4750.691205071659, 4751.812046988253, 4793.23308270675, 3624.9487648581617, 3661.2860492203763, 3670.6879915207505, 3685.299793039314, 3712.276106159273, 5133.10170720115, 5148.43367229612, 5149.150390185728, 5149.845504634867, 5151.665141765773, 4869.415670119608, 4908.386451693538, 4935.136351138464, 4979.925301120414, 4996.200607902718, 4855.878603034952, 4890.828820991248, 4904.681195722266, 4912.606991440748, 4941.5058494151735, 4836.903261934812, 4859.781309840995, 4861.149298872754, 4876.5854902333695, 4890.462049174659, 4836.758162091811, 4928.314068832567, 4945.703257804544, 4969.254611808257, 4991.6006719463085, 4665.6734028617675, 4786.664933454625, 4795.160846851857, 4796.865394899236, 4800.303766100154], "value": 3717.621961879032, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [626.8401557602812, 678.9728410863565, 684.8972654101885, 705.7917914215305, 749.7788152495013, 10823.891761082386, 11596.652100437, 11618.477168527426, 11629.883701162986, 11645.18483706141, 10936.890631093687, 11426.885731142685, 11524.769504609903, 11690.883091169086, 11697.473613687383, 789.2107892107892, 810.2748040503745, 811.0227176252602, 811.2495941254346, 811.4441607498882, 804.3685706720225, 808.4825711544617, 808.5270116981543, 809.3080416244114, 809.6194788449449, 854.7948492361819, 856.1994535109661, 856.2935578148022, 856.8971723393202, 857.0829212742368, 851.3487182305541, 851.4040171879709, 851.7657644147847, 852.2202185000717, 852.2202185000717, 612.9732697731326, 617.6232498176109, 618.483566222205, 618.5670030978333, 619.2847261413075, 10296.742581435448, 10416.42709650969, 11066.944665276702, 11136.777264454746, 11164.497597608128, 8937.662967379309, 9207.079292070806, 9222.492762898039, 9512.571934262905, 9619.038096190396, 7789.961050194713, 7839.608019599054, 7879.290863822226, 8270.338372930151, 8294.917050829476, 2794.329360953377, 2807.3964097718886, 2809.2555472799722, 2829.547272436421, 2920.2845302900714, 47394.526054739355, 47644.0, 47648.28527572089, 48185.75907120477, 48654.51345486535, 6707.195136583544, 6798.116244888133, 6804.3195680432555, 6843.349881761224, 6845.623490707959, 14436.0, 14439.783403248959, 14475.78286325706, 14475.78286325706, 14533.747269173295, 5841.123831425235, 5889.352171261158, 6003.759849605967, 6006.249218847644, 6069.393060693984, 2900.3329234276234, 3098.550710147016, 3162.22525481254, 3246.935061298761, 3285.4743241081314, 2576.549103906809, 2664.0942079692995, 2674.6389237453086, 2681.0616284300727, 2681.209043332222, 418.89318223852723, 437.1344737419926, 438.9495208051115, 444.9510553839075, 456.3178048816973, 475.3036801086356, 522.9790808367623, 523.588982648619, 534.2040359863774, 542.481929757081, 7176.425885929113, 7397.334239918433, 7551.660175292125, 7800.609969501502, 7821.608919554, 480.5962991087503, 508.141702921069, 538.2545174932668, 562.2522045679236, 570.5777724483852, 3568.928621427557, 3635.182084031072, 3646.4894914711963, 3667.972967569085, 3807.5430948286385, 68833.0, 69166.65416672984, 70091.0, 73602.0, 73665.6316718413, 19943.401697948793, 20337.0, 31625.683743162735, 58289.11080357235, 61415.692921536, 55166.72416637971, 55298.0, 55586.72206638941, 55731.72134139304, 56494.717526412926, 6616.305287944697, 6943.236244013256, 7208.819779505554, 7283.490155689051, 7533.171351151478, 34040.0, 34590.82704586461, 35190.648093518736, 35294.64705352914, 35830.0, 47846.52153478421, 48835.0, 49975.25037124519, 51488.742556286976, 52217.0, 8484.745457636282, 9725.58153423528, 9817.950910245403, 9899.1585715215, 9946.154576861049, 11727.706807329885, 11803.409829508662, 11847.0, 12259.69350766238, 12612.621621351374, 11316.83024754613, 11350.886491134983, 11419.543218271509, 11765.411729413667, 12074.335911524951, 10881.238313317992, 11409.543618255177, 11556.248843825124, 11613.941930290632, 11635.301881886775, 10702.571897124028, 10840.566377344818, 11200.83198752003, 11224.494897729459, 11990.400479975791, 8950.597223125105, 9032.819343613222, 9181.908180918106, 9511.476868772284, 9546.95226523863, 9014.459132452073, 9200.585973631336, 9442.48066356357, 9505.714828555154, 9701.70894873155], "value": 5670.54226268318, "unit": "score"}], "name": "dromaeo_css", "value": 5902.459299229641, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 117.0, 118.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 116.0], "value": 116.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 132.0, 132.0, 169.0, 132.0, 128.0, 130.0, 126.0, 166.0, 127.0], "value": 139.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 159.0, 161.0, 162.0, 162.0, 160.0, 160.0, 160.0, 160.0, 160.0], "value": 160.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 77.0, 77.0, 108.0, 77.0, 78.0, 77.0, 77.0, 119.0, 77.0], "value": 85.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 116.0, 85.0, 85.0, 85.0, 112.0, 84.0, 83.0, 113.0], "value": 93.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 148.0, 148.0, 147.0, 147.0, 148.0, 147.0, 147.0, 147.0], "value": 147.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 84.0, 84.0, 85.0, 86.0, 85.0, 84.0, 85.0, 85.0], "value": 84.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 62.0, 62.0, 63.0, 64.0, 63.0, 64.0, 63.0, 64.0], "value": 63.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 66.0, 67.0, 67.0, 67.0, 67.0, 66.0, 68.0, 67.0], "value": 66.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 85.0, 83.0, 83.0, 84.0, 82.0, 83.0, 84.0, 84.0, 93.0], "value": 84.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 143.0, 148.0, 140.0, 151.0, 150.0, 143.0, 141.0, 183.0, 149.0], "value": 149.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 180.0, 180.0, 184.0, 180.0, 182.0, 177.0, 175.0, 177.0, 176.0], "value": 179.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 70.0, 71.0, 69.0, 69.0, 70.0, 68.0, 68.0, 68.0, 73.0], "value": 69.7, "unit": "score"}], "name": "kraken", "value": 1556.2000000000003, "alertThreshold": 2.0}]} 08:05:05 INFO - Return code: 0 08:05:05 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:05:05 INFO - # TBPL SUCCESS # 08:05:05 INFO - Running post-action listener: _resource_record_post_action 08:05:05 INFO - [mozharness: 2016-10-30 15:05:05.536161Z] Finished run-tests step (success) 08:05:05 INFO - Running post-run listener: _resource_record_post_run 08:05:05 INFO - Total resource usage - Wall time: 1205s; CPU: 13.0%; Read bytes: 4096; Write bytes: 406216704; Read time: 8; Write time: 381480 08:05:05 INFO - TinderboxPrint: CPU usage
13.0% 08:05:05 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 08:05:05 INFO - TinderboxPrint: I/O write bytes / time
406,216,704 / 381,480 08:05:05 INFO - TinderboxPrint: CPU idle
8,360.6 (86.9%) 08:05:05 INFO - TinderboxPrint: CPU user
1,204.2 (12.5%) 08:05:05 INFO - TinderboxPrint: Swap in / out
0 / 0 08:05:05 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 115441664; Read time: 0; Write time: 85604 08:05:05 INFO - run-tests - Wall time: 1189s; CPU: 13.0%; Read bytes: 0; Write bytes: 289640448; Read time: 0; Write time: 295816 08:05:06 INFO - Running post-run listener: _upload_blobber_files 08:05:06 INFO - Blob upload gear active. 08:05:06 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:05:06 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 08:05:06 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'] 08:05:06 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 08:05:06 INFO - (blobuploader) - INFO - Open directory for files ... 08:05:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:05:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:05:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:05:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:05:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:05:07 INFO - (blobuploader) - INFO - Done attempting. 08:05:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:05:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:05:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:05:10 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:05:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:05:10 INFO - (blobuploader) - INFO - Done attempting. 08:05:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:05:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:05:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:05:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:05:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:05:11 INFO - (blobuploader) - INFO - Done attempting. 08:05:11 INFO - (blobuploader) - INFO - Iteration through files over. 08:05:11 INFO - Return code: 0 08:05:11 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:05:11 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:05:11 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9b5c793feb49fcf65eb8030813911968c599826866ee19cd848723ed8405da29a1aa731705ed5031bee61fb0b6b8f7c154ec1105b985f55db2fb92b8c47d8a52", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ad2e09a0c21997dee1ff0df9edc19e7b21c01f2a6900909f28377d8f5190e7c520961c2de362da7ead237cc09ee6cf862c2d31515e9d41773d9993017abc6a94", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/30a5323c5b4d8dda9d3d9d4ac1f828a755c60823c265058c0597d4b4f6231bfdb940705174b883bfd76f2b8ad8c831010498ebac171b7086d7449b0ef38bf070"} 08:05:11 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:05:11 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:05:11 INFO - Contents: 08:05:11 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9b5c793feb49fcf65eb8030813911968c599826866ee19cd848723ed8405da29a1aa731705ed5031bee61fb0b6b8f7c154ec1105b985f55db2fb92b8c47d8a52", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ad2e09a0c21997dee1ff0df9edc19e7b21c01f2a6900909f28377d8f5190e7c520961c2de362da7ead237cc09ee6cf862c2d31515e9d41773d9993017abc6a94", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/30a5323c5b4d8dda9d3d9d4ac1f828a755c60823c265058c0597d4b4f6231bfdb940705174b883bfd76f2b8ad8c831010498ebac171b7086d7449b0ef38bf070"} 08:05:11 INFO - Running post-run listener: copy_logs_to_upload_dir 08:05:11 INFO - Copying logs to upload dir... 08:05:11 INFO - mkdir: /builds/slave/test/build/upload/logs 08:05:11 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.893811 ========= master_lag: -0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-10-30 08:05:09.618867) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-30 08:05:09.622921) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a12cd81e0ef515edd9e0d800000001bb-1477838660.893373-1808162773 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/9b5c793feb49fcf65eb8030813911968c599826866ee19cd848723ed8405da29a1aa731705ed5031bee61fb0b6b8f7c154ec1105b985f55db2fb92b8c47d8a52", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ad2e09a0c21997dee1ff0df9edc19e7b21c01f2a6900909f28377d8f5190e7c520961c2de362da7ead237cc09ee6cf862c2d31515e9d41773d9993017abc6a94", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/30a5323c5b4d8dda9d3d9d4ac1f828a755c60823c265058c0597d4b4f6231bfdb940705174b883bfd76f2b8ad8c831010498ebac171b7086d7449b0ef38bf070"} build_url:https://queue.taskcluster.net/v1/task/Y2r8ZAIBSEKUNiMHtiOQaQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011200 build_url: 'https://queue.taskcluster.net/v1/task/Y2r8ZAIBSEKUNiMHtiOQaQ/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/9b5c793feb49fcf65eb8030813911968c599826866ee19cd848723ed8405da29a1aa731705ed5031bee61fb0b6b8f7c154ec1105b985f55db2fb92b8c47d8a52", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ad2e09a0c21997dee1ff0df9edc19e7b21c01f2a6900909f28377d8f5190e7c520961c2de362da7ead237cc09ee6cf862c2d31515e9d41773d9993017abc6a94", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/30a5323c5b4d8dda9d3d9d4ac1f828a755c60823c265058c0597d4b4f6231bfdb940705174b883bfd76f2b8ad8c831010498ebac171b7086d7449b0ef38bf070"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-30 08:05:09.648555) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-30 08:05:09.648912) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a12cd81e0ef515edd9e0d800000001bb-1477838660.893373-1808162773 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004424 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-30 08:05:09.734462) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-30 08:05:09.734776) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-30 08:05:09.735073) ========= ========= Total master_lag: 0.14 =========