builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-031 starttime: 1477538775.06 results: success (0) buildid: 20161026184134 builduid: d72ff4b54eb8421bbf5a93d6034a0cf4 revision: 3f4c3a3cabaf94958834d3a8935adfb4a887942d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-26 20:26:15.062392) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-26 20:26:15.062870) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-26 20:26:15.063210) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-26 20:26:15.088981) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 20:26:15.089288) ========= 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=db0483c52d987ecb441a263b000001ad-1477535160.768477-1998318446 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-26 20:26:15-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 113M=0s 2016-10-26 20:26:15 (113 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.076245 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 20:26:15.179911) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 20:26:15.180247) ========= 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=db0483c52d987ecb441a263b000001ad-1477535160.768477-1998318446 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014793 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 20:26:15.230747) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 20:26:15.231177) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 3f4c3a3cabaf94958834d3a8935adfb4a887942d --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 3f4c3a3cabaf94958834d3a8935adfb4a887942d --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=db0483c52d987ecb441a263b000001ad-1477535160.768477-1998318446 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-26 20:26:15,574 truncating revision to first 12 chars 2016-10-26 20:26:15,574 Setting DEBUG logging. 2016-10-26 20:26:15,575 attempt 1/10 2016-10-26 20:26:15,575 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/3f4c3a3cabaf?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-26 20:26:15,871 unpacking tar archive at: mozilla-central-3f4c3a3cabaf/testing/mozharness/ program finished with exit code 0 elapsedTime=0.602402 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 20:26:15.851418) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-26 20:26:15.852216) ========= script_repo_revision: 3f4c3a3cabaf94958834d3a8935adfb4a887942d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-26 20:26:15.853281) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-26 20:26:15.854032) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-26 20:26:15.865888) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-10-26 20:26:15.866208) ========= /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=db0483c52d987ecb441a263b000001ad-1477535160.768477-1998318446 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:26:16 INFO - MultiFileLogger online at 20161026 20:26:16 in /builds/slave/test 20:26:16 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 20:26:16 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:26:16 INFO - {'append_to_log': False, 20:26:16 INFO - 'base_work_dir': '/builds/slave/test', 20:26:16 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 20:26:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:26:16 INFO - 'branch': 'Firefox-Non-PGO', 20:26:16 INFO - 'buildbot_json_path': 'buildprops.json', 20:26:16 INFO - 'config_files': ('talos/linux_config.py',), 20:26:16 INFO - 'default_actions': ('clobber', 20:26:16 INFO - 'read-buildbot-config', 20:26:16 INFO - 'download-and-extract', 20:26:16 INFO - 'populate-webroot', 20:26:16 INFO - 'create-virtualenv', 20:26:16 INFO - 'install', 20:26:16 INFO - 'run-tests'), 20:26:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:26:16 INFO - 'download_minidump_stackwalk': True, 20:26:16 INFO - 'download_symbols': 'ondemand', 20:26:16 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:26:16 INFO - 'tooltool.py': '/tools/tooltool.py', 20:26:16 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:26:16 INFO - '/tools/misc-python/virtualenv.py')}, 20:26:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:26:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:26:16 INFO - 'installer_path': 'installer.exe', 20:26:16 INFO - 'log_level': 'info', 20:26:16 INFO - 'log_name': 'talos', 20:26:16 INFO - 'log_to_console': True, 20:26:16 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:26:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:26:16 INFO - 'opt_config_files': (), 20:26:16 INFO - 'pip_index': False, 20:26:16 INFO - 'sps_profile': False, 20:26:16 INFO - 'sps_profile_interval': 0, 20:26:16 INFO - 'suite': 'dromaeojs', 20:26:16 INFO - 'system_bits': '32', 20:26:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:26:16 INFO - 'title': 'talos-linux64-ix-031', 20:26:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:26:16 INFO - 'use_talos_json': True, 20:26:16 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:26:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:26:16 INFO - 'work_dir': 'build'} 20:26:16 INFO - [mozharness: 2016-10-27 03:26:16.309641Z] Running clobber step. 20:26:16 INFO - Running pre-action listener: _resource_record_pre_action 20:26:16 INFO - Running main action method: clobber 20:26:16 INFO - rmtree: /builds/slave/test/build 20:26:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:26:16 INFO - Running post-action listener: _resource_record_post_action 20:26:16 INFO - [mozharness: 2016-10-27 03:26:16.765641Z] Finished clobber step (success) 20:26:16 INFO - [mozharness: 2016-10-27 03:26:16.765742Z] Running read-buildbot-config step. 20:26:16 INFO - Running pre-action listener: _resource_record_pre_action 20:26:16 INFO - Running main action method: read_buildbot_config 20:26:16 INFO - Using buildbot properties: 20:26:16 INFO - { 20:26:16 INFO - "project": "", 20:26:16 INFO - "product": "firefox", 20:26:16 INFO - "script_repo_revision": "production", 20:26:16 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 20:26:16 INFO - "repository": "", 20:26:16 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 20:26:16 INFO - "buildid": "20161026184134", 20:26:16 INFO - "pgo_build": "False", 20:26:16 INFO - "basedir": "/builds/slave/test", 20:26:16 INFO - "buildnumber": 695, 20:26:16 INFO - "slavename": "talos-linux64-ix-031", 20:26:16 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 20:26:16 INFO - "platform": "ubuntu64_hw", 20:26:16 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 20:26:16 INFO - "branch": "mozilla-central", 20:26:16 INFO - "repo_path": "mozilla-central", 20:26:16 INFO - "revision": "3f4c3a3cabaf94958834d3a8935adfb4a887942d", 20:26:16 INFO - "stage_platform": "linux64", 20:26:16 INFO - "builduid": "d72ff4b54eb8421bbf5a93d6034a0cf4", 20:26:16 INFO - "slavebuilddir": "test" 20:26:16 INFO - } 20:26:16 INFO - Found installer url https://queue.taskcluster.net/v1/task/Jc9RvSmITg2V7jssLw8ggw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 20:26:16 INFO - Running post-action listener: _resource_record_post_action 20:26:16 INFO - [mozharness: 2016-10-27 03:26:16.768195Z] Finished read-buildbot-config step (success) 20:26:16 INFO - [mozharness: 2016-10-27 03:26:16.768285Z] Running download-and-extract step. 20:26:16 INFO - Running pre-action listener: _resource_record_pre_action 20:26:16 INFO - Running main action method: download_and_extract 20:26:16 INFO - mkdir: /builds/slave/test/build/tests 20:26: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')]} 20:26:16 INFO - trying https://queue.taskcluster.net/v1/task/Jc9RvSmITg2V7jssLw8ggw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 20:26:16 INFO - Downloading https://queue.taskcluster.net/v1/task/Jc9RvSmITg2V7jssLw8ggw/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 20:26:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Jc9RvSmITg2V7jssLw8ggw/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 20:26:17 INFO - Downloaded 1361 bytes. 20:26:17 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 20:26:17 INFO - Using the following test package requirements: 20:26:17 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 20:26:17 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 20:26:17 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 20:26:17 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 20:26:17 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 20:26:17 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 20:26:17 INFO - u'jsshell-linux-x86_64.zip'], 20:26:17 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 20:26:17 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 20:26:17 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 20:26:17 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 20:26:17 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 20:26:17 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 20:26:17 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 20:26:17 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 20:26:17 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 20:26:17 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 20:26:17 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 20:26:17 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 20:26:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Jc9RvSmITg2V7jssLw8ggw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 20:26:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Jc9RvSmITg2V7jssLw8ggw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 20:26:17 INFO - Fetch https://queue.taskcluster.net/v1/task/Jc9RvSmITg2V7jssLw8ggw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 20:26:17 INFO - Http code: 200 20:26:17 INFO - via: 1.1 7f9e159e8ac7593f5d3d995abc6d2db3.cloudfront.net (CloudFront) 20:26:17 INFO - x-amz-cf-id: Nrvy0xb7qVU03HdZiP0oR8fLnW51bBlaku6Tl9UGXYL2edo5dFeq8A== 20:26:17 INFO - x-amz-version-id: bRUl_kX3ecjfftsL4Y_tfahJsHKbxfKh 20:26:18 INFO - Expected file size: 20424285 20:26:18 INFO - Obtained file size: 20424285 20:26:22 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 20:26:22 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Jc9RvSmITg2V7jssLw8ggw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 20:26:22 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Jc9RvSmITg2V7jssLw8ggw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 20:26:22 INFO - Fetch https://queue.taskcluster.net/v1/task/Jc9RvSmITg2V7jssLw8ggw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 20:26:22 INFO - Http code: 200 20:26:22 INFO - via: 1.1 455cf6ccbccc261c46d02110de1c0237.cloudfront.net (CloudFront) 20:26:22 INFO - x-amz-cf-id: JFCPeYLiJgplIzscpec_yaeXZSAg1nuGPkKkaXEZuojEWb6N0Oma4w== 20:26:22 INFO - x-amz-version-id: bRUl_kX3ecjfftsL4Y_tfahJsHKbxfKh 20:26:23 INFO - Expected file size: 20424285 20:26:23 INFO - Obtained file size: 20424285 20:26:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Jc9RvSmITg2V7jssLw8ggw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 20:26:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Jc9RvSmITg2V7jssLw8ggw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 20:26:27 INFO - Fetch https://queue.taskcluster.net/v1/task/Jc9RvSmITg2V7jssLw8ggw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 20:26:27 INFO - Http code: 200 20:26:27 INFO - via: 1.1 1b52a5dd431f9e3c81753e61dfdf467a.cloudfront.net (CloudFront) 20:26:27 INFO - x-amz-cf-id: MxRm1gAxFgqCEuaqjjkHUBpVWdyzj8x0YGF8ErIJYZrY3y2EWi1TFQ== 20:26:27 INFO - x-amz-version-id: 6IFqH3uqmc5.4dxOeS.PsDAKtkBim1Qx 20:26:28 INFO - Expected file size: 14409028 20:26:28 INFO - Obtained file size: 14409028 20:26:28 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')]} 20:26:28 INFO - trying https://queue.taskcluster.net/v1/task/Jc9RvSmITg2V7jssLw8ggw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 20:26:28 INFO - Downloading https://queue.taskcluster.net/v1/task/Jc9RvSmITg2V7jssLw8ggw/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 20:26:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Jc9RvSmITg2V7jssLw8ggw/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 20:26:29 INFO - Downloaded 55598073 bytes. 20:26:29 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Jc9RvSmITg2V7jssLw8ggw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 20:26:29 INFO - mkdir: /builds/slave/test/properties 20:26:29 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:26:29 INFO - Writing to file /builds/slave/test/properties/build_url 20:26:29 INFO - Contents: 20:26:29 INFO - build_url:https://queue.taskcluster.net/v1/task/Jc9RvSmITg2V7jssLw8ggw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 20:26:30 INFO - Running post-action listener: _resource_record_post_action 20:26:30 INFO - Running post-action listener: set_extra_try_arguments 20:26:30 INFO - [mozharness: 2016-10-27 03:26:30.223398Z] Finished download-and-extract step (success) 20:26:30 INFO - [mozharness: 2016-10-27 03:26:30.223627Z] Running populate-webroot step. 20:26:30 INFO - Running pre-action listener: _resource_record_pre_action 20:26:30 INFO - Running main action method: populate_webroot 20:26:30 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:26:30 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:26:30 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:26:30 INFO - '--tppagecycles', 20:26:30 INFO - '7'], 20:26:30 INFO - 'tests': ['tsvgm']}}, 20:26:30 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:26:30 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:26:30 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:26:30 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:26:30 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:26:30 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:26:30 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:26:30 INFO - 'talos_options': ['--disable-e10s'], 20:26:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:26:30 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:26:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:26:30 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:26:30 INFO - 'talos_options': ['--disable-e10s'], 20:26:30 INFO - 'tests': ['damp', 'tps']}, 20:26:30 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:26:30 INFO - 'tests': ['damp', 'tps']}, 20:26:30 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:26:30 INFO - 'tests': ['dromaeo_dom']}, 20:26:30 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:26:30 INFO - 'g4': {'talos_options': ['--disable-e10s'], 20:26:30 INFO - 'tests': ['basic_compositor_video']}, 20:26:30 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 20:26:30 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:26:30 INFO - 'tests': ['a11yr', 20:26:30 INFO - 'ts_paint', 20:26:30 INFO - 'tpaint', 20:26:30 INFO - 'sessionrestore', 20:26:30 INFO - 'sessionrestore_no_auto_restore', 20:26:30 INFO - 'tabpaint']}, 20:26:30 INFO - 'other-e10s': {'tests': ['a11yr', 20:26:30 INFO - 'ts_paint', 20:26:30 INFO - 'tpaint', 20:26:30 INFO - 'sessionrestore', 20:26:30 INFO - 'sessionrestore_no_auto_restore', 20:26:30 INFO - 'tabpaint']}, 20:26:30 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:26:30 INFO - 'ts_paint', 20:26:30 INFO - 'tpaint', 20:26:30 INFO - 'sessionrestore', 20:26:30 INFO - 'sessionrestore_no_auto_restore', 20:26:30 INFO - 'tabpaint']}, 20:26:30 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:26:30 INFO - 'ts_paint', 20:26:30 INFO - 'tpaint', 20:26:30 INFO - 'sessionrestore', 20:26:30 INFO - 'sessionrestore_no_auto_restore', 20:26:30 INFO - 'tabpaint']}, 20:26:30 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:26:30 INFO - 'tests': ['a11yr', 20:26:30 INFO - 'ts_paint', 20:26:30 INFO - 'tpaint', 20:26:30 INFO - 'sessionrestore', 20:26:30 INFO - 'sessionrestore_no_auto_restore', 20:26:30 INFO - 'tabpaint']}, 20:26:30 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:26:30 INFO - 'tests': ['a11yr', 20:26:30 INFO - 'ts_paint', 20:26:30 INFO - 'tpaint', 20:26:30 INFO - 'sessionrestore', 20:26:30 INFO - 'sessionrestore_no_auto_restore', 20:26:30 INFO - 'tabpaint']}, 20:26:30 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:26:30 INFO - 'tests': ['tsvgx', 20:26:30 INFO - 'tsvgr_opacity', 20:26:30 INFO - 'tart', 20:26:30 INFO - 'tscrollx', 20:26:30 INFO - 'cart']}, 20:26:30 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:26:30 INFO - 'tsvgr_opacity', 20:26:30 INFO - 'tart', 20:26:30 INFO - 'tscrollx', 20:26:30 INFO - 'cart']}, 20:26:30 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:26:30 INFO - 'talos_options': ['--disable-e10s'], 20:26:30 INFO - 'tests': ['tp5o']}, 20:26:30 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:26:30 INFO - 'tests': ['tp5o']}, 20:26:30 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:26:30 INFO - 'talos_options': ['--disable-e10s', 20:26:30 INFO - '--xperf_path', 20:26:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:26:30 INFO - 'tests': ['tp5n']}, 20:26:30 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:26:30 INFO - 'talos_options': ['--xperf_path', 20:26:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:26:30 INFO - 'tests': ['tp5n']}}, 20:26:30 INFO - 'talos.zip': {'path': '', 20:26:30 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:26:30 INFO - Running post-action listener: _resource_record_post_action 20:26:30 INFO - [mozharness: 2016-10-27 03:26:30.245674Z] Finished populate-webroot step (success) 20:26:30 INFO - [mozharness: 2016-10-27 03:26:30.245763Z] Running create-virtualenv step. 20:26:30 INFO - Running pre-action listener: _resource_record_pre_action 20:26:30 INFO - Running main action method: create_virtualenv 20:26:30 INFO - Creating virtualenv /builds/slave/test/build/venv 20:26:30 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 20:26:30 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:26:30 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:26:30 INFO - Using real prefix '/usr' 20:26:30 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:26:30 INFO - Installing distribute.............................................................................................................................................................................................done. 20:26:32 INFO - Installing pip.................done. 20:26:32 INFO - Return code: 0 20:26:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 20:26:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 20:26:33 INFO - Reading from file tmpfile_stdout 20:26:33 INFO - Output received: 20:26:33 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) 20:26:33 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:26:33 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')]} 20:26:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:26:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:26:33 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')]} 20:26:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:26:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:26:33 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 0x7f568ea6cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1861ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x185ef60>, '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 0x185fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18601d0>, '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': 'db0483c52d987ecb441a263b000001ad-1477535160.768477-1998318446', '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 20:26:33 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 20:26:33 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 20:26:33 INFO - Using env: {'DISPLAY': ':0', 20:26:33 INFO - 'HOME': '/home/cltbld', 20:26:33 INFO - 'LANG': 'en_US.UTF-8', 20:26:33 INFO - 'LANGUAGE': 'en_US:en', 20:26:33 INFO - 'LOGNAME': 'cltbld', 20:26:33 INFO - 'MAIL': '/var/mail/cltbld', 20:26:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:26:33 INFO - 'MOZ_NO_REMOTE': '1', 20:26:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:26:33 INFO - 'NO_EM_RESTART': '1', 20:26:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:26:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:26:33 INFO - 'PWD': '/builds/slave/test', 20:26:33 INFO - 'SHELL': '/bin/bash', 20:26:33 INFO - 'SHLVL': '1', 20:26:33 INFO - 'TERM': 'linux', 20:26:33 INFO - 'TMOUT': '86400', 20:26:33 INFO - 'USER': 'cltbld', 20:26:33 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1477535160.768477-1998318446', 20:26:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:26:33 INFO - '_': '/tools/buildbot/bin/python'} 20:26:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:26:33 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 20:26:33 INFO - Cleaning up... 20:26:33 INFO - Return code: 0 20:26:33 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 20:26:33 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')]} 20:26:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:26:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:26:33 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')]} 20:26:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:26:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:26:33 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 0x7f568ea6cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1861ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x185ef60>, '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 0x185fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18601d0>, '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': 'db0483c52d987ecb441a263b000001ad-1477535160.768477-1998318446', '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 20:26:33 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 20:26:33 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 20:26:33 INFO - Using env: {'DISPLAY': ':0', 20:26:33 INFO - 'HOME': '/home/cltbld', 20:26:33 INFO - 'LANG': 'en_US.UTF-8', 20:26:33 INFO - 'LANGUAGE': 'en_US:en', 20:26:33 INFO - 'LOGNAME': 'cltbld', 20:26:33 INFO - 'MAIL': '/var/mail/cltbld', 20:26:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:26:33 INFO - 'MOZ_NO_REMOTE': '1', 20:26:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:26:33 INFO - 'NO_EM_RESTART': '1', 20:26:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:26:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:26:33 INFO - 'PWD': '/builds/slave/test', 20:26:33 INFO - 'SHELL': '/bin/bash', 20:26:33 INFO - 'SHLVL': '1', 20:26:33 INFO - 'TERM': 'linux', 20:26:33 INFO - 'TMOUT': '86400', 20:26:33 INFO - 'USER': 'cltbld', 20:26:33 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1477535160.768477-1998318446', 20:26:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:26:33 INFO - '_': '/tools/buildbot/bin/python'} 20:26:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:26:33 INFO - Downloading/unpacking psutil>=3.1.1 20:26:33 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 20:26:33 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 20:26:33 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 20:26:33 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 20:26:33 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 20:26:33 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 20:26:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:26:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:26:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:26:35 INFO - Installing collected packages: psutil 20:26:35 INFO - Running setup.py install for psutil 20:26:35 INFO - building 'psutil._psutil_linux' extension 20:26:35 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 20:26:35 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 20:26:35 INFO - building 'psutil._psutil_posix' extension 20:26:35 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 20:26:35 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 20:26:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:26:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:26:36 INFO - Successfully installed psutil 20:26:36 INFO - Cleaning up... 20:26:36 INFO - Return code: 0 20:26:36 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 20:26: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')]} 20:26:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:26:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:26: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')]} 20:26:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:26:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:26:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f568ea6cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1861ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x185ef60>, '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 0x185fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18601d0>, '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': 'db0483c52d987ecb441a263b000001ad-1477535160.768477-1998318446', '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 20:26:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 20:26:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 20:26:36 INFO - Using env: {'DISPLAY': ':0', 20:26:36 INFO - 'HOME': '/home/cltbld', 20:26:36 INFO - 'LANG': 'en_US.UTF-8', 20:26:36 INFO - 'LANGUAGE': 'en_US:en', 20:26:36 INFO - 'LOGNAME': 'cltbld', 20:26:36 INFO - 'MAIL': '/var/mail/cltbld', 20:26:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:26:36 INFO - 'MOZ_NO_REMOTE': '1', 20:26:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:26:36 INFO - 'NO_EM_RESTART': '1', 20:26:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:26:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:26:36 INFO - 'PWD': '/builds/slave/test', 20:26:36 INFO - 'SHELL': '/bin/bash', 20:26:36 INFO - 'SHLVL': '1', 20:26:36 INFO - 'TERM': 'linux', 20:26:36 INFO - 'TMOUT': '86400', 20:26:36 INFO - 'USER': 'cltbld', 20:26:36 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1477535160.768477-1998318446', 20:26:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:26:36 INFO - '_': '/tools/buildbot/bin/python'} 20:26:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:26:36 INFO - Downloading/unpacking mozsystemmonitor==0.3 20:26:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:26:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:26:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:26:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:26:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:26:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:26:38 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:26:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:26:38 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 20:26:38 INFO - Installing collected packages: mozsystemmonitor 20:26:38 INFO - Running setup.py install for mozsystemmonitor 20:26:38 INFO - Successfully installed mozsystemmonitor 20:26:38 INFO - Cleaning up... 20:26:38 INFO - Return code: 0 20:26:38 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 20:26:38 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')]} 20:26:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:26:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:26:38 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')]} 20:26:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:26:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:26:38 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 0x7f568ea6cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1861ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x185ef60>, '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 0x185fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18601d0>, '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': 'db0483c52d987ecb441a263b000001ad-1477535160.768477-1998318446', '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 20:26:38 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 20:26:38 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 20:26:38 INFO - Using env: {'DISPLAY': ':0', 20:26:38 INFO - 'HOME': '/home/cltbld', 20:26:38 INFO - 'LANG': 'en_US.UTF-8', 20:26:38 INFO - 'LANGUAGE': 'en_US:en', 20:26:38 INFO - 'LOGNAME': 'cltbld', 20:26:38 INFO - 'MAIL': '/var/mail/cltbld', 20:26:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:26:38 INFO - 'MOZ_NO_REMOTE': '1', 20:26:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:26:38 INFO - 'NO_EM_RESTART': '1', 20:26:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:26:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:26:38 INFO - 'PWD': '/builds/slave/test', 20:26:38 INFO - 'SHELL': '/bin/bash', 20:26:38 INFO - 'SHLVL': '1', 20:26:38 INFO - 'TERM': 'linux', 20:26:38 INFO - 'TMOUT': '86400', 20:26:38 INFO - 'USER': 'cltbld', 20:26:38 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1477535160.768477-1998318446', 20:26:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:26:38 INFO - '_': '/tools/buildbot/bin/python'} 20:26:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:26:38 INFO - Downloading/unpacking jsonschema==2.5.1 20:26:38 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 20:26:38 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 20:26:38 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 20:26:38 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 20:26:38 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 20:26:38 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 20:26:40 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:26:40 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 20:26:40 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 20:26:40 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 20:26:40 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 20:26:40 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 20:26:40 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 20:26:40 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 20:26:40 INFO - Downloading functools32-3.2.3-2.tar.gz 20:26:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:26:40 INFO - warning: no files found matching '*.txt' 20:26:40 INFO - no previously-included directories found matching 'build' 20:26:40 INFO - no previously-included directories found matching 'dist' 20:26:40 INFO - no previously-included directories found matching '.git*' 20:26:40 INFO - Installing collected packages: jsonschema, functools32 20:26:40 INFO - Running setup.py install for functools32 20:26:40 INFO - warning: no files found matching '*.txt' 20:26:40 INFO - no previously-included directories found matching 'build' 20:26:40 INFO - no previously-included directories found matching 'dist' 20:26:40 INFO - no previously-included directories found matching '.git*' 20:26:41 INFO - Successfully installed jsonschema functools32 20:26:41 INFO - Cleaning up... 20:26:41 INFO - Return code: 0 20:26:41 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 20:26: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')]} 20:26:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:26:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:26: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')]} 20:26:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:26:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:26: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', '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 0x7f568ea6cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1861ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x185ef60>, '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 0x185fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18601d0>, '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': 'db0483c52d987ecb441a263b000001ad-1477535160.768477-1998318446', '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 20:26: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 20:26: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 functools32==3.2.3-2 20:26:41 INFO - Using env: {'DISPLAY': ':0', 20:26:41 INFO - 'HOME': '/home/cltbld', 20:26:41 INFO - 'LANG': 'en_US.UTF-8', 20:26:41 INFO - 'LANGUAGE': 'en_US:en', 20:26:41 INFO - 'LOGNAME': 'cltbld', 20:26:41 INFO - 'MAIL': '/var/mail/cltbld', 20:26:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:26:41 INFO - 'MOZ_NO_REMOTE': '1', 20:26:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:26:41 INFO - 'NO_EM_RESTART': '1', 20:26:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:26:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:26:41 INFO - 'PWD': '/builds/slave/test', 20:26:41 INFO - 'SHELL': '/bin/bash', 20:26:41 INFO - 'SHLVL': '1', 20:26:41 INFO - 'TERM': 'linux', 20:26:41 INFO - 'TMOUT': '86400', 20:26:41 INFO - 'USER': 'cltbld', 20:26:41 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1477535160.768477-1998318446', 20:26:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:26:41 INFO - '_': '/tools/buildbot/bin/python'} 20:26:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:26:41 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 20:26:41 INFO - Cleaning up... 20:26:41 INFO - Return code: 0 20:26:41 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:26: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')]} 20:26:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:26:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:26: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')]} 20:26:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:26:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:26: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', '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 0x7f568ea6cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1861ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x185ef60>, '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 0x185fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18601d0>, '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': 'db0483c52d987ecb441a263b000001ad-1477535160.768477-1998318446', '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 20:26: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 20:26: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 blobuploader==1.2.4 20:26:41 INFO - Using env: {'DISPLAY': ':0', 20:26:41 INFO - 'HOME': '/home/cltbld', 20:26:41 INFO - 'LANG': 'en_US.UTF-8', 20:26:41 INFO - 'LANGUAGE': 'en_US:en', 20:26:41 INFO - 'LOGNAME': 'cltbld', 20:26:41 INFO - 'MAIL': '/var/mail/cltbld', 20:26:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:26:41 INFO - 'MOZ_NO_REMOTE': '1', 20:26:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:26:41 INFO - 'NO_EM_RESTART': '1', 20:26:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:26:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:26:41 INFO - 'PWD': '/builds/slave/test', 20:26:41 INFO - 'SHELL': '/bin/bash', 20:26:41 INFO - 'SHLVL': '1', 20:26:41 INFO - 'TERM': 'linux', 20:26:41 INFO - 'TMOUT': '86400', 20:26:41 INFO - 'USER': 'cltbld', 20:26:41 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1477535160.768477-1998318446', 20:26:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:26:41 INFO - '_': '/tools/buildbot/bin/python'} 20:26:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:26:41 INFO - Downloading/unpacking blobuploader==1.2.4 20:26: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 20:26: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 20:26: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 20:26: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 20:26: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 20:26: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 20:26:43 INFO - Downloading blobuploader-1.2.4.tar.gz 20:26:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:26:43 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:26:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:26:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:26:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:26:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:26:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:26:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:26:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:26:43 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:26:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:26:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:26:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:26:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:26:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:26:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:26:44 INFO - Downloading docopt-0.6.1.tar.gz 20:26:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:26:44 INFO - Installing collected packages: blobuploader, requests, docopt 20:26:44 INFO - Running setup.py install for blobuploader 20:26:44 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:26:44 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:26:44 INFO - Running setup.py install for requests 20:26:44 INFO - Running setup.py install for docopt 20:26:44 INFO - Successfully installed blobuploader requests docopt 20:26:44 INFO - Cleaning up... 20:26:44 INFO - Return code: 0 20:26:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:26: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')]} 20:26:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:26:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:26: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')]} 20:26:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:26:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:26:44 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 0x7f568ea6cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1861ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x185ef60>, '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 0x185fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18601d0>, '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': 'db0483c52d987ecb441a263b000001ad-1477535160.768477-1998318446', '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 20:26:44 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 20:26:44 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 20:26:44 INFO - Using env: {'DISPLAY': ':0', 20:26:44 INFO - 'HOME': '/home/cltbld', 20:26:44 INFO - 'LANG': 'en_US.UTF-8', 20:26:44 INFO - 'LANGUAGE': 'en_US:en', 20:26:44 INFO - 'LOGNAME': 'cltbld', 20:26:44 INFO - 'MAIL': '/var/mail/cltbld', 20:26:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:26:44 INFO - 'MOZ_NO_REMOTE': '1', 20:26:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:26:44 INFO - 'NO_EM_RESTART': '1', 20:26:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:26:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:26:44 INFO - 'PWD': '/builds/slave/test', 20:26:44 INFO - 'SHELL': '/bin/bash', 20:26:44 INFO - 'SHLVL': '1', 20:26:44 INFO - 'TERM': 'linux', 20:26:44 INFO - 'TMOUT': '86400', 20:26:44 INFO - 'USER': 'cltbld', 20:26:44 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1477535160.768477-1998318446', 20:26:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:26:44 INFO - '_': '/tools/buildbot/bin/python'} 20:26:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:26:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:26:45 INFO - Running setup.py (path:/tmp/pip-kMwYny-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:26:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:26:45 INFO - Running setup.py (path:/tmp/pip-cTcAOB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:26:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:26:45 INFO - Running setup.py (path:/tmp/pip-qFw3lp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:26:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:26:45 INFO - Running setup.py (path:/tmp/pip-LSCunz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:26:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:26:45 INFO - Running setup.py (path:/tmp/pip-J40LCW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:26:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:26:45 INFO - Running setup.py (path:/tmp/pip-ZZT7JZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:26:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:26:45 INFO - Running setup.py (path:/tmp/pip-wLfUHL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:26:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:26:45 INFO - Running setup.py (path:/tmp/pip-AW6NnK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:26:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:26:45 INFO - Running setup.py (path:/tmp/pip-oTIqF3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:26:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:26:45 INFO - Running setup.py (path:/tmp/pip-EeHKLE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:26:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:26:45 INFO - Running setup.py (path:/tmp/pip-_v5cbC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:26:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:26:45 INFO - Running setup.py (path:/tmp/pip-joaZ41-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:26:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:26:45 INFO - Running setup.py (path:/tmp/pip-icqCTp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:26:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:26:45 INFO - Running setup.py (path:/tmp/pip-wu7_OP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:26:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:26:46 INFO - Running setup.py (path:/tmp/pip-TsCtUs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:26:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:26:46 INFO - Running setup.py (path:/tmp/pip-lHavwr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:26:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:26:46 INFO - Running setup.py (path:/tmp/pip-ijz8GG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:26:46 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:26:46 INFO - Running setup.py install for manifestparser 20:26:46 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:26:46 INFO - Running setup.py install for mozcrash 20:26:46 INFO - Running setup.py install for mozdebug 20:26:46 INFO - Running setup.py install for mozdevice 20:26:46 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:26:46 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:26:46 INFO - Running setup.py install for mozfile 20:26:46 INFO - Running setup.py install for mozhttpd 20:26:46 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:26:46 INFO - Running setup.py install for mozinfo 20:26:46 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:26:46 INFO - Running setup.py install for mozInstall 20:26:47 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:26:47 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:26:47 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:26:47 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:26:47 INFO - Running setup.py install for mozleak 20:26:47 INFO - Running setup.py install for mozlog 20:26:47 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:26:47 INFO - Running setup.py install for moznetwork 20:26:47 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:26:47 INFO - Running setup.py install for mozprocess 20:26:47 INFO - Running setup.py install for mozprofile 20:26:47 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:26:47 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:26:47 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:26:47 INFO - Running setup.py install for mozrunner 20:26:47 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:26:47 INFO - Running setup.py install for mozscreenshot 20:26:47 INFO - Running setup.py install for moztest 20:26:47 INFO - Running setup.py install for mozversion 20:26:48 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:26:48 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:26:48 INFO - Cleaning up... 20:26:48 INFO - Return code: 0 20:26:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:26: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')]} 20:26:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:26:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:26: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')]} 20:26:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:26:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:26:48 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 0x7f568ea6cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1861ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x185ef60>, '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 0x185fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18601d0>, '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': 'db0483c52d987ecb441a263b000001ad-1477535160.768477-1998318446', '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 20:26:48 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 20:26:48 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 20:26:48 INFO - Using env: {'DISPLAY': ':0', 20:26:48 INFO - 'HOME': '/home/cltbld', 20:26:48 INFO - 'LANG': 'en_US.UTF-8', 20:26:48 INFO - 'LANGUAGE': 'en_US:en', 20:26:48 INFO - 'LOGNAME': 'cltbld', 20:26:48 INFO - 'MAIL': '/var/mail/cltbld', 20:26:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:26:48 INFO - 'MOZ_NO_REMOTE': '1', 20:26:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:26:48 INFO - 'NO_EM_RESTART': '1', 20:26:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:26:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:26:48 INFO - 'PWD': '/builds/slave/test', 20:26:48 INFO - 'SHELL': '/bin/bash', 20:26:48 INFO - 'SHLVL': '1', 20:26:48 INFO - 'TERM': 'linux', 20:26:48 INFO - 'TMOUT': '86400', 20:26:48 INFO - 'USER': 'cltbld', 20:26:48 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1477535160.768477-1998318446', 20:26:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:26:48 INFO - '_': '/tools/buildbot/bin/python'} 20:26:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:26:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:26:48 INFO - Running setup.py (path:/tmp/pip-_SF43O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:26:48 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)) 20:26:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:26:48 INFO - Running setup.py (path:/tmp/pip-7aTlf7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:26:48 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)) 20:26:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:26:48 INFO - Running setup.py (path:/tmp/pip-qiDHhk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:26:48 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)) 20:26:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:26:48 INFO - Running setup.py (path:/tmp/pip-K1pXeq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:26:48 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)) 20:26:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:26:48 INFO - Running setup.py (path:/tmp/pip-jllNc9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:26:48 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)) 20:26:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:26:48 INFO - Running setup.py (path:/tmp/pip-iNFkKt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:26:48 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)) 20:26:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:26:48 INFO - Running setup.py (path:/tmp/pip-aCVq6l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:26:48 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)) 20:26:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:26:48 INFO - Running setup.py (path:/tmp/pip-U5gPv5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:26:48 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)) 20:26:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:26:48 INFO - Running setup.py (path:/tmp/pip-CWxw2V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:26:48 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)) 20:26:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:26:48 INFO - Running setup.py (path:/tmp/pip-dYjCJ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:26:49 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)) 20:26:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:26:49 INFO - Running setup.py (path:/tmp/pip-tA7XdI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:26:49 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)) 20:26:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:26:49 INFO - Running setup.py (path:/tmp/pip-wHKKqm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:26:49 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)) 20:26:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:26:49 INFO - Running setup.py (path:/tmp/pip-rZLgTd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:26:49 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)) 20:26:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:26:49 INFO - Running setup.py (path:/tmp/pip-M_jeSJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:26:49 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)) 20:26:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:26:49 INFO - Running setup.py (path:/tmp/pip-jOzEVv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:26:49 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)) 20:26:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:26:49 INFO - Running setup.py (path:/tmp/pip-foHpCm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:26:49 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)) 20:26:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:26:49 INFO - Running setup.py (path:/tmp/pip-hBm2KK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:26:49 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)) 20:26:49 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)) 20:26:49 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)) 20:26:49 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)) 20:26:49 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)) 20:26:49 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)) 20:26:49 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:26: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 20:26: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 20:26: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 20:26: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 20:26: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 20:26: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 20:26:51 INFO - Downloading blessings-1.6.tar.gz 20:26:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:26:51 INFO - Installing collected packages: blessings 20:26:51 INFO - Running setup.py install for blessings 20:26:51 INFO - Successfully installed blessings 20:26:51 INFO - Cleaning up... 20:26:51 INFO - Return code: 0 20:26:51 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:26:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:26:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:26:51 INFO - Reading from file tmpfile_stdout 20:26:51 INFO - Current package versions: 20:26:51 INFO - argparse == 1.2.1 20:26:51 INFO - blessings == 1.6 20:26:51 INFO - blobuploader == 1.2.4 20:26:51 INFO - docopt == 0.6.1 20:26:51 INFO - functools32 == 3.2.3-2 20:26:51 INFO - jsonschema == 2.5.1 20:26:51 INFO - manifestparser == 1.1 20:26:51 INFO - mozInstall == 1.12 20:26:51 INFO - mozcrash == 0.17 20:26:51 INFO - mozdebug == 0.1 20:26:51 INFO - mozdevice == 0.48 20:26:51 INFO - mozfile == 1.2 20:26:51 INFO - mozhttpd == 0.7 20:26:51 INFO - mozinfo == 0.9 20:26:51 INFO - mozleak == 0.1 20:26:51 INFO - mozlog == 3.4 20:26:51 INFO - moznetwork == 0.27 20:26:51 INFO - mozprocess == 0.23 20:26:51 INFO - mozprofile == 0.28 20:26:51 INFO - mozrunner == 6.12 20:26:51 INFO - mozscreenshot == 0.1 20:26:51 INFO - mozsystemmonitor == 0.3 20:26:51 INFO - moztest == 0.7 20:26:51 INFO - mozversion == 1.4 20:26:51 INFO - psutil == 3.1.1 20:26:51 INFO - requests == 1.2.3 20:26:51 INFO - wsgiref == 0.1.2 20:26:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:26:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:26:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:26:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:26:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:26:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:26:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:26:51 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 0x7f568ea6cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1861ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x185ef60>, '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 0x185fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18601d0>, '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': 'db0483c52d987ecb441a263b000001ad-1477535160.768477-1998318446', '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 20:26:51 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 20:26:51 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 20:26:51 INFO - Using env: {'DISPLAY': ':0', 20:26:51 INFO - 'HOME': '/home/cltbld', 20:26:51 INFO - 'LANG': 'en_US.UTF-8', 20:26:51 INFO - 'LANGUAGE': 'en_US:en', 20:26:51 INFO - 'LOGNAME': 'cltbld', 20:26:51 INFO - 'MAIL': '/var/mail/cltbld', 20:26:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:26:51 INFO - 'MOZ_NO_REMOTE': '1', 20:26:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:26:51 INFO - 'NO_EM_RESTART': '1', 20:26:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:26:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:26:51 INFO - 'PWD': '/builds/slave/test', 20:26:51 INFO - 'SHELL': '/bin/bash', 20:26:51 INFO - 'SHLVL': '1', 20:26:51 INFO - 'TERM': 'linux', 20:26:51 INFO - 'TMOUT': '86400', 20:26:51 INFO - 'USER': 'cltbld', 20:26:51 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1477535160.768477-1998318446', 20:26:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:26:51 INFO - '_': '/tools/buildbot/bin/python'} 20:26:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:26:52 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)) 20:26:52 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)) 20:26:52 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)) 20:26:52 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)) 20:26:52 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)) 20:26:52 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)) 20:26:52 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)) 20:26:52 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)) 20:26:52 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)) 20:26:52 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)) 20:26:52 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)) 20:26:52 INFO - Cleaning up... 20:26:52 INFO - Return code: 0 20:26:52 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:26: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')]} 20:26:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:26:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:26: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')]} 20:26:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:26:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:26:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f568ea6cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1861ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x185ef60>, '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 0x185fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18601d0>, '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': 'db0483c52d987ecb441a263b000001ad-1477535160.768477-1998318446', '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 20:26:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 20:26:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 20:26:52 INFO - Using env: {'DISPLAY': ':0', 20:26:52 INFO - 'HOME': '/home/cltbld', 20:26:52 INFO - 'LANG': 'en_US.UTF-8', 20:26:52 INFO - 'LANGUAGE': 'en_US:en', 20:26:52 INFO - 'LOGNAME': 'cltbld', 20:26:52 INFO - 'MAIL': '/var/mail/cltbld', 20:26:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:26:52 INFO - 'MOZ_NO_REMOTE': '1', 20:26:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:26:52 INFO - 'NO_EM_RESTART': '1', 20:26:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:26:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:26:52 INFO - 'PWD': '/builds/slave/test', 20:26:52 INFO - 'SHELL': '/bin/bash', 20:26:52 INFO - 'SHLVL': '1', 20:26:52 INFO - 'TERM': 'linux', 20:26:52 INFO - 'TMOUT': '86400', 20:26:52 INFO - 'USER': 'cltbld', 20:26:52 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1477535160.768477-1998318446', 20:26:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:26:52 INFO - '_': '/tools/buildbot/bin/python'} 20:26:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:26:52 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 20:26:52 INFO - Cleaning up... 20:26:52 INFO - Return code: 0 20:26:52 INFO - Running post-action listener: _resource_record_post_action 20:26:52 INFO - Running post-action listener: _start_resource_monitoring 20:26:52 INFO - Starting resource monitoring. 20:26:52 INFO - [mozharness: 2016-10-27 03:26:52.446901Z] Finished create-virtualenv step (success) 20:26:52 INFO - [mozharness: 2016-10-27 03:26:52.447407Z] Running install step. 20:26:52 INFO - Running pre-action listener: _resource_record_pre_action 20:26:52 INFO - Running main action method: install 20:26:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:26:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:26:52 INFO - Reading from file tmpfile_stdout 20:26:52 INFO - Detecting whether we're running mozinstall >=1.0... 20:26:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:26:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:26:52 INFO - Reading from file tmpfile_stdout 20:26:52 INFO - Output received: 20:26:52 INFO - Usage: mozinstall [options] installer 20:26:52 INFO - Options: 20:26:52 INFO - -h, --help show this help message and exit 20:26:52 INFO - -d DEST, --destination=DEST 20:26:52 INFO - Directory to install application into. [default: 20:26:52 INFO - "/builds/slave/test"] 20:26:52 INFO - --app=APP Application being installed. [default: firefox] 20:26:52 INFO - mkdir: /builds/slave/test/build/application 20:26:52 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'] 20:26:52 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 20:27:08 INFO - Reading from file tmpfile_stdout 20:27:08 INFO - Output received: 20:27:08 INFO - /builds/slave/test/build/application/firefox/firefox 20:27:08 INFO - Running post-action listener: _resource_record_post_action 20:27:08 INFO - [mozharness: 2016-10-27 03:27:08.769486Z] Finished install step (success) 20:27:08 INFO - [mozharness: 2016-10-27 03:27:08.769735Z] Running run-tests step. 20:27:08 INFO - Running pre-action listener: _resource_record_pre_action 20:27:08 INFO - Running main action method: run_tests 20:27:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:27:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:27:08 INFO - Python 2.7.3 20:27:08 INFO - Return code: 0 20:27:08 INFO - grabbing minidump binary from tooltool 20:27:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:27:08 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 0x185ef60>, '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 0x185fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18601d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:27:08 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 20:27:08 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 20:27:08 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 20:27:08 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:27:08 INFO - Return code: 0 20:27:08 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 20:27:08 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:27:08 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:27:08 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 20:27:08 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:27:08 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/Jc9RvSmITg2V7jssLw8ggw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-031', '--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 20:27:08 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/Jc9RvSmITg2V7jssLw8ggw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-031 --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 20:27:08 INFO - Using env: {'DISPLAY': ':0', 20:27:08 INFO - 'HOME': '/home/cltbld', 20:27:08 INFO - 'LANG': 'en_US.UTF-8', 20:27:08 INFO - 'LANGUAGE': 'en_US:en', 20:27:08 INFO - 'LOGNAME': 'cltbld', 20:27:08 INFO - 'MAIL': '/var/mail/cltbld', 20:27:08 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:27:08 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 20:27:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:27:08 INFO - 'MOZ_NO_REMOTE': '1', 20:27:08 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:27:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:27:08 INFO - 'NO_EM_RESTART': '1', 20:27:08 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:27:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:27:08 INFO - 'PWD': '/builds/slave/test', 20:27:08 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:27:08 INFO - 'SHELL': '/bin/bash', 20:27:08 INFO - 'SHLVL': '1', 20:27:08 INFO - 'TERM': 'linux', 20:27:08 INFO - 'TMOUT': '86400', 20:27:08 INFO - 'USER': 'cltbld', 20:27:08 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1477535160.768477-1998318446', 20:27:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:27:08 INFO - '_': '/tools/buildbot/bin/python'} 20:27:08 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/Jc9RvSmITg2V7jssLw8ggw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-031', '--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 20:27:09 INFO - mozversion application_buildid: 20161026184134 20:27:09 INFO - mozversion application_changeset: 3f4c3a3cabaf94958834d3a8935adfb4a887942d 20:27:09 INFO - mozversion application_display_name: Nightly 20:27:09 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:27:09 INFO - mozversion application_name: Firefox 20:27:09 INFO - mozversion application_remotingname: firefox 20:27:09 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 20:27:09 INFO - mozversion application_vendor: Mozilla 20:27:09 INFO - mozversion application_version: 52.0a1 20:27:09 INFO - mozversion platform_buildid: 20161026184134 20:27:09 INFO - mozversion platform_changeset: 3f4c3a3cabaf94958834d3a8935adfb4a887942d 20:27:09 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 20:27:09 INFO - mozversion platform_version: 52.0a1 20:27:09 INFO - using testdate: 1477538829 20:27:09 INFO - actual date: 1477538829 20:27:09 INFO - starting webserver on 'localhost:35098' 20:27:09 INFO - SUITE-START | Running 2 tests 20:27:09 INFO - TEST-START | dromaeo_css 20:27:09 INFO - operating with platform_type : linux_ 20:27:09 INFO - Initialising browser for dromaeo_css test... 20:27:09 INFO - TEST-INFO | started process 1277 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAwBJzJ/profile http://localhost:35098/getInfo.html) 20:27:13 INFO - PROCESS | 1277 | __metrics Screen width/height:1600/1200 20:27:13 INFO - PROCESS | 1277 | colorDepth:24 20:27:13 INFO - PROCESS | 1277 | Browser inner width/height: 1024/697 20:27:13 INFO - PROCESS | 1277 | __metrics 20:27:14 INFO - PROCESS | 1277 | 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" 20:27:14 INFO - PROCESS | 1277 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:27:14 INFO - PROCESS | 1277 | console.error: PushService: 20:27:14 INFO - PROCESS | 1277 | stateChangeProcessEnqueue: Error transitioning state 20:27:14 INFO - PROCESS | 1277 | UnknownError 20:27:15 INFO - TEST-INFO | 1277: exit 0 20:27:15 INFO - Browser initialized. 20:27:15 INFO - Running cycle 1/1 for dromaeo_css test... 20:27:15 INFO - TEST-INFO | started process 1359 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAwBJzJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:27:27 INFO - PROCESS | 1359 | RSS: Main: 173981696 20:27:27 INFO - PROCESS | 1359 | 20:28:18 INFO - PROCESS | 1359 | 1477538898882 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] 20:30:33 INFO - PROCESS | 1359 | Cycle 1(1): loaded http://localhost:35098/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35098/tests/dromaeo/cssquery-ext.html) 20:30:34 INFO - PROCESS | 1359 | RSS: Main: 269410304 20:30:34 INFO - PROCESS | 1359 | 20:33:36 INFO - PROCESS | 1359 | Cycle 1(1): loaded http://localhost:35098/tests/dromaeo/cssquery-ext.html (next: http://localhost:35098/tests/dromaeo/cssquery-jquery.html) 20:33:37 INFO - PROCESS | 1359 | RSS: Main: 270307328 20:33:37 INFO - PROCESS | 1359 | 20:36:39 INFO - PROCESS | 1359 | Cycle 1(1): loaded http://localhost:35098/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35098/tests/dromaeo/cssquery-mootools.html) 20:36:40 INFO - PROCESS | 1359 | RSS: Main: 214376448 20:36:40 INFO - PROCESS | 1359 | 20:39:42 INFO - PROCESS | 1359 | Cycle 1(1): loaded http://localhost:35098/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35098/tests/dromaeo/cssquery-prototype.html) 20:39:43 INFO - PROCESS | 1359 | RSS: Main: 243425280 20:39:43 INFO - PROCESS | 1359 | 20:42:46 INFO - PROCESS | 1359 | Cycle 1(1): loaded http://localhost:35098/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35098/tests/dromaeo/cssquery-yui.html) 20:42:47 INFO - PROCESS | 1359 | RSS: Main: 214966272 20:42:47 INFO - PROCESS | 1359 | 20:45:50 INFO - PROCESS | 1359 | Cycle 1(1): loaded http://localhost:35098/tests/dromaeo/cssquery-yui.html (next: http://localhost:35098/tests/dromaeo/cssquery-dojo.html) 20:45:50 INFO - PROCESS | 1359 | RSS: Main: 299298816 20:45:50 INFO - PROCESS | 1359 | 20:45:50 INFO - PROCESS | 1359 | __start_tp_report 20:45:50 INFO - PROCESS | 1359 | _x_x_mozilla_page_load 20:45:50 INFO - PROCESS | 1359 | _x_x_mozilla_page_load_details 20:45:50 INFO - PROCESS | 1359 | |i|pagename|runs| 20:45:50 INFO - PROCESS | 1359 | |0;dojo.html;2525.1666949906535;2556.884940177692;2562.295368773587;2594.1439325022743;2609.660744103266;4447.310666846636;4521.050579378326;4524.954750452494;4545.909081818366;4549.567791059848;4495.527969563198;4518.141553104908;4528.388667529883;4561.1105834362315;4608.769561521919;4151.730137541065;4178.080822219107;4208.200441916041;4232.576742325774;4245.150969806051;4158.168366326731;4218.282891908383;4265.7014009019385;4287.228298906196;4287.8284868605215;4270.636995855356;4278.700490965633;4285.935710964338;4305.268104422255;4332.935005974913;4107.342825147962;4135.152293779768;4143;4164.875053748392;4199.622034016953;4132.318167502359;4172.624463798243;4176.248275310443;4201.1807697499;4203.495580530356;4446.710963787344;4467.039586488921;4467.910641787179;4606.700564463299;4624.468186158568;4751.40607424072;4759.643026772971;4761.785719642589;4765.356676848615;4766.404199475066;4652.325412815157;4700.694454860457;4767.094252092126;4776.689515181537;4832.661713680044;4501.819927202875;4564.292534657134;4581.74800385982;4581.908361832811;4586.656000799953;4942;4981.90036199274;4998.225275082368;5004.374453193351;5047.268146118792;4609.976950115228;4661.766911654404;4804.711717296974;4808.567228949411;4876.244182151772;4771.069641419959;4779.330893674888;4791.592714619227;4811.326414302001;4888.951110488921;4770.499097594772;4782.473927867932;4786.473487916326;4788.162071637519;4844.636652251095;4756.072565849626;4758.214894542361;4771.809127634856;4772.880677983078;4824.0834241494;3927.3912543555793;3958.6635136013188;3959.1883663848844;3966.662833659171;4010.839566417369;3525.383057964846;3550.804705741209;3584.1398064464342;3599.766015209003;3632.854685812538;4226.070264541796;4231.386448964883;4232.513260974965;4282.721623094489;4286.507051689034;4729.69256998294;4775.116603428308;4775.71345719258;4846.030793841246;4879.975600122048;4229.513605935357;4239.894002649959;4252.978735106305;4254.170436764863;4285.121550082225;4299.656027517791;4311.590398912098;4318.157959197989;4365.628921541641;4371.256886329332;4483.170613436525;4494.5505449454795;4610.95389046112;4621.1219868224925;4621.884452888705;4783.497732738151;4815.470298267118;4824.807007719652;4828.179209534458;4904.362432883702;4631.490536040966;4646.86059418218;4648.511906249931;4648.697834640738;4697.389339385858;4794.041191761731;4795.808167673394;4798.1123492154065;4800.183968725255;4859.052484765437;4736.265878788793;4788.401449818773;4812.51874812516;4815.903681926272;4862.805487780449;4712.104700107106;4714;4715;4767.451743049455;4796.376471058879;4701.247800351927;4749.620030397629;4752.881177970578;4753.2157194063975;4811.591014763784;4542.295944128666;4542.772861356852;4586.495485496526;4596.563326483979;4681.344611754425;4736.455307639666;4736.976315118402;4752.714837109785;4784.6889952153;4802;4496.437945256843;4533.501314855297;4640.396748422683;4692.694974826625;4703.223968045234 20:45:50 INFO - PROCESS | 1359 | |1;ext.html;554.3863251373133;560.8233406476962;574.4169667787197;576.2623841482904;598.3029770317579;28592;40072;41050.17899642005;41152.79423602885;41162.17675646493;41175;41686.58313416865;41689.791551042275;41696.58303416965;41733.37399938996;7783.494072885259;7934.44458887878;7934.523928564276;7936.325412339958;7940.682372705085;7692.153863075086;7770.766876993699;7777.5333479991095;7781.844363112735;7784.961075194616;7767.223277672216;7811.492253003565;7818.765437036869;7826.334761545276;7831.68673253072;7763.417743669219;7801.4929029612895;7805.414593905423;7806.72676456327;7807.609619519001;7728.922710772877;7797.883031754528;7798.571078590675;7799.1031031430975;7803.453758236926;39491.21017579661;39691.20617587632;39844;39861.40207896884;39892.40161397582;2947.7641788656856;3158.3209609933747;3271.705546500826;3309.040378290293;3458;28275.85862070697;28544.571831422545;29001.85499072491;29177.124686259445;29315.853420732972;3178.586783718125;3184.7292980096718;3288.2437039480815;3323.019709185796;3341.064501939461;249416;249805.9999999982;252437;252656;252679;54557.45442545603;54970.450295497336;55026;55027.724861375435;55087.724561376934;57910;58091.70954145202;58098.12331903587;58160.4183958155;58185;14625.488107916384;14912.179830109448;14938.32777525014;14943;14946.32741526634;11546.076313894868;11585.189036767513;11610.94194529022;11611.419429028514;11633.47649355781;16728;17351;17376.565585860455;17390.56523586895;17502.737458938125;5709.3434255060365;5749.338826034976;5878.500327472213;5880.852978675567;5903.173555702205;642.9389208025231;674.2482132422314;719.3561762222781;784.5841703896943;829.3986859526794;28280.29299267535;28418.431631367257;28733.041804098375;28953;29236.853815730785;934.8971613122551;954.6324665003884;1006.3559322033905;1012.4330374990029;1051.81593221186;14201.857981420053;15007.624809379635;15126.319315630823;15266.542003739905;15385.38458461649;344156;348793;349538;350168;351357;49953;50015.49984500181;50087.24869126966;50121.74939125354;50229.74885125551;1063.5958335832488;1094.715374002765;1167.10716302029;1198.2451055834767;1207.8007128823647;27918.581221281293;29208.415831683673;29257.268568285963;29680.40639187161;30152.547711783904;43130.78434607932;43246.351304729826;43447;43529.56470435255;43976.12047759091;263448;264994;265216;266254;266882;24305.51388972246;24927.127550535643;25134.49731005333;26053.348666283495;26147.08485203085;42524.36213456739;44935.77532112318;45477.317840231764;45518.77240613776;46736.29895551637;36379.09052273714;36551;36598.451023235204;36949;37015.629843701216;35738.28523429465;36506.8174659125;36957;37349.25301494009;37821.810890945366;35705;35843.82078089593;36327.27345453023;36442.8177859109;37348.62651373452;31329.686703132676;33235.33529329448;33495.66504335023;33610.83194584012;34134.65865341315;24939.625905611792;25303;25423.36441588975;25694.229173124837;25827.870860645577 20:45:50 INFO - PROCESS | 1359 | |2;jquery.html;338.4313063845413;357.8854766474729;365.6526300014986;367.67460797194474;382.92532956073575;12558.623241302765;16085.83914160858;16393.180340982948;17424.30302787887;17513.649727005453;16792.83207167928;16928.492145235632;17324.307027718907;17472.912635436838;17533.298668053263;4933.45731969483;4964.255361695738;5156.355455568054;5172.974135129319;5177.32694749682;5054.368203974504;5153.201253805666;6667.166604174478;6947.617881016542;6948.687309071104;6852.828679283033;6948.895766563505;7087.18497372801;7092.468064895128;7101.609411482366;6857.58854468731;6895.241523432418;6915.688794004282;6929.445644348465;7072.434205263567;6636.170478690164;6808.421284190849;6865.935779954115;6872.278410766898;6877.6217308048035;21723.29187425358;23367.18214862489;23399.298021059225;23629.29112126639;23674.64488032681;1894.7157926311027;1902.961940761177;1910.5414700471927;2059.4645392197986;2206.8675879447283;13465.730685386237;14038.782484304127;14282.428702851874;14590.489332873405;15138.848611513964;1757.253167403861;1814.1201517264117;1841.8802777819399;1897.6584214841462;1914.4543805015644;76087;76300;77841;78352;80152;16136.596585085466;16267.430639927547;16439.83560164383;16499.917500412423;16896.32414703398;28567.28581785472;28690.282742931595;28741.85629071883;28788.712112878602;28882.711172888423;8461.95769021151;8789.384743067923;9029.097090290918;9168.083191680911;9209.815803683889;7134.785956421316;7223.530470519399;7272.709091636381;7375.88936165958;7579.810504737426;8046.396520261003;8189.590520474072;8246.711365102192;8369.832603347899;8526.78683032929;3141.4659507883716;3154.8293964565464;3209.871605135815;3317.495291055286;3418.3421040795192;740.7407407407364;781.9491733037335;846.2045677063663;935.830858701401;967.1295833749682;15852.603684907739;16559.503214903572;17113.828861711223;17323.22045507955;17377.826221737872;831.3889291370838;852.5225873510853;866.1252135343223;871.5903525343078;873.1574031060057;7613.352865006425;9086.591103400362;9429.339946203838;9484.19384352324;9686;264341;265602;337345;339205;340181;79027.0183820951;79028;80120.59939700265;80880;83423.16576834154;908.2098574240321;911.1617312072909;911.4303560274828;912.5710915869531;918.1828172926101;15142.242887855342;15218.16300103505;15426.691466170838;15931.36274549005;16266.837331627006;29408;29686.406271874872;35800.8209958959;36086.45870312;36209.27581448304;45696.77151614221;46885.53114468812;47281;52928.47071529389;53985;7150.96424517874;7232.168300645282;7294.927050729425;7300.269973002657;7392.075109187528;10435;11620.418979051183;11888.524459021888;12020.939895300467;12193.756124877274;9871.901280987098;10235.641752538626;10286.948565257126;10613.787724245318;10625.468726563795;9595.088466595662;9992.500374981077;10010.199184065403;10193.898061019296;10204;10158.746031349276;10219.795604088025;10372.948135259276;10460.529276182438;10551.103156231806;6370;6651.833704157435;6928.099347084847;7109.1824440187975;7754.495957762728;8265.752027439186;9633.855492167482;10098.646547370807;10378.962103789561;10731.839022414513 20:45:50 INFO - PROCESS | 1359 | |3;mootools.html;1212.405921098662;1354.0656946706772;1386.1405928324439;1415.3489394878357;1608.2762756759455;6090.299615544208;6952.339527744863;7153.284671532851;7161.964190179055;7360.779176624696;7153.24890886456;7183;7193.172785129712;7223.38601218897;7229.4939354245225;2080.625487412265;2101.1175306371283;2103.968440473394;2105.5788842231536;2109.683547467877;2057.4650590846336;2064.587082583482;2081.3235698398007;2140.347194105797;2142.3037512808323;2085.4463424748506;2091.393495886191;2108.736407949006;2110.2614085070254;2119.9364019079453;1954.4722924810292;1996.7204591357222;1998.510364960594;1998.960020799576;2001.8698784578955;2002.9599408011904;2005.1878989009474;2021.242034237161;2031.238285642884;2039.6532589459828;6936.79189624312;7223.783286501413;7224;7297.89053164203;7312.744053958139;4218.367244913257;4403.427554417937;4403.669724770623;4409.316555933835;4413.29387298034;2629.0929629277866;2826.9293267668268;2886.8556572171306;2895.247235718707;2899.4635992341487;915.1397686174975;931.0456781798711;945.6028468043438;961.365498770815;968.5835090910906;9642.903570964341;9757.316987810857;9758.560864761102;9774;9810.411375317504;3760.360738674432;3785.356489396754;3831.214601006787;3901.6098390160755;3922.666573341298;7721.806954826175;7832.099308579473;7840.215978402228;7844.097928738268;7855.253750893656;4207.621314081747;4208.347706105558;4208.8316467340965;4209.368594710818;4212.094399704079;3451.2234747181683;3456.827158642058;3856.1902000580194;3870.9419358709642;3926.489556357655;3215.083701145162;3230.9192270193435;3321.6512266212185;3357.8992630221132;3370.376480351143;1003.2876657573205;1023.9129673977646;1028.8508166315992;1036.1192985961873;1042.635077722791;694.2883544367064;824.2540500846743;829.6805729794073;831.3307787231337;846.9322454203649;4627.467841198238;4669.579737823612;4759;4820.4456487503685;5093.949060509348;381.87970789201313;385.88423472958;386.12157342047067;388.233239352277;389.690196293947;3144.5440411140257;3311.850966706504;3326.567546218976;3327.7670563060356;3405.250844814137;8127.2279133482225;8251.381146414044;8467.49195048299;8497.83004339922;8862.069482704352;8704.347173961978;8733.170348816851;8734.563271836383;8735.1701588349;8737.21365077146;6670.533062685662;6711.664416779142;6887.965560172267;6926.619035953071;6936.306369363023;4858.44127925279;4873.707577545359;5103.18349064148;5111.309973153577;5157.226416037624;8031.397645176518;8057.758267251992;8112.878306825521;8146.511209327459;8165;8196.098429172667;8202.138775428733;8247;8361.289290410139;8364.163583641588;5640.88718225625;6046.606970546901;6182.598131121463;6186.721597528212;6191.938080619317;6301.842453938688;6505.154329937078;6512.641804700597;6512.804615861532;6513.283538810632;6127.417895299939;6427.389398007182;6430.903536446864;6476.740930362733;6578.605283682994;6213.813585592439;6316.84207894788;6343.492520598249;6346.111544383883;6358.554901157059;5929.584929054925;6042.486388657014;6047.153398524122;6049;6050.273967123973;4210.873673789792;4224.218519573888;4250.468691413574;4294.506131794884;4372.737635741865;4217.388478670637;4278.379634952977;4290.184864875664;4432.867013989586;4482 20:45:50 INFO - PROCESS | 1359 | |4;prototype.html;297.83916684990095;298.85057471264366;303.0816625624358;306.5922323309998;310.33123618601905;4599.264117741153;4635.953640463595;4759.976200118999;4790.425148982118;4807.543283388081;4558.635309175266;4582.77086145693;4656.5110663380365;4690.718556886589;4713.905721885569;3705.3515634763944;3772.7359084863933;3779.39529675252;3780.168362960158;3788.204477059821;3589.282143571283;3780.3384407728536;3787.3940169572875;3788.5264341957254;3804.733668643196;3474.722022238215;3712.6658600725927;3714.9442758358646;3723.3298006358846;3731.2164445466483;3712.3874560697454;3713.2387860488534;3717.3494638438165;3720.720945929039;3721.869734559291;3282.998685400976;3295.9070989921574;3312.751543634237;3317.369699757063;3324.16895776056;4500.144972455223;4529.456465224162;4564.178447879381;4618.607418369443;4637.142128706167;4232.195882782262;4239.957600423987;4242.469691288589;4244.511881133678;4258.574142585748;4916.877078073041;4917.50824917509;4919.680220785637;4925.876853078666;4933.358663373739;3518.557391469485;3620.420732682758;3622.474741162543;3627.1294889226397;3628.455731640249;5038.118329292396;5056.646034777567;5100.872478188038;5105.82129625465;5131;3685.6130106338983;3693.538307711536;3694.1160008395373;3701.03773019017;3705.7035437164964;3756.2487502499607;3760.7367484276383;3760.9059773505332;3766.7928263945196;3774.6791522720328;4027.899302517402;4173.728707633994;4202.894927626772;4235.1577063977265;4242.766647834337;4904.4605093439695;4920.434150072716;4937.432195297587;4939.604831613462;4942.629302802305;1235.234154824015;1265.1586694848006;1276.4766445757195;1301.4273719563362;1310.377570653951;886.3795343259744;912.7946212102224;913.4199783137756;925.1997022575424;926.6061923682408;4348.130164153906;4368.301071828492;4368.301071828492;4392.275274579659;4399.340098985113;5004.574611158092;5036.219385995103;5048.697078175322;5057.342545469065;5075.1625981712605;4264.211120942574;4422.579854913778;4481.887952801141;4482.503647155224;4500.774961251925;2707.5514599689072;2722.945541089207;2723.400851812598;2724.209979106077;2732.8360298381763;4858.271259311061;4877.292792545132;4887.169181239198;4887.313876712528;4917.950820491821;5073.239014147834;5128.769205385766;5216.921746173811;5254.92117618236;5258.368995720538;4832.251001094836;4861.586765124934;4871.756412179377;4892.363992680928;4900.509949005071;4964.8758781030765;5098.209777484496;5114.718690471911;5119.872003199801;5120.415709003787;4947.332110165082;4953.851384458472;4960.5287497689105;4961.536346777637;4974.651774375904;4831.73425461603;4838.225883858566;4856.798868978379;4861.1979023462145;4877.6585639004925;3563.590187128513;3566.358055549922;3575.76757510761;3576.856925722942;3605.188832512664;4876.731779752147;5062.645614806928;5070.873228169177;5107.489251075011;5121.385433747974;4971.825986090469;4976.950230497649;4990.700557966534;4996.825111121093;4998.3002379667605;4990.078819654386;4994.9750251248515;5000.699818047261;5003.749812509433;5025.597952163891;4698;4806.206975849085;4825.155597770306;4880.829170978998;4953.678010929278;4883.853484395474;4993.3259010034635;4995.725235112103;5015.1474249378425;5019.573336266459;4864.683795553419;4866.464688884291;4877.780499877443;4894.632902532253;4900.730459824744 20:45:50 INFO - PROCESS | 1359 | |5;yui.html;653.7646447278979;666.2105405094962;705.3264132753221;729.8759210934144;738.505201514985;11856.76286474271;12111.636650900487;12186.268823870552;12404.255744655327;12925.418356173972;12264.5707400241;12443.440045197965;12465.563705270317;12483.50065997359;12484.438200280987;630.2279707358472;788.2866006264326;802.1537278171527;805.0138580239189;805.0781854776278;650.1353200243665;783.1581050370875;801.5911884938665;807.3500831830374;812.1796985045117;838.656150978099;841.4614646626164;842.3135144856952;843.1189407069596;846.5301757524571;654.6039646014141;838.4131108224267;838.9412741108125;839.0225387423644;839.1650307943605;496.52085737263354;596.6867394617817;611.5016261746662;611.5688439650036;614.0850133301393;11548.076153907667;11589.536418543332;11590.594329198437;11611.477483513263;11614.477348519336;11817.231879927776;11933.761324773455;12005.699857503545;12384.938075309656;12569.685757856127;10883.619073332475;11137.554497820078;11265.662030139109;11674.1244406669;12363.320017399039;4185.539590645027;4203.096334288112;4221.683373746951;4247.5540068293;4294.162638285536;51263.231051534254;51469.74265128688;51651;51799;52703.945921081744;10225.488725563691;10261.897381026243;10417.270791044553;10455.424951627581;10631.149508039338;18501.7224741629;18591.16339764714;18944.81055189458;19131.61736765285;19154.616907662046;6563.113979612691;6575.112359831362;6682.3317668232785;6693.464522838161;6766.763163289262;3460.325236578843;3614.963850361463;3660.5058317127377;3660.633936606318;3698.4822124902535;2709.363299624626;2782.777377809811;2793.1062060140966;2796.622455968459;2798.398344355973;493.43008824807407;496.43654452196296;496.66226965662975;501.4859768737074;515.2142981952477;460.64070025380255;493.9604831613534;498.185466761847;528.6775067208999;547.5674217368314;6808.9659551701925;6870.7595234166565;6946;7065.788026359218;7068.611226382495;515;534.5776836299358;535.4190703087116;546.0880329849082;558.8993981083363;3332.518251999837;3376.1053320869987;3382.797032178077;3499.807510586942;3534.204803919149;65444.67277663676;66430;70256.64871675608;70556.29443705497;70701.64649176721;62043.689781550805;62329.37670623326;62482.43793905189;62650;62871.6856415715;56634;58198.81520733855;58308;60245.698771505864;60356.39643603508;6179.567430279837;6496.7726129585235;6594.558964525415;6658.5671931324305;6758.763443279461;39460.21079578335;39789.60210397859;40250.79874600608;40679;41091.383629246186;51508.227376590134;53335.733321333144;54386;54588.454115458335;55831.72084139716;9277.6288948444;9556.235501159752;10513.842292365467;10532.684019479428;10575.62985295511;12091.57679481214;12100.636980890587;12701.110922235355;12735.426905789447;12758.362081896053;9517.952410237904;11449.771004579696;11587.420628968686;11615.477303521531;11647.76704465923;11316.773664526829;11395;11478.655640330804;11492.48283827213;11580.6525804226;11067.169962253025;11247.268927519684;11313.20807543497;11325.943370283096;11376.285256107902;8917.866232006396;9123.498207598646;9666.661666841626;9686.75783105428;9718.514074296116;9036.728898133066;9449.864688083431;9632.711018669452;9959.701208963743;10102.24233182529 20:45:50 INFO - PROCESS | 1359 | __end_tp_report 20:45:50 INFO - PROCESS | 1359 | __start_cc_report 20:45:50 INFO - PROCESS | 1359 | _x_x_mozilla_cycle_collect,1021 20:45:50 INFO - PROCESS | 1359 | __end_cc_report 20:45:50 INFO - PROCESS | 1359 | __startTimestamp1477539950416__endTimestamp 20:45:50 INFO - PROCESS | 1359 | 20:45:50 INFO - PROCESS | 1359 | ------- Summary: start ------- 20:45:50 INFO - PROCESS | 1359 | Number of tests: 6 20:45:50 INFO - PROCESS | 1359 | 20:45:50 INFO - PROCESS | 1359 | [#0] dojo.html Cycles:165 Average:4476.50 Median:4609.98 stddev:455.68 (9.9%) stddev-sans-first:430.60 20:45:50 INFO - PROCESS | 1359 | Values: 2525.2 2556.9 2562.3 2594.1 2609.7 4447.3 4521.1 4525.0 4545.9 4549.6 4495.5 4518.1 4528.4 4561.1 4608.8 4151.7 4178.1 4208.2 4232.6 4245.2 4158.2 4218.3 4265.7 4287.2 4287.8 4270.6 4278.7 4285.9 4305.3 4332.9 4107.3 4135.2 4143.0 4164.9 4199.6 4132.3 4172.6 4176.2 4201.2 4203.5 4446.7 4467.0 4467.9 4606.7 4624.5 4751.4 4759.6 4761.8 4765.4 4766.4 4652.3 4700.7 4767.1 4776.7 4832.7 4501.8 4564.3 4581.7 4581.9 4586.7 4942.0 4981.9 4998.2 5004.4 5047.3 4610.0 4661.8 4804.7 4808.6 4876.2 4771.1 4779.3 4791.6 4811.3 4889.0 4770.5 4782.5 4786.5 4788.2 4844.6 4756.1 4758.2 4771.8 4772.9 4824.1 3927.4 3958.7 3959.2 3966.7 4010.8 3525.4 3550.8 3584.1 3599.8 3632.9 4226.1 4231.4 4232.5 4282.7 4286.5 4729.7 4775.1 4775.7 4846.0 4880.0 4229.5 4239.9 4253.0 4254.2 4285.1 4299.7 4311.6 4318.2 4365.6 4371.3 4483.2 4494.6 4611.0 4621.1 4621.9 4783.5 4815.5 4824.8 4828.2 4904.4 4631.5 4646.9 4648.5 4648.7 4697.4 4794.0 4795.8 4798.1 4800.2 4859.1 4736.3 4788.4 4812.5 4815.9 4862.8 4712.1 4714.0 4715.0 4767.5 4796.4 4701.2 4749.6 4752.9 4753.2 4811.6 4542.3 4542.8 4586.5 4596.6 4681.3 4736.5 4737.0 4752.7 4784.7 4802.0 4496.4 4533.5 4640.4 4692.7 4703.2 20:45:50 INFO - PROCESS | 1359 | 20:45:50 INFO - PROCESS | 1359 | [#1] ext.html Cycles:180 Average:45309.26 Median:36528.91 stddev:76440.98 (209.3%) stddev-sans-first:76581.56 20:45:50 INFO - PROCESS | 1359 | Values: 554.4 560.8 574.4 576.3 598.3 28592.0 40072.0 41050.2 41152.8 41162.2 41175.0 41686.6 41689.8 41696.6 41733.4 7783.5 7934.4 7934.5 7936.3 7940.7 7692.2 7770.8 7777.5 7781.8 7785.0 7767.2 7811.5 7818.8 7826.3 7831.7 7763.4 7801.5 7805.4 7806.7 7807.6 7728.9 7797.9 7798.6 7799.1 7803.5 39491.2 39691.2 39844.0 39861.4 39892.4 2947.8 3158.3 3271.7 3309.0 3458.0 28275.9 28544.6 29001.9 29177.1 29315.9 3178.6 3184.7 3288.2 3323.0 3341.1 249416.0 249806.0 252437.0 252656.0 252679.0 54557.5 54970.5 55026.0 55027.7 55087.7 57910.0 58091.7 58098.1 58160.4 58185.0 14625.5 14912.2 14938.3 14943.0 14946.3 11546.1 11585.2 11610.9 11611.4 11633.5 16728.0 17351.0 17376.6 17390.6 17502.7 5709.3 5749.3 5878.5 5880.9 5903.2 642.9 674.2 719.4 784.6 829.4 28280.3 28418.4 28733.0 28953.0 29236.9 934.9 954.6 1006.4 1012.4 1051.8 14201.9 15007.6 15126.3 15266.5 15385.4 344156.0 348793.0 349538.0 350168.0 351357.0 49953.0 50015.5 50087.2 50121.7 50229.7 1063.6 1094.7 1167.1 1198.2 1207.8 27918.6 29208.4 29257.3 29680.4 30152.5 43130.8 43246.4 43447.0 43529.6 43976.1 263448.0 264994.0 265216.0 266254.0 266882.0 24305.5 24927.1 25134.5 26053.3 26147.1 42524.4 44935.8 45477.3 45518.8 46736.3 36379.1 36551.0 36598.5 36949.0 37015.6 35738.3 36506.8 36957.0 37349.3 37821.8 35705.0 35843.8 36327.3 36442.8 37348.6 31329.7 33235.3 33495.7 33610.8 34134.7 24939.6 25303.0 25423.4 25694.2 25827.9 20:45:50 INFO - PROCESS | 1359 | 20:45:50 INFO - PROCESS | 1359 | [#2] jquery.html Cycles:180 Average:23352.52 Median:46291.15 stddev:52201.83 (112.8%) stddev-sans-first:52319.67 20:45:50 INFO - PROCESS | 1359 | Values: 338.4 357.9 365.7 367.7 382.9 12558.6 16085.8 16393.2 17424.3 17513.6 16792.8 16928.5 17324.3 17472.9 17533.3 4933.5 4964.3 5156.4 5173.0 5177.3 5054.4 5153.2 6667.2 6947.6 6948.7 6852.8 6948.9 7087.2 7092.5 7101.6 6857.6 6895.2 6915.7 6929.4 7072.4 6636.2 6808.4 6865.9 6872.3 6877.6 21723.3 23367.2 23399.3 23629.3 23674.6 1894.7 1903.0 1910.5 2059.5 2206.9 13465.7 14038.8 14282.4 14590.5 15138.8 1757.3 1814.1 1841.9 1897.7 1914.5 76087.0 76300.0 77841.0 78352.0 80152.0 16136.6 16267.4 16439.8 16499.9 16896.3 28567.3 28690.3 28741.9 28788.7 28882.7 8462.0 8789.4 9029.1 9168.1 9209.8 7134.8 7223.5 7272.7 7375.9 7579.8 8046.4 8189.6 8246.7 8369.8 8526.8 3141.5 3154.8 3209.9 3317.5 3418.3 740.7 781.9 846.2 935.8 967.1 15852.6 16559.5 17113.8 17323.2 17377.8 831.4 852.5 866.1 871.6 873.2 7613.4 9086.6 9429.3 9484.2 9686.0 264341.0 265602.0 337345.0 339205.0 340181.0 79027.0 79028.0 80120.6 80880.0 83423.2 908.2 911.2 911.4 912.6 918.2 15142.2 15218.2 15426.7 15931.4 16266.8 29408.0 29686.4 35800.8 36086.5 36209.3 45696.8 46885.5 47281.0 52928.5 53985.0 7151.0 7232.2 7294.9 7300.3 7392.1 10435.0 11620.4 11888.5 12020.9 12193.8 9871.9 10235.6 10286.9 10613.8 10625.5 9595.1 9992.5 10010.2 10193.9 10204.0 10158.7 10219.8 10372.9 10460.5 10551.1 6370.0 6651.8 6928.1 7109.2 7754.5 8265.8 9633.9 10098.6 10379.0 10731.8 20:45:50 INFO - PROCESS | 1359 | 20:45:50 INFO - PROCESS | 1359 | [#3] mootools.html Cycles:180 Average:4705.63 Median:4983.83 stddev:2597.87 (52.1%) stddev-sans-first:2591.89 20:45:50 INFO - PROCESS | 1359 | Values: 1212.4 1354.1 1386.1 1415.3 1608.3 6090.3 6952.3 7153.3 7162.0 7360.8 7153.2 7183.0 7193.2 7223.4 7229.5 2080.6 2101.1 2104.0 2105.6 2109.7 2057.5 2064.6 2081.3 2140.3 2142.3 2085.4 2091.4 2108.7 2110.3 2119.9 1954.5 1996.7 1998.5 1999.0 2001.9 2003.0 2005.2 2021.2 2031.2 2039.7 6936.8 7223.8 7224.0 7297.9 7312.7 4218.4 4403.4 4403.7 4409.3 4413.3 2629.1 2826.9 2886.9 2895.2 2899.5 915.1 931.0 945.6 961.4 968.6 9642.9 9757.3 9758.6 9774.0 9810.4 3760.4 3785.4 3831.2 3901.6 3922.7 7721.8 7832.1 7840.2 7844.1 7855.3 4207.6 4208.3 4208.8 4209.4 4212.1 3451.2 3456.8 3856.2 3870.9 3926.5 3215.1 3230.9 3321.7 3357.9 3370.4 1003.3 1023.9 1028.9 1036.1 1042.6 694.3 824.3 829.7 831.3 846.9 4627.5 4669.6 4759.0 4820.4 5093.9 381.9 385.9 386.1 388.2 389.7 3144.5 3311.9 3326.6 3327.8 3405.3 8127.2 8251.4 8467.5 8497.8 8862.1 8704.3 8733.2 8734.6 8735.2 8737.2 6670.5 6711.7 6888.0 6926.6 6936.3 4858.4 4873.7 5103.2 5111.3 5157.2 8031.4 8057.8 8112.9 8146.5 8165.0 8196.1 8202.1 8247.0 8361.3 8364.2 5640.9 6046.6 6182.6 6186.7 6191.9 6301.8 6505.2 6512.6 6512.8 6513.3 6127.4 6427.4 6430.9 6476.7 6578.6 6213.8 6316.8 6343.5 6346.1 6358.6 5929.6 6042.5 6047.2 6049.0 6050.3 4210.9 4224.2 4250.5 4294.5 4372.7 4217.4 4278.4 4290.2 4432.9 4482.0 20:45:50 INFO - PROCESS | 1359 | 20:45:50 INFO - PROCESS | 1359 | [#4] prototype.html Cycles:180 Average:4132.71 Median:4694.36 stddev:1180.53 (25.1%) stddev-sans-first:1148.22 20:45:50 INFO - PROCESS | 1359 | Values: 297.8 298.9 303.1 306.6 310.3 4599.3 4636.0 4760.0 4790.4 4807.5 4558.6 4582.8 4656.5 4690.7 4713.9 3705.4 3772.7 3779.4 3780.2 3788.2 3589.3 3780.3 3787.4 3788.5 3804.7 3474.7 3712.7 3714.9 3723.3 3731.2 3712.4 3713.2 3717.3 3720.7 3721.9 3283.0 3295.9 3312.8 3317.4 3324.2 4500.1 4529.5 4564.2 4618.6 4637.1 4232.2 4240.0 4242.5 4244.5 4258.6 4916.9 4917.5 4919.7 4925.9 4933.4 3518.6 3620.4 3622.5 3627.1 3628.5 5038.1 5056.6 5100.9 5105.8 5131.0 3685.6 3693.5 3694.1 3701.0 3705.7 3756.2 3760.7 3760.9 3766.8 3774.7 4027.9 4173.7 4202.9 4235.2 4242.8 4904.5 4920.4 4937.4 4939.6 4942.6 1235.2 1265.2 1276.5 1301.4 1310.4 886.4 912.8 913.4 925.2 926.6 4348.1 4368.3 4368.3 4392.3 4399.3 5004.6 5036.2 5048.7 5057.3 5075.2 4264.2 4422.6 4481.9 4482.5 4500.8 2707.6 2722.9 2723.4 2724.2 2732.8 4858.3 4877.3 4887.2 4887.3 4918.0 5073.2 5128.8 5216.9 5254.9 5258.4 4832.3 4861.6 4871.8 4892.4 4900.5 4964.9 5098.2 5114.7 5119.9 5120.4 4947.3 4953.9 4960.5 4961.5 4974.7 4831.7 4838.2 4856.8 4861.2 4877.7 3563.6 3566.4 3575.8 3576.9 3605.2 4876.7 5062.6 5070.9 5107.5 5121.4 4971.8 4977.0 4990.7 4996.8 4998.3 4990.1 4995.0 5000.7 5003.7 5025.6 4698.0 4806.2 4825.2 4880.8 4953.7 4883.9 4993.3 4995.7 5015.1 5019.6 4864.7 4866.5 4877.8 4894.6 4900.7 20:45:50 INFO - PROCESS | 1359 | 20:45:50 INFO - PROCESS | 1359 | [#5] yui.html Cycles:180 Average:15021.30 Median:25882.36 stddev:19321.30 (74.7%) stddev-sans-first:19345.38 20:45:50 INFO - PROCESS | 1359 | Values: 653.8 666.2 705.3 729.9 738.5 11856.8 12111.6 12186.3 12404.3 12925.4 12264.6 12443.4 12465.6 12483.5 12484.4 630.2 788.3 802.2 805.0 805.1 650.1 783.2 801.6 807.4 812.2 838.7 841.5 842.3 843.1 846.5 654.6 838.4 838.9 839.0 839.2 496.5 596.7 611.5 611.6 614.1 11548.1 11589.5 11590.6 11611.5 11614.5 11817.2 11933.8 12005.7 12384.9 12569.7 10883.6 11137.6 11265.7 11674.1 12363.3 4185.5 4203.1 4221.7 4247.6 4294.2 51263.2 51469.7 51651.0 51799.0 52703.9 10225.5 10261.9 10417.3 10455.4 10631.1 18501.7 18591.2 18944.8 19131.6 19154.6 6563.1 6575.1 6682.3 6693.5 6766.8 3460.3 3615.0 3660.5 3660.6 3698.5 2709.4 2782.8 2793.1 2796.6 2798.4 493.4 496.4 496.7 501.5 515.2 460.6 494.0 498.2 528.7 547.6 6809.0 6870.8 6946.0 7065.8 7068.6 515.0 534.6 535.4 546.1 558.9 3332.5 3376.1 3382.8 3499.8 3534.2 65444.7 66430.0 70256.6 70556.3 70701.6 62043.7 62329.4 62482.4 62650.0 62871.7 56634.0 58198.8 58308.0 60245.7 60356.4 6179.6 6496.8 6594.6 6658.6 6758.8 39460.2 39789.6 40250.8 40679.0 41091.4 51508.2 53335.7 54386.0 54588.5 55831.7 9277.6 9556.2 10513.8 10532.7 10575.6 12091.6 12100.6 12701.1 12735.4 12758.4 9518.0 11449.8 11587.4 11615.5 11647.8 11316.8 11395.0 11478.7 11492.5 11580.7 11067.2 11247.3 11313.2 11325.9 11376.3 8917.9 9123.5 9666.7 9686.8 9718.5 9036.7 9449.9 9632.7 9959.7 10102.2 20:45:50 INFO - PROCESS | 1359 | -------- Summary: end -------- 20:45:50 INFO - PROCESS | 1359 | 20:45:51 INFO - TEST-INFO | 1359: exit 0 20:45:51 INFO - TEST-OK | dromaeo_css | took 1122334ms 20:45:51 INFO - TEST-START | kraken 20:45:51 INFO - operating with platform_type : linux_ 20:45:51 INFO - Initialising browser for kraken test... 20:45:51 INFO - TEST-INFO | started process 1663 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJSdCX8/profile http://localhost:35098/getInfo.html) 20:45:55 INFO - PROCESS | 1663 | __metrics Screen width/height:1600/1200 20:45:55 INFO - PROCESS | 1663 | colorDepth:24 20:45:55 INFO - PROCESS | 1663 | Browser inner width/height: 1024/697 20:45:55 INFO - PROCESS | 1663 | __metrics 20:45:56 INFO - PROCESS | 1663 | 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" 20:45:56 INFO - PROCESS | 1663 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:45:57 INFO - PROCESS | 1663 | console.error: PushService: 20:45:57 INFO - PROCESS | 1663 | stateChangeProcessEnqueue: Error transitioning state 20:45:57 INFO - PROCESS | 1663 | UnknownError 20:45:57 INFO - TEST-INFO | 1663: exit 0 20:45:57 INFO - Browser initialized. 20:45:57 INFO - Running cycle 1/1 for kraken test... 20:45:57 INFO - TEST-INFO | started process 1746 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJSdCX8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:46:10 INFO - PROCESS | 1746 | RSS: Main: 173727744 20:46:10 INFO - PROCESS | 1746 | 20:46:12 INFO - PROCESS | 1746 | Cycle 1(1): loaded http://localhost:35098/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35098/tests/kraken/driver.html?testName=audio-beat-detection) 20:46:13 INFO - PROCESS | 1746 | RSS: Main: 230121472 20:46:13 INFO - PROCESS | 1746 | 20:46:16 INFO - PROCESS | 1746 | Cycle 1(1): loaded http://localhost:35098/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35098/tests/kraken/driver.html?testName=audio-dft) 20:46:17 INFO - PROCESS | 1746 | RSS: Main: 217260032 20:46:17 INFO - PROCESS | 1746 | 20:46:20 INFO - PROCESS | 1746 | Cycle 1(1): loaded http://localhost:35098/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35098/tests/kraken/driver.html?testName=audio-fft) 20:46:20 INFO - PROCESS | 1746 | RSS: Main: 299302912 20:46:20 INFO - PROCESS | 1746 | 20:46:23 INFO - PROCESS | 1746 | Cycle 1(1): loaded http://localhost:35098/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35098/tests/kraken/driver.html?testName=audio-oscillator) 20:46:23 INFO - PROCESS | 1746 | RSS: Main: 210477056 20:46:23 INFO - PROCESS | 1746 | 20:46:25 INFO - PROCESS | 1746 | Cycle 1(1): loaded http://localhost:35098/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35098/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:46:26 INFO - PROCESS | 1746 | RSS: Main: 213217280 20:46:26 INFO - PROCESS | 1746 | 20:46:29 INFO - PROCESS | 1746 | Cycle 1(1): loaded http://localhost:35098/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35098/tests/kraken/driver.html?testName=imaging-darkroom) 20:46:30 INFO - PROCESS | 1746 | RSS: Main: 249430016 20:46:30 INFO - PROCESS | 1746 | 20:46:33 INFO - PROCESS | 1746 | Cycle 1(1): loaded http://localhost:35098/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35098/tests/kraken/driver.html?testName=imaging-desaturate) 20:46:34 INFO - PROCESS | 1746 | RSS: Main: 248401920 20:46:34 INFO - PROCESS | 1746 | 20:46:37 INFO - PROCESS | 1746 | Cycle 1(1): loaded http://localhost:35098/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35098/tests/kraken/driver.html?testName=json-parse-financial) 20:46:37 INFO - PROCESS | 1746 | RSS: Main: 247472128 20:46:37 INFO - PROCESS | 1746 | 20:46:39 INFO - PROCESS | 1746 | Cycle 1(1): loaded http://localhost:35098/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35098/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:46:39 INFO - PROCESS | 1746 | RSS: Main: 210325504 20:46:39 INFO - PROCESS | 1746 | 20:46:41 INFO - PROCESS | 1746 | Cycle 1(1): loaded http://localhost:35098/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35098/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:46:42 INFO - PROCESS | 1746 | RSS: Main: 217493504 20:46:42 INFO - PROCESS | 1746 | 20:46:44 INFO - PROCESS | 1746 | Cycle 1(1): loaded http://localhost:35098/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35098/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:46:45 INFO - PROCESS | 1746 | RSS: Main: 226091008 20:46:45 INFO - PROCESS | 1746 | 20:46:48 INFO - PROCESS | 1746 | Cycle 1(1): loaded http://localhost:35098/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35098/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:46:48 INFO - PROCESS | 1746 | RSS: Main: 235769856 20:46:48 INFO - PROCESS | 1746 | 20:46:51 INFO - PROCESS | 1746 | Cycle 1(1): loaded http://localhost:35098/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35098/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:46:52 INFO - PROCESS | 1746 | RSS: Main: 231378944 20:46:52 INFO - PROCESS | 1746 | 20:46:54 INFO - PROCESS | 1746 | Cycle 1(1): loaded http://localhost:35098/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35098/tests/kraken/driver.html?testName=ai-astar) 20:46:54 INFO - PROCESS | 1746 | RSS: Main: 282546176 20:46:54 INFO - PROCESS | 1746 | 20:46:54 INFO - PROCESS | 1746 | __start_tp_report 20:46:54 INFO - PROCESS | 1746 | _x_x_mozilla_page_load 20:46:54 INFO - PROCESS | 1746 | _x_x_mozilla_page_load_details 20:46:54 INFO - PROCESS | 1746 | |i|pagename|runs| 20:46:54 INFO - PROCESS | 1746 | |0;ai-astar;106;113;114;113;114;115;113;112;114;113 20:46:54 INFO - PROCESS | 1746 | |1;audio-beat-detection;158;128;134;174;130;130;129;129;163;129 20:46:54 INFO - PROCESS | 1746 | |2;audio-dft;160;160;161;162;161;161;160;163;160;160 20:46:54 INFO - PROCESS | 1746 | |3;audio-fft;75;76;75;114;77;76;77;78;118;76 20:46:54 INFO - PROCESS | 1746 | |4;audio-oscillator;84;84;123;83;84;84;112;83;85;124 20:46:54 INFO - PROCESS | 1746 | |5;imaging-gaussian-blur;117;117;116;117;117;116;117;118;118;118 20:46:54 INFO - PROCESS | 1746 | |6;imaging-darkroom;146;148;146;146;146;146;147;146;146;146 20:46:54 INFO - PROCESS | 1746 | |7;imaging-desaturate;86;85;84;84;84;84;85;84;85;84 20:46:54 INFO - PROCESS | 1746 | |8;json-parse-financial;64;62;63;62;62;64;64;64;65;64 20:46:54 INFO - PROCESS | 1746 | |9;json-stringify-tinderbox;65;66;67;66;66;66;66;66;66;66 20:46:54 INFO - PROCESS | 1746 | |10;stanford-crypto-aes;90;83;83;83;82;85;83;86;84;83 20:46:54 INFO - PROCESS | 1746 | |11;stanford-crypto-ccm;141;142;146;142;141;141;152;142;178;140 20:46:54 INFO - PROCESS | 1746 | |12;stanford-crypto-pbkdf2;179;183;176;180;179;177;181;182;181;178 20:46:54 INFO - PROCESS | 1746 | |13;stanford-crypto-sha256-iterative;72;72;71;72;71;72;71;72;71;70 20:46:54 INFO - PROCESS | 1746 | __end_tp_report 20:46:54 INFO - PROCESS | 1746 | __start_cc_report 20:46:54 INFO - PROCESS | 1746 | _x_x_mozilla_cycle_collect,2002 20:46:54 INFO - PROCESS | 1746 | __end_cc_report 20:46:54 INFO - PROCESS | 1746 | __startTimestamp1477540014506__endTimestamp 20:46:54 INFO - PROCESS | 1746 | 20:46:54 INFO - PROCESS | 1746 | ------- Summary: start ------- 20:46:54 INFO - PROCESS | 1746 | Number of tests: 14 20:46:54 INFO - PROCESS | 1746 | 20:46:54 INFO - PROCESS | 1746 | [#0] ai-astar Cycles:10 Average:112.70 Median:113.50 stddev:2.50 (2.2%) stddev-sans-first:0.88 20:46:54 INFO - PROCESS | 1746 | Values: 106.0 113.0 114.0 113.0 114.0 115.0 113.0 112.0 114.0 113.0 20:46:54 INFO - PROCESS | 1746 | 20:46:54 INFO - PROCESS | 1746 | [#1] audio-beat-detection Cycles:10 Average:140.40 Median:132.00 stddev:17.48 (13.2%) stddev-sans-first:17.34 20:46:54 INFO - PROCESS | 1746 | Values: 158.0 128.0 134.0 174.0 130.0 130.0 129.0 129.0 163.0 129.0 20:46:54 INFO - PROCESS | 1746 | 20:46:54 INFO - PROCESS | 1746 | [#2] audio-dft Cycles:10 Average:160.80 Median:161.00 stddev:1.03 (0.6%) stddev-sans-first:1.05 20:46:54 INFO - PROCESS | 1746 | Values: 160.0 160.0 161.0 162.0 161.0 161.0 160.0 163.0 160.0 160.0 20:46:54 INFO - PROCESS | 1746 | 20:46:54 INFO - PROCESS | 1746 | [#3] audio-fft Cycles:10 Average:84.20 Median:76.00 stddev:16.81 (22.1%) stddev-sans-first:17.50 20:46:54 INFO - PROCESS | 1746 | Values: 75.0 76.0 75.0 114.0 77.0 76.0 77.0 78.0 118.0 76.0 20:46:54 INFO - PROCESS | 1746 | 20:46:54 INFO - PROCESS | 1746 | [#4] audio-oscillator Cycles:10 Average:94.60 Median:84.00 stddev:17.59 (20.9%) stddev-sans-first:18.23 20:46:54 INFO - PROCESS | 1746 | Values: 84.0 84.0 123.0 83.0 84.0 84.0 112.0 83.0 85.0 124.0 20:46:54 INFO - PROCESS | 1746 | 20:46:54 INFO - PROCESS | 1746 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.74 (0.6%) stddev-sans-first:0.78 20:46:54 INFO - PROCESS | 1746 | Values: 117.0 117.0 116.0 117.0 117.0 116.0 117.0 118.0 118.0 118.0 20:46:54 INFO - PROCESS | 1746 | 20:46:54 INFO - PROCESS | 1746 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 20:46:54 INFO - PROCESS | 1746 | Values: 146.0 148.0 146.0 146.0 146.0 146.0 147.0 146.0 146.0 146.0 20:46:54 INFO - PROCESS | 1746 | 20:46:54 INFO - PROCESS | 1746 | [#7] imaging-desaturate Cycles:10 Average:84.50 Median:84.50 stddev:0.71 (0.8%) stddev-sans-first:0.50 20:46:54 INFO - PROCESS | 1746 | Values: 86.0 85.0 84.0 84.0 84.0 84.0 85.0 84.0 85.0 84.0 20:46:54 INFO - PROCESS | 1746 | 20:46:54 INFO - PROCESS | 1746 | [#8] json-parse-financial Cycles:10 Average:63.40 Median:64.00 stddev:1.07 (1.7%) stddev-sans-first:1.12 20:46:54 INFO - PROCESS | 1746 | Values: 64.0 62.0 63.0 62.0 62.0 64.0 64.0 64.0 65.0 64.0 20:46:54 INFO - PROCESS | 1746 | 20:46:54 INFO - PROCESS | 1746 | [#9] json-stringify-tinderbox Cycles:10 Average:66.00 Median:66.00 stddev:0.47 (0.7%) stddev-sans-first:0.33 20:46:54 INFO - PROCESS | 1746 | Values: 65.0 66.0 67.0 66.0 66.0 66.0 66.0 66.0 66.0 66.0 20:46:54 INFO - PROCESS | 1746 | 20:46:54 INFO - PROCESS | 1746 | [#10] stanford-crypto-aes Cycles:10 Average:84.20 Median:83.50 stddev:2.35 (2.8%) stddev-sans-first:1.24 20:46:54 INFO - PROCESS | 1746 | Values: 90.0 83.0 83.0 83.0 82.0 85.0 83.0 86.0 84.0 83.0 20:46:54 INFO - PROCESS | 1746 | 20:46:54 INFO - PROCESS | 1746 | [#11] stanford-crypto-ccm Cycles:10 Average:146.50 Median:142.00 stddev:11.63 (8.2%) stddev-sans-first:12.16 20:46:54 INFO - PROCESS | 1746 | Values: 141.0 142.0 146.0 142.0 141.0 141.0 152.0 142.0 178.0 140.0 20:46:54 INFO - PROCESS | 1746 | 20:46:54 INFO - PROCESS | 1746 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:179.60 Median:180.50 stddev:2.22 (1.2%) stddev-sans-first:2.35 20:46:54 INFO - PROCESS | 1746 | Values: 179.0 183.0 176.0 180.0 179.0 177.0 181.0 182.0 181.0 178.0 20:46:54 INFO - PROCESS | 1746 | 20:46:54 INFO - PROCESS | 1746 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.40 Median:72.00 stddev:0.70 (1.0%) stddev-sans-first:0.71 20:46:54 INFO - PROCESS | 1746 | Values: 72.0 72.0 71.0 72.0 71.0 72.0 71.0 72.0 71.0 70.0 20:46:54 INFO - PROCESS | 1746 | -------- Summary: end -------- 20:46:54 INFO - PROCESS | 1746 | 20:46:55 INFO - TEST-INFO | 1746: exit 0 20:46:55 INFO - TEST-OK | kraken | took 64556ms 20:46:55 INFO - SUITE-END | took 1186s 20:46:56 INFO - Completed test suite (00:19:47) 20:46:56 INFO - javascript benchmark 20:46:56 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2525.1666949906535, 2556.884940177692, 2562.295368773587, 2594.1439325022743, 2609.660744103266, 4447.310666846636, 4521.050579378326, 4524.954750452494, 4545.909081818366, 4549.567791059848, 4495.527969563198, 4518.141553104908, 4528.388667529883, 4561.1105834362315, 4608.769561521919, 4151.730137541065, 4178.080822219107, 4208.200441916041, 4232.576742325774, 4245.150969806051, 4158.168366326731, 4218.282891908383, 4265.7014009019385, 4287.228298906196, 4287.8284868605215, 4270.636995855356, 4278.700490965633, 4285.935710964338, 4305.268104422255, 4332.935005974913, 4107.342825147962, 4135.152293779768, 4143.0, 4164.875053748392, 4199.622034016953, 4132.318167502359, 4172.624463798243, 4176.248275310443, 4201.1807697499, 4203.495580530356, 4446.710963787344, 4467.039586488921, 4467.910641787179, 4606.700564463299, 4624.468186158568, 4751.40607424072, 4759.643026772971, 4761.785719642589, 4765.356676848615, 4766.404199475066, 4652.325412815157, 4700.694454860457, 4767.094252092126, 4776.689515181537, 4832.661713680044, 4501.819927202875, 4564.292534657134, 4581.74800385982, 4581.908361832811, 4586.656000799953, 4942.0, 4981.90036199274, 4998.225275082368, 5004.374453193351, 5047.268146118792, 4609.976950115228, 4661.766911654404, 4804.711717296974, 4808.567228949411, 4876.244182151772, 4771.069641419959, 4779.330893674888, 4791.592714619227, 4811.326414302001, 4888.951110488921, 4770.499097594772, 4782.473927867932, 4786.473487916326, 4788.162071637519, 4844.636652251095, 4756.072565849626, 4758.214894542361, 4771.809127634856, 4772.880677983078, 4824.0834241494, 3927.3912543555793, 3958.6635136013188, 3959.1883663848844, 3966.662833659171, 4010.839566417369, 3525.383057964846, 3550.804705741209, 3584.1398064464342, 3599.766015209003, 3632.854685812538, 4226.070264541796, 4231.386448964883, 4232.513260974965, 4282.721623094489, 4286.507051689034, 4729.69256998294, 4775.116603428308, 4775.71345719258, 4846.030793841246, 4879.975600122048, 4229.513605935357, 4239.894002649959, 4252.978735106305, 4254.170436764863, 4285.121550082225, 4299.656027517791, 4311.590398912098, 4318.157959197989, 4365.628921541641, 4371.256886329332, 4483.170613436525, 4494.5505449454795, 4610.95389046112, 4621.1219868224925, 4621.884452888705, 4783.497732738151, 4815.470298267118, 4824.807007719652, 4828.179209534458, 4904.362432883702, 4631.490536040966, 4646.86059418218, 4648.511906249931, 4648.697834640738, 4697.389339385858, 4794.041191761731, 4795.808167673394, 4798.1123492154065, 4800.183968725255, 4859.052484765437, 4736.265878788793, 4788.401449818773, 4812.51874812516, 4815.903681926272, 4862.805487780449, 4712.104700107106, 4714.0, 4715.0, 4767.451743049455, 4796.376471058879, 4701.247800351927, 4749.620030397629, 4752.881177970578, 4753.2157194063975, 4811.591014763784, 4542.295944128666, 4542.772861356852, 4586.495485496526, 4596.563326483979, 4681.344611754425, 4736.455307639666, 4736.976315118402, 4752.714837109785, 4784.6889952153, 4802.0, 4496.437945256843, 4533.501314855297, 4640.396748422683, 4692.694974826625, 4703.223968045234], "value": 4448.229939014493, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [554.3863251373133, 560.8233406476962, 574.4169667787197, 576.2623841482904, 598.3029770317579, 28592.0, 40072.0, 41050.17899642005, 41152.79423602885, 41162.17675646493, 41175.0, 41686.58313416865, 41689.791551042275, 41696.58303416965, 41733.37399938996, 7783.494072885259, 7934.44458887878, 7934.523928564276, 7936.325412339958, 7940.682372705085, 7692.153863075086, 7770.766876993699, 7777.5333479991095, 7781.844363112735, 7784.961075194616, 7767.223277672216, 7811.492253003565, 7818.765437036869, 7826.334761545276, 7831.68673253072, 7763.417743669219, 7801.4929029612895, 7805.414593905423, 7806.72676456327, 7807.609619519001, 7728.922710772877, 7797.883031754528, 7798.571078590675, 7799.1031031430975, 7803.453758236926, 39491.21017579661, 39691.20617587632, 39844.0, 39861.40207896884, 39892.40161397582, 2947.7641788656856, 3158.3209609933747, 3271.705546500826, 3309.040378290293, 3458.0, 28275.85862070697, 28544.571831422545, 29001.85499072491, 29177.124686259445, 29315.853420732972, 3178.586783718125, 3184.7292980096718, 3288.2437039480815, 3323.019709185796, 3341.064501939461, 249416.0, 249805.9999999982, 252437.0, 252656.0, 252679.0, 54557.45442545603, 54970.450295497336, 55026.0, 55027.724861375435, 55087.724561376934, 57910.0, 58091.70954145202, 58098.12331903587, 58160.4183958155, 58185.0, 14625.488107916384, 14912.179830109448, 14938.32777525014, 14943.0, 14946.32741526634, 11546.076313894868, 11585.189036767513, 11610.94194529022, 11611.419429028514, 11633.47649355781, 16728.0, 17351.0, 17376.565585860455, 17390.56523586895, 17502.737458938125, 5709.3434255060365, 5749.338826034976, 5878.500327472213, 5880.852978675567, 5903.173555702205, 642.9389208025231, 674.2482132422314, 719.3561762222781, 784.5841703896943, 829.3986859526794, 28280.29299267535, 28418.431631367257, 28733.041804098375, 28953.0, 29236.853815730785, 934.8971613122551, 954.6324665003884, 1006.3559322033905, 1012.4330374990029, 1051.81593221186, 14201.857981420053, 15007.624809379635, 15126.319315630823, 15266.542003739905, 15385.38458461649, 344156.0, 348793.0, 349538.0, 350168.0, 351357.0, 49953.0, 50015.49984500181, 50087.24869126966, 50121.74939125354, 50229.74885125551, 1063.5958335832488, 1094.715374002765, 1167.10716302029, 1198.2451055834767, 1207.8007128823647, 27918.581221281293, 29208.415831683673, 29257.268568285963, 29680.40639187161, 30152.547711783904, 43130.78434607932, 43246.351304729826, 43447.0, 43529.56470435255, 43976.12047759091, 263448.0, 264994.0, 265216.0, 266254.0, 266882.0, 24305.51388972246, 24927.127550535643, 25134.49731005333, 26053.348666283495, 26147.08485203085, 42524.36213456739, 44935.77532112318, 45477.317840231764, 45518.77240613776, 46736.29895551637, 36379.09052273714, 36551.0, 36598.451023235204, 36949.0, 37015.629843701216, 35738.28523429465, 36506.8174659125, 36957.0, 37349.25301494009, 37821.810890945366, 35705.0, 35843.82078089593, 36327.27345453023, 36442.8177859109, 37348.62651373452, 31329.686703132676, 33235.33529329448, 33495.66504335023, 33610.83194584012, 34134.65865341315, 24939.625905611792, 25303.0, 25423.36441588975, 25694.229173124837, 25827.870860645577], "value": 17391.377399226596, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [338.4313063845413, 357.8854766474729, 365.6526300014986, 367.67460797194474, 382.92532956073575, 12558.623241302765, 16085.83914160858, 16393.180340982948, 17424.30302787887, 17513.649727005453, 16792.83207167928, 16928.492145235632, 17324.307027718907, 17472.912635436838, 17533.298668053263, 4933.45731969483, 4964.255361695738, 5156.355455568054, 5172.974135129319, 5177.32694749682, 5054.368203974504, 5153.201253805666, 6667.166604174478, 6947.617881016542, 6948.687309071104, 6852.828679283033, 6948.895766563505, 7087.18497372801, 7092.468064895128, 7101.609411482366, 6857.58854468731, 6895.241523432418, 6915.688794004282, 6929.445644348465, 7072.434205263567, 6636.170478690164, 6808.421284190849, 6865.935779954115, 6872.278410766898, 6877.6217308048035, 21723.29187425358, 23367.18214862489, 23399.298021059225, 23629.29112126639, 23674.64488032681, 1894.7157926311027, 1902.961940761177, 1910.5414700471927, 2059.4645392197986, 2206.8675879447283, 13465.730685386237, 14038.782484304127, 14282.428702851874, 14590.489332873405, 15138.848611513964, 1757.253167403861, 1814.1201517264117, 1841.8802777819399, 1897.6584214841462, 1914.4543805015644, 76087.0, 76300.0, 77841.0, 78352.0, 80152.0, 16136.596585085466, 16267.430639927547, 16439.83560164383, 16499.917500412423, 16896.32414703398, 28567.28581785472, 28690.282742931595, 28741.85629071883, 28788.712112878602, 28882.711172888423, 8461.95769021151, 8789.384743067923, 9029.097090290918, 9168.083191680911, 9209.815803683889, 7134.785956421316, 7223.530470519399, 7272.709091636381, 7375.88936165958, 7579.810504737426, 8046.396520261003, 8189.590520474072, 8246.711365102192, 8369.832603347899, 8526.78683032929, 3141.4659507883716, 3154.8293964565464, 3209.871605135815, 3317.495291055286, 3418.3421040795192, 740.7407407407364, 781.9491733037335, 846.2045677063663, 935.830858701401, 967.1295833749682, 15852.603684907739, 16559.503214903572, 17113.828861711223, 17323.22045507955, 17377.826221737872, 831.3889291370838, 852.5225873510853, 866.1252135343223, 871.5903525343078, 873.1574031060057, 7613.352865006425, 9086.591103400362, 9429.339946203838, 9484.19384352324, 9686.0, 264341.0, 265602.0, 337345.0, 339205.0, 340181.0, 79027.0183820951, 79028.0, 80120.59939700265, 80880.0, 83423.16576834154, 908.2098574240321, 911.1617312072909, 911.4303560274828, 912.5710915869531, 918.1828172926101, 15142.242887855342, 15218.16300103505, 15426.691466170838, 15931.36274549005, 16266.837331627006, 29408.0, 29686.406271874872, 35800.8209958959, 36086.45870312, 36209.27581448304, 45696.77151614221, 46885.53114468812, 47281.0, 52928.47071529389, 53985.0, 7150.96424517874, 7232.168300645282, 7294.927050729425, 7300.269973002657, 7392.075109187528, 10435.0, 11620.418979051183, 11888.524459021888, 12020.939895300467, 12193.756124877274, 9871.901280987098, 10235.641752538626, 10286.948565257126, 10613.787724245318, 10625.468726563795, 9595.088466595662, 9992.500374981077, 10010.199184065403, 10193.898061019296, 10204.0, 10158.746031349276, 10219.795604088025, 10372.948135259276, 10460.529276182438, 10551.103156231806, 6370.0, 6651.833704157435, 6928.099347084847, 7109.1824440187975, 7754.495957762728, 8265.752027439186, 9633.855492167482, 10098.646547370807, 10378.962103789561, 10731.839022414513], "value": 9097.317966860877, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1212.405921098662, 1354.0656946706772, 1386.1405928324439, 1415.3489394878357, 1608.2762756759455, 6090.299615544208, 6952.339527744863, 7153.284671532851, 7161.964190179055, 7360.779176624696, 7153.24890886456, 7183.0, 7193.172785129712, 7223.38601218897, 7229.4939354245225, 2080.625487412265, 2101.1175306371283, 2103.968440473394, 2105.5788842231536, 2109.683547467877, 2057.4650590846336, 2064.587082583482, 2081.3235698398007, 2140.347194105797, 2142.3037512808323, 2085.4463424748506, 2091.393495886191, 2108.736407949006, 2110.2614085070254, 2119.9364019079453, 1954.4722924810292, 1996.7204591357222, 1998.510364960594, 1998.960020799576, 2001.8698784578955, 2002.9599408011904, 2005.1878989009474, 2021.242034237161, 2031.238285642884, 2039.6532589459828, 6936.79189624312, 7223.783286501413, 7224.0, 7297.89053164203, 7312.744053958139, 4218.367244913257, 4403.427554417937, 4403.669724770623, 4409.316555933835, 4413.29387298034, 2629.0929629277866, 2826.9293267668268, 2886.8556572171306, 2895.247235718707, 2899.4635992341487, 915.1397686174975, 931.0456781798711, 945.6028468043438, 961.365498770815, 968.5835090910906, 9642.903570964341, 9757.316987810857, 9758.560864761102, 9774.0, 9810.411375317504, 3760.360738674432, 3785.356489396754, 3831.214601006787, 3901.6098390160755, 3922.666573341298, 7721.806954826175, 7832.099308579473, 7840.215978402228, 7844.097928738268, 7855.253750893656, 4207.621314081747, 4208.347706105558, 4208.8316467340965, 4209.368594710818, 4212.094399704079, 3451.2234747181683, 3456.827158642058, 3856.1902000580194, 3870.9419358709642, 3926.489556357655, 3215.083701145162, 3230.9192270193435, 3321.6512266212185, 3357.8992630221132, 3370.376480351143, 1003.2876657573205, 1023.9129673977646, 1028.8508166315992, 1036.1192985961873, 1042.635077722791, 694.2883544367064, 824.2540500846743, 829.6805729794073, 831.3307787231337, 846.9322454203649, 4627.467841198238, 4669.579737823612, 4759.0, 4820.4456487503685, 5093.949060509348, 381.87970789201313, 385.88423472958, 386.12157342047067, 388.233239352277, 389.690196293947, 3144.5440411140257, 3311.850966706504, 3326.567546218976, 3327.7670563060356, 3405.250844814137, 8127.2279133482225, 8251.381146414044, 8467.49195048299, 8497.83004339922, 8862.069482704352, 8704.347173961978, 8733.170348816851, 8734.563271836383, 8735.1701588349, 8737.21365077146, 6670.533062685662, 6711.664416779142, 6887.965560172267, 6926.619035953071, 6936.306369363023, 4858.44127925279, 4873.707577545359, 5103.18349064148, 5111.309973153577, 5157.226416037624, 8031.397645176518, 8057.758267251992, 8112.878306825521, 8146.511209327459, 8165.0, 8196.098429172667, 8202.138775428733, 8247.0, 8361.289290410139, 8364.163583641588, 5640.88718225625, 6046.606970546901, 6182.598131121463, 6186.721597528212, 6191.938080619317, 6301.842453938688, 6505.154329937078, 6512.641804700597, 6512.804615861532, 6513.283538810632, 6127.417895299939, 6427.389398007182, 6430.903536446864, 6476.740930362733, 6578.605283682994, 6213.813585592439, 6316.84207894788, 6343.492520598249, 6346.111544383883, 6358.554901157059, 5929.584929054925, 6042.486388657014, 6047.153398524122, 6049.0, 6050.273967123973, 4210.873673789792, 4224.218519573888, 4250.468691413574, 4294.506131794884, 4372.737635741865, 4217.388478670637, 4278.379634952977, 4290.184864875664, 4432.867013989586, 4482.0], "value": 3758.2882142378753, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [297.83916684990095, 298.85057471264366, 303.0816625624358, 306.5922323309998, 310.33123618601905, 4599.264117741153, 4635.953640463595, 4759.976200118999, 4790.425148982118, 4807.543283388081, 4558.635309175266, 4582.77086145693, 4656.5110663380365, 4690.718556886589, 4713.905721885569, 3705.3515634763944, 3772.7359084863933, 3779.39529675252, 3780.168362960158, 3788.204477059821, 3589.282143571283, 3780.3384407728536, 3787.3940169572875, 3788.5264341957254, 3804.733668643196, 3474.722022238215, 3712.6658600725927, 3714.9442758358646, 3723.3298006358846, 3731.2164445466483, 3712.3874560697454, 3713.2387860488534, 3717.3494638438165, 3720.720945929039, 3721.869734559291, 3282.998685400976, 3295.9070989921574, 3312.751543634237, 3317.369699757063, 3324.16895776056, 4500.144972455223, 4529.456465224162, 4564.178447879381, 4618.607418369443, 4637.142128706167, 4232.195882782262, 4239.957600423987, 4242.469691288589, 4244.511881133678, 4258.574142585748, 4916.877078073041, 4917.50824917509, 4919.680220785637, 4925.876853078666, 4933.358663373739, 3518.557391469485, 3620.420732682758, 3622.474741162543, 3627.1294889226397, 3628.455731640249, 5038.118329292396, 5056.646034777567, 5100.872478188038, 5105.82129625465, 5131.0, 3685.6130106338983, 3693.538307711536, 3694.1160008395373, 3701.03773019017, 3705.7035437164964, 3756.2487502499607, 3760.7367484276383, 3760.9059773505332, 3766.7928263945196, 3774.6791522720328, 4027.899302517402, 4173.728707633994, 4202.894927626772, 4235.1577063977265, 4242.766647834337, 4904.4605093439695, 4920.434150072716, 4937.432195297587, 4939.604831613462, 4942.629302802305, 1235.234154824015, 1265.1586694848006, 1276.4766445757195, 1301.4273719563362, 1310.377570653951, 886.3795343259744, 912.7946212102224, 913.4199783137756, 925.1997022575424, 926.6061923682408, 4348.130164153906, 4368.301071828492, 4368.301071828492, 4392.275274579659, 4399.340098985113, 5004.574611158092, 5036.219385995103, 5048.697078175322, 5057.342545469065, 5075.1625981712605, 4264.211120942574, 4422.579854913778, 4481.887952801141, 4482.503647155224, 4500.774961251925, 2707.5514599689072, 2722.945541089207, 2723.400851812598, 2724.209979106077, 2732.8360298381763, 4858.271259311061, 4877.292792545132, 4887.169181239198, 4887.313876712528, 4917.950820491821, 5073.239014147834, 5128.769205385766, 5216.921746173811, 5254.92117618236, 5258.368995720538, 4832.251001094836, 4861.586765124934, 4871.756412179377, 4892.363992680928, 4900.509949005071, 4964.8758781030765, 5098.209777484496, 5114.718690471911, 5119.872003199801, 5120.415709003787, 4947.332110165082, 4953.851384458472, 4960.5287497689105, 4961.536346777637, 4974.651774375904, 4831.73425461603, 4838.225883858566, 4856.798868978379, 4861.1979023462145, 4877.6585639004925, 3563.590187128513, 3566.358055549922, 3575.76757510761, 3576.856925722942, 3605.188832512664, 4876.731779752147, 5062.645614806928, 5070.873228169177, 5107.489251075011, 5121.385433747974, 4971.825986090469, 4976.950230497649, 4990.700557966534, 4996.825111121093, 4998.3002379667605, 4990.078819654386, 4994.9750251248515, 5000.699818047261, 5003.749812509433, 5025.597952163891, 4698.0, 4806.206975849085, 4825.155597770306, 4880.829170978998, 4953.678010929278, 4883.853484395474, 4993.3259010034635, 4995.725235112103, 5015.1474249378425, 5019.573336266459, 4864.683795553419, 4866.464688884291, 4877.780499877443, 4894.632902532253, 4900.730459824744], "value": 3763.8592541576486, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [653.7646447278979, 666.2105405094962, 705.3264132753221, 729.8759210934144, 738.505201514985, 11856.76286474271, 12111.636650900487, 12186.268823870552, 12404.255744655327, 12925.418356173972, 12264.5707400241, 12443.440045197965, 12465.563705270317, 12483.50065997359, 12484.438200280987, 630.2279707358472, 788.2866006264326, 802.1537278171527, 805.0138580239189, 805.0781854776278, 650.1353200243665, 783.1581050370875, 801.5911884938665, 807.3500831830374, 812.1796985045117, 838.656150978099, 841.4614646626164, 842.3135144856952, 843.1189407069596, 846.5301757524571, 654.6039646014141, 838.4131108224267, 838.9412741108125, 839.0225387423644, 839.1650307943605, 496.52085737263354, 596.6867394617817, 611.5016261746662, 611.5688439650036, 614.0850133301393, 11548.076153907667, 11589.536418543332, 11590.594329198437, 11611.477483513263, 11614.477348519336, 11817.231879927776, 11933.761324773455, 12005.699857503545, 12384.938075309656, 12569.685757856127, 10883.619073332475, 11137.554497820078, 11265.662030139109, 11674.1244406669, 12363.320017399039, 4185.539590645027, 4203.096334288112, 4221.683373746951, 4247.5540068293, 4294.162638285536, 51263.231051534254, 51469.74265128688, 51651.0, 51799.0, 52703.945921081744, 10225.488725563691, 10261.897381026243, 10417.270791044553, 10455.424951627581, 10631.149508039338, 18501.7224741629, 18591.16339764714, 18944.81055189458, 19131.61736765285, 19154.616907662046, 6563.113979612691, 6575.112359831362, 6682.3317668232785, 6693.464522838161, 6766.763163289262, 3460.325236578843, 3614.963850361463, 3660.5058317127377, 3660.633936606318, 3698.4822124902535, 2709.363299624626, 2782.777377809811, 2793.1062060140966, 2796.622455968459, 2798.398344355973, 493.43008824807407, 496.43654452196296, 496.66226965662975, 501.4859768737074, 515.2142981952477, 460.64070025380255, 493.9604831613534, 498.185466761847, 528.6775067208999, 547.5674217368314, 6808.9659551701925, 6870.7595234166565, 6946.0, 7065.788026359218, 7068.611226382495, 515.0, 534.5776836299358, 535.4190703087116, 546.0880329849082, 558.8993981083363, 3332.518251999837, 3376.1053320869987, 3382.797032178077, 3499.807510586942, 3534.204803919149, 65444.67277663676, 66430.0, 70256.64871675608, 70556.29443705497, 70701.64649176721, 62043.689781550805, 62329.37670623326, 62482.43793905189, 62650.0, 62871.6856415715, 56634.0, 58198.81520733855, 58308.0, 60245.698771505864, 60356.39643603508, 6179.567430279837, 6496.7726129585235, 6594.558964525415, 6658.5671931324305, 6758.763443279461, 39460.21079578335, 39789.60210397859, 40250.79874600608, 40679.0, 41091.383629246186, 51508.227376590134, 53335.733321333144, 54386.0, 54588.454115458335, 55831.72084139716, 9277.6288948444, 9556.235501159752, 10513.842292365467, 10532.684019479428, 10575.62985295511, 12091.57679481214, 12100.636980890587, 12701.110922235355, 12735.426905789447, 12758.362081896053, 9517.952410237904, 11449.771004579696, 11587.420628968686, 11615.477303521531, 11647.76704465923, 11316.773664526829, 11395.0, 11478.655640330804, 11492.48283827213, 11580.6525804226, 11067.169962253025, 11247.268927519684, 11313.20807543497, 11325.943370283096, 11376.285256107902, 8917.866232006396, 9123.498207598646, 9666.661666841626, 9686.75783105428, 9718.514074296116, 9036.728898133066, 9449.864688083431, 9632.711018669452, 9959.701208963743, 10102.24233182529], "value": 6130.460237878569, "unit": "score"}], "name": "dromaeo_css", "value": 6274.82077867181, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 113.0, 114.0, 113.0, 114.0, 115.0, 113.0, 112.0, 114.0, 113.0], "value": 112.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 128.0, 134.0, 174.0, 130.0, 130.0, 129.0, 129.0, 163.0, 129.0], "value": 140.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 161.0, 162.0, 161.0, 161.0, 160.0, 163.0, 160.0, 160.0], "value": 160.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 75.0, 114.0, 77.0, 76.0, 77.0, 78.0, 118.0, 76.0], "value": 84.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 123.0, 83.0, 84.0, 84.0, 112.0, 83.0, 85.0, 124.0], "value": 94.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 117.0, 116.0, 117.0, 118.0, 118.0, 118.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 148.0, 146.0, 146.0, 146.0, 146.0, 147.0, 146.0, 146.0, 146.0], "value": 146.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 84.0, 84.0, 84.0, 84.0, 85.0, 84.0, 85.0, 84.0], "value": 84.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 62.0, 63.0, 62.0, 62.0, 64.0, 64.0, 64.0, 65.0, 64.0], "value": 63.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 67.0, 66.0, 66.0, 66.0, 66.0, 66.0, 66.0, 66.0], "value": 66.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 83.0, 83.0, 83.0, 82.0, 85.0, 83.0, 86.0, 84.0, 83.0], "value": 84.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 142.0, 146.0, 142.0, 141.0, 141.0, 152.0, 142.0, 178.0, 140.0], "value": 146.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [179.0, 183.0, 176.0, 180.0, 179.0, 177.0, 181.0, 182.0, 181.0, 178.0], "value": 179.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 72.0, 71.0, 72.0, 71.0, 72.0, 71.0, 72.0, 71.0, 70.0], "value": 71.4, "unit": "score"}], "name": "kraken", "value": 1551.7, "alertThreshold": 2.0}]} 20:46:56 INFO - Return code: 0 20:46:56 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 20:46:56 INFO - # TBPL SUCCESS # 20:46:56 INFO - Running post-action listener: _resource_record_post_action 20:46:56 INFO - [mozharness: 2016-10-27 03:46:56.308177Z] Finished run-tests step (success) 20:46:56 INFO - Running post-run listener: _resource_record_post_run 20:46:56 INFO - Total resource usage - Wall time: 1203s; CPU: 13.0%; Read bytes: 4096; Write bytes: 401846272; Read time: 16; Write time: 259448 20:46:56 INFO - TinderboxPrint: CPU usage
13.0% 20:46:56 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 20:46:56 INFO - TinderboxPrint: I/O write bytes / time
401,846,272 / 259,448 20:46:56 INFO - TinderboxPrint: CPU idle
8,346.5 (86.9%) 20:46:56 INFO - TinderboxPrint: CPU user
1,203.0 (12.5%) 20:46:56 INFO - TinderboxPrint: Swap in / out
0 / 0 20:46:56 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 110493696; Read time: 0; Write time: 58960 20:46:56 INFO - run-tests - Wall time: 1188s; CPU: 13.0%; Read bytes: 0; Write bytes: 291352576; Read time: 0; Write time: 200488 20:46:56 INFO - Running post-run listener: _upload_blobber_files 20:46:56 INFO - Blob upload gear active. 20:46:56 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:46:56 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 20:46:56 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'] 20:46:56 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 20:46:57 INFO - (blobuploader) - INFO - Open directory for files ... 20:46:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:46:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:46:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:47:00 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:47:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:47:00 INFO - (blobuploader) - INFO - Done attempting. 20:47:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 20:47:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:47:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:47:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 20:47:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:47:01 INFO - (blobuploader) - INFO - Done attempting. 20:47:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 20:47:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:47:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:47:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 20:47:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:47:02 INFO - (blobuploader) - INFO - Done attempting. 20:47:02 INFO - (blobuploader) - INFO - Iteration through files over. 20:47:02 INFO - Return code: 0 20:47:02 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:47:02 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:47:02 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ff72cd2363a01f18290eba71ad68459545ea69b4a42bd3e85a9a545488ffa316c5f444f80bf85f54da02d70554c75afc3293132b1c0f85d5b79bad48fec19fa1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fdff21f9c6a38a356bb194bb3c2e65d1a094176c82d111f00b128eab48f08b9662538b29d657c0dce638d27d7de2352297f762a1f1772091e98d71bf6918c857", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5ca572ded79bbcc641c44f9a647e62febb00d0ceb2be16c1c436c805946b567209a4e1aa49aa50bafb8cb899b53864b08a02e7a318d51367daca0ff6996bfe50"} 20:47:02 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:47:02 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:47:02 INFO - Contents: 20:47:02 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ff72cd2363a01f18290eba71ad68459545ea69b4a42bd3e85a9a545488ffa316c5f444f80bf85f54da02d70554c75afc3293132b1c0f85d5b79bad48fec19fa1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fdff21f9c6a38a356bb194bb3c2e65d1a094176c82d111f00b128eab48f08b9662538b29d657c0dce638d27d7de2352297f762a1f1772091e98d71bf6918c857", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5ca572ded79bbcc641c44f9a647e62febb00d0ceb2be16c1c436c805946b567209a4e1aa49aa50bafb8cb899b53864b08a02e7a318d51367daca0ff6996bfe50"} 20:47:02 INFO - Running post-run listener: copy_logs_to_upload_dir 20:47:02 INFO - Copying logs to upload dir... 20:47:02 INFO - mkdir: /builds/slave/test/build/upload/logs 20:47:02 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1246.517904 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-10-26 20:47:02.409228) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-26 20:47:02.412965) ========= 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=db0483c52d987ecb441a263b000001ad-1477535160.768477-1998318446 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/ff72cd2363a01f18290eba71ad68459545ea69b4a42bd3e85a9a545488ffa316c5f444f80bf85f54da02d70554c75afc3293132b1c0f85d5b79bad48fec19fa1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fdff21f9c6a38a356bb194bb3c2e65d1a094176c82d111f00b128eab48f08b9662538b29d657c0dce638d27d7de2352297f762a1f1772091e98d71bf6918c857", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5ca572ded79bbcc641c44f9a647e62febb00d0ceb2be16c1c436c805946b567209a4e1aa49aa50bafb8cb899b53864b08a02e7a318d51367daca0ff6996bfe50"} build_url:https://queue.taskcluster.net/v1/task/Jc9RvSmITg2V7jssLw8ggw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011490 build_url: 'https://queue.taskcluster.net/v1/task/Jc9RvSmITg2V7jssLw8ggw/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/ff72cd2363a01f18290eba71ad68459545ea69b4a42bd3e85a9a545488ffa316c5f444f80bf85f54da02d70554c75afc3293132b1c0f85d5b79bad48fec19fa1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fdff21f9c6a38a356bb194bb3c2e65d1a094176c82d111f00b128eab48f08b9662538b29d657c0dce638d27d7de2352297f762a1f1772091e98d71bf6918c857", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5ca572ded79bbcc641c44f9a647e62febb00d0ceb2be16c1c436c805946b567209a4e1aa49aa50bafb8cb899b53864b08a02e7a318d51367daca0ff6996bfe50"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-26 20:47:02.439855) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 20:47:02.440217) ========= 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=db0483c52d987ecb441a263b000001ad-1477535160.768477-1998318446 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004490 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 20:47:02.522402) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-26 20:47:02.522746) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-26 20:47:02.523075) ========= ========= Total master_lag: 0.19 =========