builder: cedar_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-008 starttime: 1478601114.99 results: success (0) buildid: 20161108011436 builduid: cb7a98fe92ab414a8e3ca8a23cb727f9 revision: 5993f9fae928a0f18928fe3b48042c85c1a00647 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-08 02:31:54.993657) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-08 02:31:54.994048) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-08 02:31:54.994339) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-08 02:31:55.013339) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-08 02:31:55.013702) ========= 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=32c5991c409366f7fec8a718000001d2-1478600775.545392-238932751 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-08 02:31:55-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 23.2M=0.001s 2016-11-08 02:31:55 (23.2 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.088663 ========= master_lag: 0.30 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-08 02:31:55.403900) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-08 02:31:55.412539) ========= 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=32c5991c409366f7fec8a718000001d2-1478600775.545392-238932751 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015542 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-08 02:31:55.470778) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-08 02:31:55.471124) ========= bash -c 'python archiver_client.py mozharness --repo projects/cedar --rev 5993f9fae928a0f18928fe3b48042c85c1a00647 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/cedar --rev 5993f9fae928a0f18928fe3b48042c85c1a00647 --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=32c5991c409366f7fec8a718000001d2-1478600775.545392-238932751 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-08 02:31:55,924 truncating revision to first 12 chars 2016-11-08 02:31:55,924 Setting DEBUG logging. 2016-11-08 02:31:55,924 attempt 1/10 2016-11-08 02:31:55,924 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/cedar/5993f9fae928?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-08 02:31:56,268 unpacking tar archive at: cedar-5993f9fae928/testing/mozharness/ program finished with exit code 0 elapsedTime=0.731137 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-08 02:31:56.220081) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-08 02:31:56.220421) ========= script_repo_revision: 5993f9fae928a0f18928fe3b48042c85c1a00647 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-08 02:31:56.220803) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-08 02:31:56.221080) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-08 02:31:56.230424) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2016-11-08 02:31:56.230819) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Cedar --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Cedar 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', 'Cedar', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Cedar'] 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=32c5991c409366f7fec8a718000001d2-1478600775.545392-238932751 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:31:56 INFO - MultiFileLogger online at 20161108 02:31:56 in /builds/slave/test 02:31:56 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Cedar --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Cedar 02:31:56 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:31:56 INFO - {'append_to_log': False, 02:31:56 INFO - 'base_work_dir': '/builds/slave/test', 02:31:56 INFO - 'blob_upload_branch': 'Cedar', 02:31:56 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:31:56 INFO - 'branch': 'Cedar', 02:31:56 INFO - 'buildbot_json_path': 'buildprops.json', 02:31:56 INFO - 'config_files': ('talos/linux_config.py',), 02:31:56 INFO - 'default_actions': ('clobber', 02:31:56 INFO - 'read-buildbot-config', 02:31:56 INFO - 'download-and-extract', 02:31:56 INFO - 'populate-webroot', 02:31:56 INFO - 'create-virtualenv', 02:31:56 INFO - 'install', 02:31:56 INFO - 'run-tests'), 02:31:56 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:31:56 INFO - 'download_minidump_stackwalk': True, 02:31:56 INFO - 'download_symbols': 'ondemand', 02:31:56 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:31:56 INFO - 'tooltool.py': '/tools/tooltool.py', 02:31:56 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:31:56 INFO - '/tools/misc-python/virtualenv.py')}, 02:31:56 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:31:56 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:31:56 INFO - 'installer_path': 'installer.exe', 02:31:56 INFO - 'log_level': 'info', 02:31:56 INFO - 'log_name': 'talos', 02:31:56 INFO - 'log_to_console': True, 02:31:56 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:31:56 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:31:56 INFO - 'opt_config_files': (), 02:31:56 INFO - 'pip_index': False, 02:31:56 INFO - 'sps_profile': False, 02:31:56 INFO - 'sps_profile_interval': 0, 02:31:56 INFO - 'suite': 'dromaeojs', 02:31:56 INFO - 'system_bits': '32', 02:31:56 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:31:56 INFO - 'title': 'talos-linux64-ix-008', 02:31:56 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:31:56 INFO - 'use_talos_json': True, 02:31:56 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:31:56 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:31:56 INFO - 'work_dir': 'build'} 02:31:56 INFO - [mozharness: 2016-11-08 10:31:56.777296Z] Running clobber step. 02:31:56 INFO - Running pre-action listener: _resource_record_pre_action 02:31:56 INFO - Running main action method: clobber 02:31:56 INFO - rmtree: /builds/slave/test/build 02:31:56 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:31:57 INFO - Running post-action listener: _resource_record_post_action 02:31:57 INFO - [mozharness: 2016-11-08 10:31:57.239259Z] Finished clobber step (success) 02:31:57 INFO - [mozharness: 2016-11-08 10:31:57.239359Z] Running read-buildbot-config step. 02:31:57 INFO - Running pre-action listener: _resource_record_pre_action 02:31:57 INFO - Running main action method: read_buildbot_config 02:31:57 INFO - Using buildbot properties: 02:31:57 INFO - { 02:31:57 INFO - "project": "", 02:31:57 INFO - "product": "firefox", 02:31:57 INFO - "script_repo_revision": "default", 02:31:57 INFO - "builddir": "cedar_ubuntu64_hw_test-dromaeojs", 02:31:57 INFO - "repository": "", 02:31:57 INFO - "buildername": "Ubuntu HW 12.04 x64 cedar talos dromaeojs", 02:31:57 INFO - "buildid": "20161108011436", 02:31:57 INFO - "pgo_build": "False", 02:31:57 INFO - "basedir": "/builds/slave/test", 02:31:57 INFO - "buildnumber": 2, 02:31:57 INFO - "slavename": "talos-linux64-ix-008", 02:31:57 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 02:31:57 INFO - "platform": "ubuntu64_hw", 02:31:57 INFO - "scheduler": "tests-cedar-linux64-talos", 02:31:57 INFO - "branch": "cedar", 02:31:57 INFO - "repo_path": "projects/cedar", 02:31:57 INFO - "revision": "5993f9fae928a0f18928fe3b48042c85c1a00647", 02:31:57 INFO - "stage_platform": "linux64", 02:31:57 INFO - "builduid": "cb7a98fe92ab414a8e3ca8a23cb727f9", 02:31:57 INFO - "slavebuilddir": "test" 02:31:57 INFO - } 02:31:57 INFO - Found installer url https://queue.taskcluster.net/v1/task/AztzlPNQQUS07QDvRrf_Hw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 02:31:57 INFO - Running post-action listener: _resource_record_post_action 02:31:57 INFO - [mozharness: 2016-11-08 10:31:57.241779Z] Finished read-buildbot-config step (success) 02:31:57 INFO - [mozharness: 2016-11-08 10:31:57.241874Z] Running download-and-extract step. 02:31:57 INFO - Running pre-action listener: _resource_record_pre_action 02:31:57 INFO - Running main action method: download_and_extract 02:31:57 INFO - mkdir: /builds/slave/test/build/tests 02:31:57 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')]} 02:31:57 INFO - trying https://queue.taskcluster.net/v1/task/AztzlPNQQUS07QDvRrf_Hw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 02:31:57 INFO - Downloading https://queue.taskcluster.net/v1/task/AztzlPNQQUS07QDvRrf_Hw/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 02:31:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AztzlPNQQUS07QDvRrf_Hw/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 02:31:57 INFO - Downloaded 1361 bytes. 02:31:57 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 02:31:57 INFO - Using the following test package requirements: 02:31:57 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 02:31:57 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 02:31:57 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 02:31:57 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 02:31:57 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 02:31:57 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 02:31:57 INFO - u'jsshell-linux-x86_64.zip'], 02:31:57 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 02:31:57 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 02:31:57 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 02:31:57 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 02:31:57 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 02:31:57 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 02:31:57 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 02:31:57 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 02:31:57 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 02:31:57 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 02:31:57 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 02:31:57 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:31:57 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/AztzlPNQQUS07QDvRrf_Hw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 02:31:57 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AztzlPNQQUS07QDvRrf_Hw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:31:57 INFO - Fetch https://queue.taskcluster.net/v1/task/AztzlPNQQUS07QDvRrf_Hw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 02:31:58 INFO - Http code: 200 02:31:58 INFO - via: 1.1 455cf6ccbccc261c46d02110de1c0237.cloudfront.net (CloudFront) 02:31:58 INFO - x-amz-cf-id: vNBRB20015jFkPDU9mTjXuyB5cql9voehTSNlen1h9BVunSwh06BTA== 02:31:58 INFO - x-amz-version-id: M74wPvS.MMQtWVLakqqyTIMpPHWjD7Op 02:31:59 INFO - Expected file size: 20355406 02:31:59 INFO - Obtained file size: 20355406 02:32:03 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 02:32:03 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/AztzlPNQQUS07QDvRrf_Hw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 02:32:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AztzlPNQQUS07QDvRrf_Hw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:32:03 INFO - Fetch https://queue.taskcluster.net/v1/task/AztzlPNQQUS07QDvRrf_Hw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 02:32:04 INFO - Http code: 200 02:32:04 INFO - via: 1.1 49c80a47c1441dd194a8337982f1cd7e.cloudfront.net (CloudFront) 02:32:04 INFO - x-amz-cf-id: W-58G4a-KSS1QEx_cPaAvcf9p6dR-JCAwhfvEtziM1oNdsVJk547yA== 02:32:04 INFO - x-amz-version-id: M74wPvS.MMQtWVLakqqyTIMpPHWjD7Op 02:32:04 INFO - Expected file size: 20355406 02:32:04 INFO - Obtained file size: 20355406 02:32:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/AztzlPNQQUS07QDvRrf_Hw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 02:32:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AztzlPNQQUS07QDvRrf_Hw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 02:32:08 INFO - Fetch https://queue.taskcluster.net/v1/task/AztzlPNQQUS07QDvRrf_Hw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 02:32:10 INFO - Http code: 200 02:32:10 INFO - via: 1.1 24b0e5a3429d07ef12381da50e07f70f.cloudfront.net (CloudFront) 02:32:10 INFO - x-amz-cf-id: tRGRFP_8O_vbx1sd6S_8QqVPYqR2C2tR4A6NEqB6BDARmvqWWJdGeA== 02:32:10 INFO - x-amz-version-id: 9csKFb4MuMof.CPxk4vc7sPHcFQqiW96 02:32:11 INFO - Expected file size: 14409038 02:32:11 INFO - Obtained file size: 14409038 02:32:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:32:11 INFO - trying https://queue.taskcluster.net/v1/task/AztzlPNQQUS07QDvRrf_Hw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 02:32:11 INFO - Downloading https://queue.taskcluster.net/v1/task/AztzlPNQQUS07QDvRrf_Hw/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 02:32:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AztzlPNQQUS07QDvRrf_Hw/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 02:32:13 INFO - Downloaded 55894183 bytes. 02:32:13 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/AztzlPNQQUS07QDvRrf_Hw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 02:32:13 INFO - mkdir: /builds/slave/test/properties 02:32:13 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:32:13 INFO - Writing to file /builds/slave/test/properties/build_url 02:32:13 INFO - Contents: 02:32:13 INFO - build_url:https://queue.taskcluster.net/v1/task/AztzlPNQQUS07QDvRrf_Hw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 02:32:14 INFO - Running post-action listener: _resource_record_post_action 02:32:14 INFO - Running post-action listener: set_extra_try_arguments 02:32:14 INFO - [mozharness: 2016-11-08 10:32:14.697097Z] Finished download-and-extract step (success) 02:32:14 INFO - [mozharness: 2016-11-08 10:32:14.697324Z] Running populate-webroot step. 02:32:14 INFO - Running pre-action listener: _resource_record_pre_action 02:32:14 INFO - Running main action method: populate_webroot 02:32:14 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:32:14 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:32:14 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:32:14 INFO - '--tppagecycles', 02:32:14 INFO - '7'], 02:32:14 INFO - 'tests': ['tsvgm']}}, 02:32:14 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:32:14 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:32:14 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:32:14 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:32:14 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:32:14 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:32:14 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:32:14 INFO - 'talos_options': ['--disable-e10s'], 02:32:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:32:14 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:32:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:32:14 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:32:14 INFO - 'talos_options': ['--disable-e10s'], 02:32:14 INFO - 'tests': ['damp', 'tps']}, 02:32:14 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:32:14 INFO - 'tests': ['damp', 'tps']}, 02:32:14 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:32:14 INFO - 'tests': ['dromaeo_dom']}, 02:32:14 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:32:14 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:32:14 INFO - 'tests': ['basic_compositor_video']}, 02:32:14 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:32:14 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:32:14 INFO - 'tests': ['a11yr', 02:32:14 INFO - 'ts_paint', 02:32:14 INFO - 'tpaint', 02:32:14 INFO - 'sessionrestore', 02:32:14 INFO - 'sessionrestore_no_auto_restore', 02:32:14 INFO - 'tabpaint']}, 02:32:14 INFO - 'other-e10s': {'tests': ['a11yr', 02:32:14 INFO - 'ts_paint', 02:32:14 INFO - 'tpaint', 02:32:14 INFO - 'sessionrestore', 02:32:14 INFO - 'sessionrestore_no_auto_restore', 02:32:14 INFO - 'tabpaint']}, 02:32:14 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:32:14 INFO - 'ts_paint', 02:32:14 INFO - 'tpaint', 02:32:14 INFO - 'sessionrestore', 02:32:14 INFO - 'sessionrestore_no_auto_restore', 02:32:14 INFO - 'tabpaint']}, 02:32:14 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:32:14 INFO - 'ts_paint', 02:32:14 INFO - 'tpaint', 02:32:14 INFO - 'sessionrestore', 02:32:14 INFO - 'sessionrestore_no_auto_restore', 02:32:14 INFO - 'tabpaint']}, 02:32:14 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:32:14 INFO - 'tests': ['a11yr', 02:32:14 INFO - 'ts_paint', 02:32:14 INFO - 'tpaint', 02:32:14 INFO - 'sessionrestore', 02:32:14 INFO - 'sessionrestore_no_auto_restore', 02:32:14 INFO - 'tabpaint']}, 02:32:14 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:32:14 INFO - 'tests': ['a11yr', 02:32:14 INFO - 'ts_paint', 02:32:14 INFO - 'tpaint', 02:32:14 INFO - 'sessionrestore', 02:32:14 INFO - 'sessionrestore_no_auto_restore', 02:32:14 INFO - 'tabpaint']}, 02:32:14 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:32:14 INFO - 'tests': ['tsvgx', 02:32:14 INFO - 'tsvgr_opacity', 02:32:14 INFO - 'tart', 02:32:14 INFO - 'tscrollx', 02:32:14 INFO - 'cart']}, 02:32:14 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:32:14 INFO - 'tsvgr_opacity', 02:32:14 INFO - 'tart', 02:32:14 INFO - 'tscrollx', 02:32:14 INFO - 'cart']}, 02:32:14 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:32:14 INFO - 'talos_options': ['--disable-e10s'], 02:32:14 INFO - 'tests': ['tp5o']}, 02:32:14 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:32:14 INFO - 'tests': ['tp5o']}, 02:32:14 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:32:14 INFO - 'talos_options': ['--disable-e10s', 02:32:14 INFO - '--xperf_path', 02:32:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:32:14 INFO - 'tests': ['tp5n']}, 02:32:14 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:32:14 INFO - 'talos_options': ['--xperf_path', 02:32:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:32:14 INFO - 'tests': ['tp5n']}}, 02:32:14 INFO - 'talos.zip': {'path': '', 02:32:14 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:32:14 INFO - Running post-action listener: _resource_record_post_action 02:32:14 INFO - [mozharness: 2016-11-08 10:32:14.716125Z] Finished populate-webroot step (success) 02:32:14 INFO - [mozharness: 2016-11-08 10:32:14.716213Z] Running create-virtualenv step. 02:32:14 INFO - Running pre-action listener: _resource_record_pre_action 02:32:14 INFO - Running main action method: create_virtualenv 02:32:14 INFO - Creating virtualenv /builds/slave/test/build/venv 02:32:14 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 02:32:14 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:32:14 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:32:14 INFO - Using real prefix '/usr' 02:32:14 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:32:15 INFO - Installing distribute.............................................................................................................................................................................................done. 02:32:17 INFO - Installing pip.................done. 02:32:17 INFO - Return code: 0 02:32:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 02:32:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 02:32:17 INFO - Reading from file tmpfile_stdout 02:32:17 INFO - Output received: 02:32:17 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) 02:32:17 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:32:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:32:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:32:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:32:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:32:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:32:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:32:17 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 0x7fc3e6faff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25f68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26c3790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26c0930>, '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 0x26c1830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26c1cc0>, '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': '32c5991c409366f7fec8a718000001d2-1478600775.545392-238932751', '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 02:32:17 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 02:32:17 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 02:32:17 INFO - Using env: {'DISPLAY': ':0', 02:32:17 INFO - 'HOME': '/home/cltbld', 02:32:17 INFO - 'LANG': 'en_US.UTF-8', 02:32:17 INFO - 'LANGUAGE': 'en_US:en', 02:32:17 INFO - 'LOGNAME': 'cltbld', 02:32:17 INFO - 'MAIL': '/var/mail/cltbld', 02:32:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:32:17 INFO - 'MOZ_NO_REMOTE': '1', 02:32:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:32:17 INFO - 'NO_EM_RESTART': '1', 02:32:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:32:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:32:17 INFO - 'PWD': '/builds/slave/test', 02:32:17 INFO - 'SHELL': '/bin/bash', 02:32:17 INFO - 'SHLVL': '1', 02:32:17 INFO - 'TERM': 'linux', 02:32:17 INFO - 'TMOUT': '86400', 02:32:17 INFO - 'USER': 'cltbld', 02:32:17 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1478600775.545392-238932751', 02:32:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:32:17 INFO - '_': '/tools/buildbot/bin/python'} 02:32:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:32:17 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 02:32:17 INFO - Cleaning up... 02:32:17 INFO - Return code: 0 02:32:17 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:32:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:32:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:32:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:32:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:32:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:32:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:32:17 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 0x7fc3e6faff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25f68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26c3790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26c0930>, '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 0x26c1830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26c1cc0>, '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': '32c5991c409366f7fec8a718000001d2-1478600775.545392-238932751', '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 02:32:17 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 02:32:17 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 02:32:17 INFO - Using env: {'DISPLAY': ':0', 02:32:17 INFO - 'HOME': '/home/cltbld', 02:32:17 INFO - 'LANG': 'en_US.UTF-8', 02:32:17 INFO - 'LANGUAGE': 'en_US:en', 02:32:17 INFO - 'LOGNAME': 'cltbld', 02:32:17 INFO - 'MAIL': '/var/mail/cltbld', 02:32:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:32:17 INFO - 'MOZ_NO_REMOTE': '1', 02:32:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:32:17 INFO - 'NO_EM_RESTART': '1', 02:32:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:32:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:32:17 INFO - 'PWD': '/builds/slave/test', 02:32:17 INFO - 'SHELL': '/bin/bash', 02:32:17 INFO - 'SHLVL': '1', 02:32:17 INFO - 'TERM': 'linux', 02:32:17 INFO - 'TMOUT': '86400', 02:32:17 INFO - 'USER': 'cltbld', 02:32:17 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1478600775.545392-238932751', 02:32:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:32:17 INFO - '_': '/tools/buildbot/bin/python'} 02:32:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:32:17 INFO - Downloading/unpacking psutil>=3.1.1 02:32:17 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 02:32:17 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 02:32:17 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 02:32:17 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 02:32:17 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 02:32:17 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 02:32:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:32:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:32:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:32:20 INFO - Installing collected packages: psutil 02:32:20 INFO - Running setup.py install for psutil 02:32:20 INFO - building 'psutil._psutil_linux' extension 02:32:20 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 02:32:20 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 02:32:20 INFO - building 'psutil._psutil_posix' extension 02:32:20 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 02:32:20 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 02:32:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:32:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:32:20 INFO - Successfully installed psutil 02:32:20 INFO - Cleaning up... 02:32:20 INFO - Return code: 0 02:32:20 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:32:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:32:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:32:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:32:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:32:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:32:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:32:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc3e6faff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25f68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26c3790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26c0930>, '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 0x26c1830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26c1cc0>, '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': '32c5991c409366f7fec8a718000001d2-1478600775.545392-238932751', '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 02:32:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 02:32:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 02:32:20 INFO - Using env: {'DISPLAY': ':0', 02:32:20 INFO - 'HOME': '/home/cltbld', 02:32:20 INFO - 'LANG': 'en_US.UTF-8', 02:32:20 INFO - 'LANGUAGE': 'en_US:en', 02:32:20 INFO - 'LOGNAME': 'cltbld', 02:32:20 INFO - 'MAIL': '/var/mail/cltbld', 02:32:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:32:20 INFO - 'MOZ_NO_REMOTE': '1', 02:32:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:32:20 INFO - 'NO_EM_RESTART': '1', 02:32:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:32:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:32:20 INFO - 'PWD': '/builds/slave/test', 02:32:20 INFO - 'SHELL': '/bin/bash', 02:32:20 INFO - 'SHLVL': '1', 02:32:20 INFO - 'TERM': 'linux', 02:32:20 INFO - 'TMOUT': '86400', 02:32:20 INFO - 'USER': 'cltbld', 02:32:20 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1478600775.545392-238932751', 02:32:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:32:20 INFO - '_': '/tools/buildbot/bin/python'} 02:32:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:32:20 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:32:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:32:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:32:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:32:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:32:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:32:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:32:22 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:32:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:32:22 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:32:22 INFO - Installing collected packages: mozsystemmonitor 02:32:22 INFO - Running setup.py install for mozsystemmonitor 02:32:22 INFO - Successfully installed mozsystemmonitor 02:32:22 INFO - Cleaning up... 02:32:22 INFO - Return code: 0 02:32:22 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:32:22 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')]} 02:32:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:32:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:32:22 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')]} 02:32:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:32:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:32:22 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 0x7fc3e6faff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25f68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26c3790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26c0930>, '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 0x26c1830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26c1cc0>, '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': '32c5991c409366f7fec8a718000001d2-1478600775.545392-238932751', '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 02:32:22 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 02:32:22 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 02:32:22 INFO - Using env: {'DISPLAY': ':0', 02:32:22 INFO - 'HOME': '/home/cltbld', 02:32:22 INFO - 'LANG': 'en_US.UTF-8', 02:32:22 INFO - 'LANGUAGE': 'en_US:en', 02:32:22 INFO - 'LOGNAME': 'cltbld', 02:32:22 INFO - 'MAIL': '/var/mail/cltbld', 02:32:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:32:22 INFO - 'MOZ_NO_REMOTE': '1', 02:32:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:32:22 INFO - 'NO_EM_RESTART': '1', 02:32:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:32:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:32:22 INFO - 'PWD': '/builds/slave/test', 02:32:22 INFO - 'SHELL': '/bin/bash', 02:32:22 INFO - 'SHLVL': '1', 02:32:22 INFO - 'TERM': 'linux', 02:32:22 INFO - 'TMOUT': '86400', 02:32:22 INFO - 'USER': 'cltbld', 02:32:22 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1478600775.545392-238932751', 02:32:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:32:22 INFO - '_': '/tools/buildbot/bin/python'} 02:32:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:32:23 INFO - Downloading/unpacking jsonschema==2.5.1 02:32:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:32:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:32:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:32:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:32:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:32:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:32:25 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:32:25 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:32:25 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 02:32:25 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 02:32:25 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 02:32:25 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 02:32:25 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 02:32:25 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 02:32:25 INFO - Downloading functools32-3.2.3-2.tar.gz 02:32:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:32:25 INFO - warning: no files found matching '*.txt' 02:32:25 INFO - no previously-included directories found matching 'build' 02:32:25 INFO - no previously-included directories found matching 'dist' 02:32:25 INFO - no previously-included directories found matching '.git*' 02:32:25 INFO - Installing collected packages: jsonschema, functools32 02:32:25 INFO - Running setup.py install for functools32 02:32:25 INFO - warning: no files found matching '*.txt' 02:32:25 INFO - no previously-included directories found matching 'build' 02:32:25 INFO - no previously-included directories found matching 'dist' 02:32:25 INFO - no previously-included directories found matching '.git*' 02:32:25 INFO - Successfully installed jsonschema functools32 02:32:25 INFO - Cleaning up... 02:32:25 INFO - Return code: 0 02:32:25 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:32:25 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')]} 02:32:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:32:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:32:25 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')]} 02:32:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:32:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:32:25 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 0x7fc3e6faff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25f68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26c3790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26c0930>, '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 0x26c1830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26c1cc0>, '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': '32c5991c409366f7fec8a718000001d2-1478600775.545392-238932751', '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 02:32:25 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 02:32:25 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 02:32:25 INFO - Using env: {'DISPLAY': ':0', 02:32:25 INFO - 'HOME': '/home/cltbld', 02:32:25 INFO - 'LANG': 'en_US.UTF-8', 02:32:25 INFO - 'LANGUAGE': 'en_US:en', 02:32:25 INFO - 'LOGNAME': 'cltbld', 02:32:25 INFO - 'MAIL': '/var/mail/cltbld', 02:32:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:32:25 INFO - 'MOZ_NO_REMOTE': '1', 02:32:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:32:25 INFO - 'NO_EM_RESTART': '1', 02:32:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:32:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:32:25 INFO - 'PWD': '/builds/slave/test', 02:32:25 INFO - 'SHELL': '/bin/bash', 02:32:25 INFO - 'SHLVL': '1', 02:32:25 INFO - 'TERM': 'linux', 02:32:25 INFO - 'TMOUT': '86400', 02:32:25 INFO - 'USER': 'cltbld', 02:32:25 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1478600775.545392-238932751', 02:32:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:32:25 INFO - '_': '/tools/buildbot/bin/python'} 02:32:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:32:25 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:32:25 INFO - Cleaning up... 02:32:25 INFO - Return code: 0 02:32:25 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:32:25 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')]} 02:32:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:32:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:32:25 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')]} 02:32:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:32:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:32:25 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 0x7fc3e6faff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25f68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26c3790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26c0930>, '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 0x26c1830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26c1cc0>, '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': '32c5991c409366f7fec8a718000001d2-1478600775.545392-238932751', '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 02:32:25 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 02:32:25 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 02:32:25 INFO - Using env: {'DISPLAY': ':0', 02:32:25 INFO - 'HOME': '/home/cltbld', 02:32:25 INFO - 'LANG': 'en_US.UTF-8', 02:32:25 INFO - 'LANGUAGE': 'en_US:en', 02:32:25 INFO - 'LOGNAME': 'cltbld', 02:32:25 INFO - 'MAIL': '/var/mail/cltbld', 02:32:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:32:25 INFO - 'MOZ_NO_REMOTE': '1', 02:32:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:32:25 INFO - 'NO_EM_RESTART': '1', 02:32:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:32:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:32:25 INFO - 'PWD': '/builds/slave/test', 02:32:25 INFO - 'SHELL': '/bin/bash', 02:32:25 INFO - 'SHLVL': '1', 02:32:25 INFO - 'TERM': 'linux', 02:32:25 INFO - 'TMOUT': '86400', 02:32:25 INFO - 'USER': 'cltbld', 02:32:25 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1478600775.545392-238932751', 02:32:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:32:25 INFO - '_': '/tools/buildbot/bin/python'} 02:32:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:32:25 INFO - Downloading/unpacking blobuploader==1.2.4 02:32:25 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 02:32:25 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 02:32:25 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 02:32:25 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 02:32:25 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 02:32:25 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 02:32:27 INFO - Downloading blobuploader-1.2.4.tar.gz 02:32:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:32:27 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:32:27 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 02:32:27 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 02:32:27 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 02:32:27 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 02:32:27 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 02:32:27 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 02:32:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:32:28 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:32:28 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 02:32:28 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 02:32:28 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 02:32:28 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 02:32:28 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 02:32:28 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 02:32:28 INFO - Downloading docopt-0.6.1.tar.gz 02:32:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:32:28 INFO - Installing collected packages: blobuploader, requests, docopt 02:32:28 INFO - Running setup.py install for blobuploader 02:32:28 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:32:28 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:32:28 INFO - Running setup.py install for requests 02:32:29 INFO - Running setup.py install for docopt 02:32:29 INFO - Successfully installed blobuploader requests docopt 02:32:29 INFO - Cleaning up... 02:32:29 INFO - Return code: 0 02:32:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:32:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:32:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:32:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:32:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:32:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:32:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:32:29 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 0x7fc3e6faff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25f68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26c3790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26c0930>, '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 0x26c1830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26c1cc0>, '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': '32c5991c409366f7fec8a718000001d2-1478600775.545392-238932751', '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 02:32:29 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 02:32:29 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 02:32:29 INFO - Using env: {'DISPLAY': ':0', 02:32:29 INFO - 'HOME': '/home/cltbld', 02:32:29 INFO - 'LANG': 'en_US.UTF-8', 02:32:29 INFO - 'LANGUAGE': 'en_US:en', 02:32:29 INFO - 'LOGNAME': 'cltbld', 02:32:29 INFO - 'MAIL': '/var/mail/cltbld', 02:32:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:32:29 INFO - 'MOZ_NO_REMOTE': '1', 02:32:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:32:29 INFO - 'NO_EM_RESTART': '1', 02:32:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:32:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:32:29 INFO - 'PWD': '/builds/slave/test', 02:32:29 INFO - 'SHELL': '/bin/bash', 02:32:29 INFO - 'SHLVL': '1', 02:32:29 INFO - 'TERM': 'linux', 02:32:29 INFO - 'TMOUT': '86400', 02:32:29 INFO - 'USER': 'cltbld', 02:32:29 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1478600775.545392-238932751', 02:32:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:32:29 INFO - '_': '/tools/buildbot/bin/python'} 02:32:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:32:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:32:29 INFO - Running setup.py (path:/tmp/pip-En7U6n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:32:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:32:29 INFO - Running setup.py (path:/tmp/pip-gkoX4C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:32:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:32:29 INFO - Running setup.py (path:/tmp/pip-m7NyO3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:32:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:32:29 INFO - Running setup.py (path:/tmp/pip-UPErkE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:32:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:32:29 INFO - Running setup.py (path:/tmp/pip-0SeljW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:32:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:32:29 INFO - Running setup.py (path:/tmp/pip-TuzLPW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:32:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:32:29 INFO - Running setup.py (path:/tmp/pip-bB1x9b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:32:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:32:30 INFO - Running setup.py (path:/tmp/pip-Z2jky2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:32:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:32:30 INFO - Running setup.py (path:/tmp/pip-K1qBfd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:32:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:32:30 INFO - Running setup.py (path:/tmp/pip-FNQ03O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:32:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:32:30 INFO - Running setup.py (path:/tmp/pip-xJ7R6b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:32:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:32:30 INFO - Running setup.py (path:/tmp/pip-3TLWNc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:32:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:32:30 INFO - Running setup.py (path:/tmp/pip-l38gGu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:32:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:32:30 INFO - Running setup.py (path:/tmp/pip-UsIjJR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:32:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:32:30 INFO - Running setup.py (path:/tmp/pip-FXamIU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:32:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:32:30 INFO - Running setup.py (path:/tmp/pip-FY5rIP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:32:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:32:30 INFO - Running setup.py (path:/tmp/pip-JXkVHG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:32:30 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:32:30 INFO - Running setup.py install for manifestparser 02:32:30 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:32:30 INFO - Running setup.py install for mozcrash 02:32:30 INFO - Running setup.py install for mozdebug 02:32:31 INFO - Running setup.py install for mozdevice 02:32:31 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:32:31 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:32:31 INFO - Running setup.py install for mozfile 02:32:31 INFO - Running setup.py install for mozhttpd 02:32:31 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:32:31 INFO - Running setup.py install for mozinfo 02:32:31 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:32:31 INFO - Running setup.py install for mozInstall 02:32:31 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:32:31 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:32:31 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:32:31 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:32:31 INFO - Running setup.py install for mozleak 02:32:31 INFO - Running setup.py install for mozlog 02:32:31 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:32:31 INFO - Running setup.py install for moznetwork 02:32:31 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:32:31 INFO - Running setup.py install for mozprocess 02:32:31 INFO - Running setup.py install for mozprofile 02:32:32 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:32:32 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:32:32 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:32:32 INFO - Running setup.py install for mozrunner 02:32:32 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:32:32 INFO - Running setup.py install for mozscreenshot 02:32:32 INFO - Running setup.py install for moztest 02:32:32 INFO - Running setup.py install for mozversion 02:32:32 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:32:32 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:32:32 INFO - Cleaning up... 02:32:32 INFO - Return code: 0 02:32:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:32:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:32:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:32:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:32:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:32:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:32:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:32:32 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 0x7fc3e6faff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25f68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26c3790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26c0930>, '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 0x26c1830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26c1cc0>, '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': '32c5991c409366f7fec8a718000001d2-1478600775.545392-238932751', '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 02:32:32 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 02:32:32 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 02:32:32 INFO - Using env: {'DISPLAY': ':0', 02:32:32 INFO - 'HOME': '/home/cltbld', 02:32:32 INFO - 'LANG': 'en_US.UTF-8', 02:32:32 INFO - 'LANGUAGE': 'en_US:en', 02:32:32 INFO - 'LOGNAME': 'cltbld', 02:32:32 INFO - 'MAIL': '/var/mail/cltbld', 02:32:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:32:32 INFO - 'MOZ_NO_REMOTE': '1', 02:32:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:32:32 INFO - 'NO_EM_RESTART': '1', 02:32:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:32:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:32:32 INFO - 'PWD': '/builds/slave/test', 02:32:32 INFO - 'SHELL': '/bin/bash', 02:32:32 INFO - 'SHLVL': '1', 02:32:32 INFO - 'TERM': 'linux', 02:32:32 INFO - 'TMOUT': '86400', 02:32:32 INFO - 'USER': 'cltbld', 02:32:32 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1478600775.545392-238932751', 02:32:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:32:32 INFO - '_': '/tools/buildbot/bin/python'} 02:32:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:32:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:32:32 INFO - Running setup.py (path:/tmp/pip-_mZtXC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:32:32 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)) 02:32:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:32:32 INFO - Running setup.py (path:/tmp/pip-TvLedV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:32:32 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)) 02:32:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:32:32 INFO - Running setup.py (path:/tmp/pip-CL7OXn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:32:32 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)) 02:32:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:32:32 INFO - Running setup.py (path:/tmp/pip-p112Dd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:32:33 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)) 02:32:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:32:33 INFO - Running setup.py (path:/tmp/pip-PvuJ2X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:32:33 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)) 02:32:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:32:33 INFO - Running setup.py (path:/tmp/pip-KYPXra-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:32:33 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)) 02:32:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:32:33 INFO - Running setup.py (path:/tmp/pip-s3JQGt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:32:33 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)) 02:32:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:32:33 INFO - Running setup.py (path:/tmp/pip-bFMSzL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:32:33 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)) 02:32:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:32:33 INFO - Running setup.py (path:/tmp/pip-TuFMkL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:32:33 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)) 02:32:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:32:33 INFO - Running setup.py (path:/tmp/pip-79pH1Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:32:33 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)) 02:32:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:32:33 INFO - Running setup.py (path:/tmp/pip-__B1xD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:32:33 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)) 02:32:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:32:33 INFO - Running setup.py (path:/tmp/pip-q71Yvr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:32:33 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)) 02:32:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:32:33 INFO - Running setup.py (path:/tmp/pip-ukL7Uj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:32:33 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)) 02:32:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:32:33 INFO - Running setup.py (path:/tmp/pip-YnWxrr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:32:33 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)) 02:32:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:32:33 INFO - Running setup.py (path:/tmp/pip-ICetpi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:32:33 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)) 02:32:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:32:33 INFO - Running setup.py (path:/tmp/pip-omtceK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:32:33 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)) 02:32:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:32:33 INFO - Running setup.py (path:/tmp/pip-jrVBZB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:32:33 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)) 02:32:33 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)) 02:32:33 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)) 02:32:33 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)) 02:32:33 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)) 02:32:33 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)) 02:32:33 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:32: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 02:32: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 02:32: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 02:32: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 02:32: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 02:32: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 02:32:35 INFO - Downloading blessings-1.6.tar.gz 02:32:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:32:35 INFO - Installing collected packages: blessings 02:32:35 INFO - Running setup.py install for blessings 02:32:36 INFO - Successfully installed blessings 02:32:36 INFO - Cleaning up... 02:32:36 INFO - Return code: 0 02:32:36 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:32:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:32:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:32:36 INFO - Reading from file tmpfile_stdout 02:32:36 INFO - Current package versions: 02:32:36 INFO - argparse == 1.2.1 02:32:36 INFO - blessings == 1.6 02:32:36 INFO - blobuploader == 1.2.4 02:32:36 INFO - docopt == 0.6.1 02:32:36 INFO - functools32 == 3.2.3-2 02:32:36 INFO - jsonschema == 2.5.1 02:32:36 INFO - manifestparser == 1.1 02:32:36 INFO - mozInstall == 1.12 02:32:36 INFO - mozcrash == 0.17 02:32:36 INFO - mozdebug == 0.1 02:32:36 INFO - mozdevice == 0.48 02:32:36 INFO - mozfile == 1.2 02:32:36 INFO - mozhttpd == 0.7 02:32:36 INFO - mozinfo == 0.9 02:32:36 INFO - mozleak == 0.1 02:32:36 INFO - mozlog == 3.4 02:32:36 INFO - moznetwork == 0.27 02:32:36 INFO - mozprocess == 0.23 02:32:36 INFO - mozprofile == 0.28 02:32:36 INFO - mozrunner == 6.12 02:32:36 INFO - mozscreenshot == 0.1 02:32:36 INFO - mozsystemmonitor == 0.3 02:32:36 INFO - moztest == 0.7 02:32:36 INFO - mozversion == 1.4 02:32:36 INFO - psutil == 3.1.1 02:32:36 INFO - requests == 1.2.3 02:32:36 INFO - wsgiref == 0.1.2 02:32:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:32: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')]} 02:32:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:32:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:32: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')]} 02:32:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:32:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:32:36 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 0x7fc3e6faff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25f68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26c3790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26c0930>, '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 0x26c1830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26c1cc0>, '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': '32c5991c409366f7fec8a718000001d2-1478600775.545392-238932751', '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 02:32:36 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 02:32:36 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 02:32:36 INFO - Using env: {'DISPLAY': ':0', 02:32:36 INFO - 'HOME': '/home/cltbld', 02:32:36 INFO - 'LANG': 'en_US.UTF-8', 02:32:36 INFO - 'LANGUAGE': 'en_US:en', 02:32:36 INFO - 'LOGNAME': 'cltbld', 02:32:36 INFO - 'MAIL': '/var/mail/cltbld', 02:32:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:32:36 INFO - 'MOZ_NO_REMOTE': '1', 02:32:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:32:36 INFO - 'NO_EM_RESTART': '1', 02:32:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:32:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:32:36 INFO - 'PWD': '/builds/slave/test', 02:32:36 INFO - 'SHELL': '/bin/bash', 02:32:36 INFO - 'SHLVL': '1', 02:32:36 INFO - 'TERM': 'linux', 02:32:36 INFO - 'TMOUT': '86400', 02:32:36 INFO - 'USER': 'cltbld', 02:32:36 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1478600775.545392-238932751', 02:32:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:32:36 INFO - '_': '/tools/buildbot/bin/python'} 02:32:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:32:36 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)) 02:32:36 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)) 02:32:36 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)) 02:32:36 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)) 02:32:36 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)) 02:32:36 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)) 02:32:36 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)) 02:32:36 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)) 02:32:36 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)) 02:32:36 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)) 02:32:36 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)) 02:32:36 INFO - Cleaning up... 02:32:36 INFO - Return code: 0 02:32:36 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:32: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')]} 02:32:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:32:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:32: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')]} 02:32:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:32:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:32: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc3e6faff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25f68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26c3790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26c0930>, '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 0x26c1830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26c1cc0>, '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': '32c5991c409366f7fec8a718000001d2-1478600775.545392-238932751', '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 02:32: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', 'jsonschema'] in /builds/slave/test/build 02:32: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 jsonschema 02:32:36 INFO - Using env: {'DISPLAY': ':0', 02:32:36 INFO - 'HOME': '/home/cltbld', 02:32:36 INFO - 'LANG': 'en_US.UTF-8', 02:32:36 INFO - 'LANGUAGE': 'en_US:en', 02:32:36 INFO - 'LOGNAME': 'cltbld', 02:32:36 INFO - 'MAIL': '/var/mail/cltbld', 02:32:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:32:36 INFO - 'MOZ_NO_REMOTE': '1', 02:32:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:32:36 INFO - 'NO_EM_RESTART': '1', 02:32:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:32:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:32:36 INFO - 'PWD': '/builds/slave/test', 02:32:36 INFO - 'SHELL': '/bin/bash', 02:32:36 INFO - 'SHLVL': '1', 02:32:36 INFO - 'TERM': 'linux', 02:32:36 INFO - 'TMOUT': '86400', 02:32:36 INFO - 'USER': 'cltbld', 02:32:36 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1478600775.545392-238932751', 02:32:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:32:36 INFO - '_': '/tools/buildbot/bin/python'} 02:32:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:32:36 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:32:36 INFO - Cleaning up... 02:32:36 INFO - Return code: 0 02:32:36 INFO - Running post-action listener: _resource_record_post_action 02:32:36 INFO - Running post-action listener: _start_resource_monitoring 02:32:36 INFO - Starting resource monitoring. 02:32:36 INFO - [mozharness: 2016-11-08 10:32:36.863418Z] Finished create-virtualenv step (success) 02:32:36 INFO - [mozharness: 2016-11-08 10:32:36.863923Z] Running install step. 02:32:36 INFO - Running pre-action listener: _resource_record_pre_action 02:32:36 INFO - Running main action method: install 02:32:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:32:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:32:37 INFO - Reading from file tmpfile_stdout 02:32:37 INFO - Detecting whether we're running mozinstall >=1.0... 02:32:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:32:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:32:37 INFO - Reading from file tmpfile_stdout 02:32:37 INFO - Output received: 02:32:37 INFO - Usage: mozinstall [options] installer 02:32:37 INFO - Options: 02:32:37 INFO - -h, --help show this help message and exit 02:32:37 INFO - -d DEST, --destination=DEST 02:32:37 INFO - Directory to install application into. [default: 02:32:37 INFO - "/builds/slave/test"] 02:32:37 INFO - --app=APP Application being installed. [default: firefox] 02:32:37 INFO - mkdir: /builds/slave/test/build/application 02:32:37 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'] 02:32:37 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 02:32:53 INFO - Reading from file tmpfile_stdout 02:32:53 INFO - Output received: 02:32:53 INFO - /builds/slave/test/build/application/firefox/firefox 02:32:53 INFO - Running post-action listener: _resource_record_post_action 02:32:53 INFO - [mozharness: 2016-11-08 10:32:53.256088Z] Finished install step (success) 02:32:53 INFO - [mozharness: 2016-11-08 10:32:53.256332Z] Running run-tests step. 02:32:53 INFO - Running pre-action listener: _resource_record_pre_action 02:32:53 INFO - Running main action method: run_tests 02:32:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:32:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:32:53 INFO - Python 2.7.3 02:32:53 INFO - Return code: 0 02:32:53 INFO - grabbing minidump binary from tooltool 02:32:53 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')]} 02:32:53 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 0x26c0930>, '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 0x26c1830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26c1cc0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:32:53 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 02:32:53 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 02:32:53 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 02:32:53 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:32:53 INFO - Return code: 0 02:32:53 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:32:53 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:32:53 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:32:53 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:32:53 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:32:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Cedar', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/AztzlPNQQUS07QDvRrf_Hw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--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 02:32:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Cedar --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/AztzlPNQQUS07QDvRrf_Hw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-008 --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 02:32:53 INFO - Using env: {'DISPLAY': ':0', 02:32:53 INFO - 'HOME': '/home/cltbld', 02:32:53 INFO - 'LANG': 'en_US.UTF-8', 02:32:53 INFO - 'LANGUAGE': 'en_US:en', 02:32:53 INFO - 'LOGNAME': 'cltbld', 02:32:53 INFO - 'MAIL': '/var/mail/cltbld', 02:32:53 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:32:53 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:32:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:32:53 INFO - 'MOZ_NO_REMOTE': '1', 02:32:53 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:32:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:32:53 INFO - 'NO_EM_RESTART': '1', 02:32:53 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:32:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:32:53 INFO - 'PWD': '/builds/slave/test', 02:32:53 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:32:53 INFO - 'SHELL': '/bin/bash', 02:32:53 INFO - 'SHLVL': '1', 02:32:53 INFO - 'TERM': 'linux', 02:32:53 INFO - 'TMOUT': '86400', 02:32:53 INFO - 'USER': 'cltbld', 02:32:53 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1478600775.545392-238932751', 02:32:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:32:53 INFO - '_': '/tools/buildbot/bin/python'} 02:32:53 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Cedar', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/AztzlPNQQUS07QDvRrf_Hw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--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 02:32:53 INFO - mozversion application_buildid: 20161108011436 02:32:53 INFO - mozversion application_changeset: 5993f9fae928a0f18928fe3b48042c85c1a00647 02:32:53 INFO - mozversion application_display_name: Nightly 02:32:53 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:32:53 INFO - mozversion application_name: Firefox 02:32:53 INFO - mozversion application_remotingname: firefox 02:32:53 INFO - mozversion application_repository: https://hg.mozilla.org/projects/cedar 02:32:53 INFO - mozversion application_vendor: Mozilla 02:32:53 INFO - mozversion application_version: 52.0a1 02:32:53 INFO - mozversion platform_buildid: 20161108011436 02:32:53 INFO - mozversion platform_changeset: 5993f9fae928a0f18928fe3b48042c85c1a00647 02:32:53 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/cedar 02:32:53 INFO - mozversion platform_version: 52.0a1 02:32:53 INFO - using testdate: 1478601173 02:32:53 INFO - actual date: 1478601173 02:32:53 INFO - starting webserver on 'localhost:48901' 02:32:53 INFO - SUITE-START | Running 2 tests 02:32:53 INFO - TEST-START | dromaeo_css 02:32:53 INFO - operating with platform_type : linux_ 02:32:53 INFO - Initialising browser for dromaeo_css test... 02:32:53 INFO - TEST-INFO | started process 26807 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxOCbUn/profile http://localhost:48901/getInfo.html) 02:32:57 INFO - PROCESS | 26807 | __metrics Screen width/height:1600/1200 02:32:57 INFO - PROCESS | 26807 | colorDepth:24 02:32:57 INFO - PROCESS | 26807 | Browser inner width/height: 1024/697 02:32:57 INFO - PROCESS | 26807 | __metrics 02:32:58 INFO - PROCESS | 26807 | 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" 02:32:58 INFO - PROCESS | 26807 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:32:58 INFO - PROCESS | 26807 | console.error: PushService: 02:32:58 INFO - PROCESS | 26807 | stateChangeProcessEnqueue: Error transitioning state 02:32:58 INFO - PROCESS | 26807 | UnknownError 02:32:59 INFO - TEST-INFO | 26807: exit 0 02:32:59 INFO - Browser initialized. 02:32:59 INFO - Running cycle 1/1 for dromaeo_css test... 02:32:59 INFO - TEST-INFO | started process 26887 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxOCbUn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:33:11 INFO - PROCESS | 26887 | RSS: Main: 174518272 02:33:11 INFO - PROCESS | 26887 | 02:34:03 INFO - PROCESS | 26887 | 1478601243619 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] 02:36:19 INFO - PROCESS | 26887 | Cycle 1(1): loaded http://localhost:48901/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48901/tests/dromaeo/cssquery-ext.html) 02:36:20 INFO - PROCESS | 26887 | RSS: Main: 317906944 02:36:20 INFO - PROCESS | 26887 | 02:39:23 INFO - PROCESS | 26887 | Cycle 1(1): loaded http://localhost:48901/tests/dromaeo/cssquery-ext.html (next: http://localhost:48901/tests/dromaeo/cssquery-jquery.html) 02:39:24 INFO - PROCESS | 26887 | RSS: Main: 289185792 02:39:24 INFO - PROCESS | 26887 | 02:42:26 INFO - PROCESS | 26887 | Cycle 1(1): loaded http://localhost:48901/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48901/tests/dromaeo/cssquery-mootools.html) 02:42:27 INFO - PROCESS | 26887 | RSS: Main: 220606464 02:42:27 INFO - PROCESS | 26887 | 02:45:29 INFO - PROCESS | 26887 | Cycle 1(1): loaded http://localhost:48901/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48901/tests/dromaeo/cssquery-prototype.html) 02:45:30 INFO - PROCESS | 26887 | RSS: Main: 221970432 02:45:30 INFO - PROCESS | 26887 | 02:48:33 INFO - PROCESS | 26887 | Cycle 1(1): loaded http://localhost:48901/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48901/tests/dromaeo/cssquery-yui.html) 02:48:33 INFO - PROCESS | 26887 | RSS: Main: 219058176 02:48:33 INFO - PROCESS | 26887 | 02:51:36 INFO - PROCESS | 26887 | Cycle 1(1): loaded http://localhost:48901/tests/dromaeo/cssquery-yui.html (next: http://localhost:48901/tests/dromaeo/cssquery-dojo.html) 02:51:37 INFO - PROCESS | 26887 | RSS: Main: 313757696 02:51:37 INFO - PROCESS | 26887 | 02:51:37 INFO - PROCESS | 26887 | __start_tp_report 02:51:37 INFO - PROCESS | 26887 | _x_x_mozilla_page_load 02:51:37 INFO - PROCESS | 26887 | _x_x_mozilla_page_load_details 02:51:37 INFO - PROCESS | 26887 | |i|pagename|runs| 02:51:37 INFO - PROCESS | 26887 | |0;dojo.html;2588.262345231609;2621.7116117227115;2628.723983981682;2653;2664.8401095934246;4618.861434156972;4700.858974230779;4752.524747525245;4786.688865223762;4787.928181077286;4703.7883295251795;4740.620750339973;4747.62019038477;4792.448868380137;4792.736399498035;4274.1451709658195;4280.1653677532895;4290.420793192926;4343.891402714926;4404.097160082191;4283.121959998209;4426.557344265564;4448.110377924412;4454.821807127711;4498.032922921571;4263.253930562139;4306.483222013347;4433.667474939392;4464.330350447426;4483.50681425043;4362.563743625644;4383.232934236496;4385.6710746694125;4387.73673579583;4391.363252328427;4356.041670832412;4361.9127617447475;4365.367021781855;4369.890752731176;4371.3224450209955;4707.45864225615;4718.457377401608;4723;4724.433068031858;4728.148933192024;4985.252212168168;5043.798248070073;5046.924296135561;5051.772670229849;5051.949480505222;4871.537203965618;4890.413150421937;4898.314236006961;4998.225275082332;5007.4491805901325;4631.282151266559;4631.884202894955;4634.814607415733;4642.4661163966575;4679.906401871944;5031.823886163967;5061.392632884077;5073.949260507421;5076.974615126901;5128.871778205575;4816.109019831342;4851.854444366674;4854.490278520775;4926.261060840831;4931;5000.824971125993;5004.799808007639;5005.274235235943;5006.64953453262;5010.69935803853;4958.826441074545;4967.403911530567;4967.90064198714;4969.155243608595;4975.328330675385;4962.007598480318;4963.875903102451;4969.204927211629;4970.254461830682;4972.353594032825;4204.474440694913;4210.094829611587;4218.093109981369;4219.029623186684;4219.831206751757;3679.3377192105677;3683.4290684943876;3727.38498147808;3727.9254414912093;3815.4086116651965;4321.092570560155;4325.84859529915;4329.891752706145;4381.21138195128;4416.558344165622;5145.922811157836;5156;5157.32954715892;5157.690538567698;5161;4088.9182216356103;4219.2194444027955;4225.492940847118;4392.879815646989;4426.712263702849;4423.181711383404;4459.955400446019;4498.370228168124;4527.275635898241;4528.252838281646;4708.505606911362;4708.788104535372;4731.976340118277;4735.810567577259;4768.76156192196;4832.830850920201;4863.076015557032;5051.949480505148;5052.59579233653;5098.719570423514;4634.72191668501;4713.387259656222;4741.431028276629;4748.952510474851;4841.709497430165;5051.621128415457;5051.797928082982;5052.040112378636;5055.848324550269;5101.51535604117;4912;5106.846794596168;5118.257852611276;5120.359955005624;5120.769565369493;4836.250381190921;4893.926591101065;4900.26496025599;4923.433805112315;4925.014997000542;4923.901521969612;4932.926006109983;4944.8763780905765;4964.751762411793;4998.750062496933;4892.65751397413;4893.021395720799;4895.583875370491;4897.0450762101045;4926.285688575208;4833.709977401367;4837.298591704112;4886.047220791911;4905.656604037683;5026.84919452417;4821.63837712166;4845;4881.780319885543;4920.975395123001;4921.064997650578 02:51:37 INFO - PROCESS | 26887 | |1;ext.html;537.4893850841701;545.1441237257508;551.3907132618456;563.4337490821729;572.9657967368897;27926.301842453948;33257.833710831444;34518.30963380734;34697;37458.43812342817;40638.59361406385;40999.79500102503;41004.58995410045;41083.38374924379;41178.794106029505;7481.850362992724;7617.085949686018;7625.580593067379;7634.274743899321;7635.236476352348;7463.888041679379;7552.282533159341;7555.924440755604;7566.20554841742;7566.84344961686;7561.508501947384;7584.976028236173;7596.354309883666;7596.430267729942;7599.544027358348;7530;7569.962150189269;7574.621268936531;7577.052868391451;7579.583122928264;7399.3710534604625;7462.70149194037;7470.813229669247;7475.401967842614;7475.439342049368;37142;37760.811195944116;37841.62158378409;37846;37903.81048094769;2998.250437390652;3086.506159014569;3116.9688303116905;3142.5286207068893;3156.71589556941;27973.440531189262;28710.282242943886;28798;29682.70317296821;30120.69879301201;3355.6644335566493;3388.271521622863;3389.7288216942584;3440.8107554084513;3441.2773317603333;239609;239934;240185;240672;241698.7915060431;27715.16854494328;28425.857870710515;52070.739646301525;52505.474945250826;52581.47418525842;33393.666063339544;33690.49464258038;33778.15554611154;33837.66162338345;33860.32279354399;12773.61679149627;12985.740285194242;12985.740285194432;12991.480340786451;12994.740105197843;10534.262601617813;10708.785824283626;10722.517486713117;10724.571017159225;10724.78550428987;7831.882521762178;7839.568823714636;7845.646945887449;7921;7928.207179282141;3083.8612262447796;3105.534169874537;3112.4553203189353;3131.906042818719;3145.2608636970294;863.6207249028885;895.1809094678297;896.3635818568758;897.8742975983367;951.1724799424406;26496;26612.8669356652;27276.72723272742;27450.862745686143;27781.444371112466;818.414833394126;892.7500299916034;896.6682327538853;956.5169589357469;1010.6159659329408;12625;13476.326183690777;13673.86326136726;13703.533363994376;13730.244836534086;371457;374538;374746;374866;375369;49022.26466603004;49614.50385496099;49685;49692;49819.25271120936;1046.278068133001;1063.8138325792954;1102.239454776202;1125.7129431994952;1175.5415387998517;27640;28419.147425577266;28981.275468113465;29071;29382.412351752417;40492.39261411022;41136.38295425511;41141.97145071397;41186.17627647371;41231;238277;238407;238961;239267;239549;37715.81142094272;39340.409893852186;39397.80301098591;41212.793936030124;41451.1709765809;38105.42841857319;38937.61062389453;41571.792141040314;41873.58126418697;42262;35018.64981350256;35757.82121089378;35822.641773582975;35835.28329433449;36195.819020904724;35285.82357088301;35542.64457355393;35613;35852.462213066305;35889.641103589674;33449.49825752664;34152.31695366029;34761.13097172591;34924;35533.466997995565;30110;32369.676303237607;32699.18252043623;32779.508307374934;33209.17721993657;24509.754902450746;24652.630210547213;25322.366940826625;25619;25745 02:51:37 INFO - PROCESS | 26887 | |2;jquery.html;338.13100332146394;352.54521667049505;358.63419312301454;362.13269220217586;380.872407743406;12312.569060082898;13364.7327053459;15432.845671543295;16210.189490525456;17638.029908355034;15894.682106357866;15910.443134490295;15963.600909977256;16062.75905861413;16200.270987805548;3989.381645844884;4964.280179373988;5197.246399272103;5206.635535512516;5207.270982062514;3722.7394082414244;3878.747881387715;5055.368078990126;5095.464976177504;5681.318241810988;5923.407659234085;6002.759889604411;6021.126936594192;6034.396560343975;6054.878902421949;5666.348369937468;5882.852928676774;5936.317323507808;5942.138389933479;6008.158857759917;5155.046316431472;5184.533391994701;5185.144451165553;5185.688858668492;5190.273361729323;19744.70382944257;20410.591788164154;20465.897670511553;20484.590308193754;20551.691724623994;1706.2663054886393;1776.7956684981264;1847.833694967446;1936.4287535177157;2064.4322811226884;8404.915950840474;8571.528565928871;8822.69120580783;8972.685955991508;8993.19061284481;1634.648550561635;1656.5278895514841;1667.1664167916042;1701.9914900425542;1725.0540010427862;66565.33434665688;70134.64932675356;70189.64905175492;72073.66637172087;72386.63806680986;8944.776380590407;9261.30540209487;9275.814483710288;9838.704838854846;10152.949235253776;13743.450261989608;13745.175289482662;13766.724665506634;13775.173489590657;13780.310984450938;6883.174019117638;6883.311668833177;6983.615901125487;7160.427165826722;7163.068801055933;6514.153160089253;6530.8367290818105;6719.160104986877;6727.058211850345;6730.697118629673;4248.553901840324;4286.849960251377;4287.206866729603;4299.14017196562;4411.580899814512;1635.959101022484;1775.6448710258;1795.371619933039;1838.1820090060062;1845.6216475622466;723.5586292361655;815.8368326334756;820.6266148902355;849.2059923971107;894.2577660541734;16205.108719020567;16217.189140542925;16628.83371166297;16808.15959202035;17162.091973311148;802.1657476224777;833.3791325462569;837.6649340263822;877.2236570635034;891.3537685178323;6785.830354241183;9669.951650241705;9683.225341972626;9685.41887486739;9799.657012004545;394493;403864;406472;426925;430646;78094;80065.59967200126;81465;81706.18293817104;82837;780.9140994490601;792.3027735592757;827.2596026556198;827.7020272701823;830.9750707478785;14333.283335832957;14607.26963651792;14765.409383624534;14795.926020369829;15229.6192595186;34754;35333.823330883184;35755.28489430145;36811.26377472489;41064;51067.48932510776;51109.744451277504;51169;51773;53532.46467535275;7151.8569628608175;10831.729206769578;11039.558417663204;11145.387003714874;11170.888291116984;11899;12038.458269378074;12846;12955.352232388532;13398.799018014543;10017.14854237398;10019.749506262402;10068.24488163376;10502.26484146133;10779.838302425313;11062.889371106508;11144.832827507757;11461.598844040418;11545.653630391102;11650.941745291218;10082.546285417027;10102.444365559964;10164.847527287244;10257.435841028815;10790.784184316113;11557.537698491966;11651.242669226813;11730.941345293219;11823.76352472963;11919.94040029829;10338.534765935701;10411.47942602882;10582.153427725609;10634.361938283728;10739.837881760868 02:51:37 INFO - PROCESS | 26887 | |3;mootools.html;1290.7612091763024;1321.2931081871195;1334.1261473734703;1626.8291829357918;1638.5739707676;6153.230846144232;6405.103285540016;6714.496412769044;7194.8920766188485;7207.855842883146;6424.5824021438575;6630.834229144274;6652.268250492442;6785.389314961652;6811.182658081025;2028.0468179955396;2054.9589008219828;2055.2601063617085;2056.0747663551388;2057.9897100514477;1826.936057237997;1899.0694559665803;2003.388966365258;2019.8283145932614;2025.3417639267223;1843.1429385335816;1860.4418674397693;1863.7577114975102;2014.4359579317816;2071.7099606055162;2028.0873606876892;2031.0048076442586;2034.3185033013958;2035.3690355989543;2039.5920815836892;2024.9696254556193;2064.5148390128306;2071.9171233150655;2072.5025993761387;2080.334293026232;6942.791716248521;7005;7009.474289428263;7021;7021.61381124038;4037.253108174997;4155.314373128461;4159.896002599929;4162.146759914241;4163.271427500175;2674.9197524074307;2751.5047291487526;2853.7574306184;2864.5416733322777;2904.6659634142134;904.5432056811268;960.2270172511126;962.5764663548016;983.9262055345806;983.9409635421897;9343.392679475812;9347.158755712018;9376.8593471098;9388.812223755487;9392.389494682891;3742.8877133686033;3932.5674175840636;3933.1347103637154;4006.3990401439432;4046.4132700758814;7074.9646251769445;7315.268473152642;7638.197989211164;7645.311921926942;7648.34989025939;4113.568075352105;4217.536071032184;4229.471316085489;4231.534531201565;4244.087521182899;3958.802059897051;3962.881113566598;3964.207158568298;3965.4448377227213;3968.920621587552;3138.9372212556077;3210.566573512546;3249.23642943908;3304.7025767680543;3341.047801376596;1021.952498688835;1035.1304903880775;1039.8856125826153;1041.317936751429;1042.4318746283293;623.2240860129168;647.4334956912701;712.1063065852322;724.2178447276929;727.2436665867439;4570.81716731327;4616.3537104805355;4621.838235661736;4714.787834547454;4820.71075735457;791.8376732769768;840.2018082821344;843.527624530265;850.1880703927858;853.1809462915546;3089.2276930767307;3104.9068527944196;3130.5617213590117;3140;3201.775875688679;8046.879296810553;8320.334373250247;8347.624356903954;8363.330933525425;8404.369672274604;8285.047219569706;8303.4602750821;8314.334853211729;8326.084130745614;8327.084020757711;6356.300806911236;6509.1863517060365;6649.734010639617;6663.267040625527;6664.067030615718;4476.5299643538265;4540.636749060133;4592.747398893093;4609.631229501565;4742.502037286035;7566.281203285679;7728.4590078693955;7792.181820908723;7846.5292082475235;7884.250996155356;7898.960505197438;7927.920720792718;7941.523508589503;7961.8407631848195;8050.677972881019;5569.08110161835;5685.459881311269;5687.3459552152035;5689.829305120853;5693.345265294544;6473.255575608865;6517.837054073686;6530.47756179514;6539.869202615826;6544;5754.683492407958;5929.16991621182;6009.158717779427;6044.304904935989;6074.483668888194;5891.440313170242;5961.52307815365;5971.104334349709;6021.367756385692;6039.275286965592;5422.972885135549;5539.639923404966;5550.08423610116;5550.750216240198;5551.111822108443;4119.505659320901;4173.624373806372;4262.531121576686;4354.606525911678;4361.847335343247;4165.375193720966;4182.581741825793;4243.639290660329;4284.807183676679;4330.956690433181 02:51:37 INFO - PROCESS | 26887 | |4;prototype.html;282.89532872837054;288.8180446318819;291.83657151994873;292.113435722582;293.65202235351103;4713.76431178441;4742;4768.1894078006735;4774.618030557555;4798.928016079757;4710.434747830265;4713.882152946178;4719.952800471994;4722.480527142012;4740.478547359797;3572.92854142917;3616.6383361663884;3665.3402387570227;3760.417135344026;3768.5854555998817;3687.6865466435383;3688.0964163779913;3698.500702405168;3702.2410405866867;3702.592714801383;3670.9816450917706;3671.779693218402;3672.706183505313;3679.4112941929297;3679.816009199543;3525.5769307682986;3571.5892672342493;3621.746477746559;3670.1925576373287;3671.6144804795513;3211.96788032119;3218.1311046017445;3229.531717900915;3230.7576931730214;3237.838108094609;4584.951007579955;4585.197590421662;4585.839495617637;4602.4477062752685;4622.260438329851;4049.400486807724;4149.771762553059;4163.708540402173;4166.291730405808;4167.895802604929;4881.267809828554;4890.144224760688;4898.877528061791;4902.166631672624;4909.459959404463;3551.5027896094566;3554.928901421957;3562.750607457479;3563.8574457021687;3575.731820113476;5137.332146820927;5140.485951404867;5152.871178220537;5153.845384638467;5167.715775632339;3525.8765943191866;3633.6366363363454;3644.1436262478296;3661.6338366163172;3671.054341199169;3689.686376658014;3714.665680088805;3718.2563487302104;3719.75821571597;3723.5345581802276;4231.83624503264;4237.872863814029;4244.405783190356;4257.1698518788535;4268.893277668083;4765.5949244314625;4950.4059512858685;4966.4355727945585;4967.205247160437;4991.600671946236;1215.8905698487001;1227;1231.2243286729483;1232.2852745407642;1232.8767123287778;822.8560001999626;834.6786487202471;839.882955668971;853.9573021348908;859.6303589456594;4210.915781684349;4261.932962513179;4285.357196420499;4305.526392096866;4413.801378937956;5121.641485096082;5136.691798492103;5138.460461651547;5146.845594632167;5148.304978827885;4398.846040388635;4408.691391602557;4413.638703293723;4414.1171765647;4416.712913660602;2571.5499787537105;2623.3048242215827;2627.738685431004;2629.5529759940855;2646.682398112239;4654.8130226791955;4657.324687920301;4664.597732167937;4667.906641867144;4669.976650116796;5057.772400241998;5067.214581739836;5078.289039534468;5093.694378337312;5094.77073531692;4420.695894711068;4623.491415944243;4645.353397582881;4685.625149987993;4686.179918514246;4946.183879659816;4972.2790195422185;4973.9554693514765;4986.526280003394;4988.156750652093;4885.4870238624435;4889.364382630235;4891.095147397743;4897.6695846824505;4914.238293064581;4524.7015335430815;4681.729361259854;4855;4880.341153944172;4893.7276308160845;3648.5986541479883;3667.3215455140885;3667.339878821731;3669.449582562637;3673.8611030580605;5145.742712864417;5147.58819294448;5164.845054648366;5174.430812610685;5217.295665085317;4879.292502587176;4999.750012499288;5008.323876276656;5018.146915024382;5036.445990941067;4968.453470118212;4969.726665033458;4990.950090499048;5006.574441172541;5006.874828129326;4925.605951523798;4944.906746051573;4948.38145231846;4949.28235405857;4954.950450495449;4805.471398146271;4829.613630909589;4990.451050384382;5030.57920613986;5058.570021548209;4752.667313288037;4805.711657300573;4908.7545622719435;4913.533214344631;4921.606271498343 02:51:37 INFO - PROCESS | 26887 | |5;yui.html;607.1330658225955;625.140431906129;669.6986356139738;710.6304721544793;730.5689643110563;11638.650840474778;12528.561500347467;12538.81191782124;12581.93709031456;12583.811242831353;11985.700357491067;12220.144589878711;12232.571859984902;12246.755064898696;12247.387630618456;582.0454454694304;600.4625859855427;728.6174758251933;735.9852802943951;746.6640011994624;748.554610007045;753.2655660730771;755.8866170074477;755.9319661230488;756.6103456719794;789.0964845252183;792.0851416613821;794.9046114466272;795.4789612803623;798.3333916179997;607.8419610901176;624.8312955502034;625.8904691678938;626.4925410417576;787.7124849429974;463.02764195190167;559.3567397492916;572.5734327925722;575.9798407055774;578.6528083150118;12335.93832030843;12341.259524428562;12371.75256494874;12381.257124572554;12382.75234495305;10805.783884322269;11058.723531911686;11232.943835280854;11551.075913926865;11716.648500544998;9343.486108264044;9786.363886347364;10125.594976200942;10155.847662285072;10269.89730102697;3940.428637847525;3992.5208974922903;3997.760134391917;4002.8198731057173;4039.3738970459626;41020;41126.58873411288;41610.37584436236;41933.58066419327;42031;9058.139476749699;9260.645998701984;9531.47576883278;9534.28492863038;9535.47554884474;15827;15930.442434514736;15979.760303595456;16056.91971540135;16298.674026519404;6281.120643109968;6294.8426289342215;6372.490200783926;6403.455706265019;6415.743370265231;3582.4089025311055;3630.854765809338;3638.1268495560876;3681.4293784463453;3716.662001679393;2538.2892790018823;2598.740125987424;2618.3061488705507;2619.227327938225;2619.895204191849;451.7267053432626;456.40895040922084;465.03041159182806;470.81167532986393;471.2248351461826;490.1911845455028;504.4325134223998;506.2406390414378;522.1228336394818;539.6869815506997;7171.39043181325;7261.128664560287;7376.262373762581;7467.290607392289;7469.103707555019;428.42163079841964;480.4570834956477;494.16732805223313;526.1607735661613;552.1855263486406;3470.201853573692;3534.293141371736;3546.202104526461;3583.623719509466;3688.63113688629;52929;66814.66592667006;71316;71617.64191179114;72272.27727722656;34227.31545369079;41721;45342.54657453449;46785;57107.42892571104;33085.17287067795;33158.3368332632;33727.42315248503;50183;52380.21429678634;7566.24337566239;8016.1583033782945;8045.87931181021;8072.838543228985;8299;35525.28949421049;37791.62208377881;37919.81040094782;38387;38718.419223711106;43215.78392108019;49838.25242621291;50151.24773128479;50689;51292;10237.48812559384;10274.486275686335;10394.688159355232;10403.791924161324;10407.791844163226;11331.980121789078;11376.146788991024;11772.764544709229;12310.446029928853;12341.197822141532;10545.894541054491;10803.135749139892;10829.51267192994;11068.5572577096;11147.665570032912;10521.368717876952;10688.198385121303;10911.018008379284;11150.665480035612;11360.318380897173;10630.574777008833;10788;10828.620998265023;10930.672079837617;10987;8849.91150088491;8898.59956301955;9221.492817894812;9376.48429336393;9524.904750952403;8587.270082043096;8691.304695624462;9019.594118264562;9214.861777073214;9463.337566370288 02:51:37 INFO - PROCESS | 26887 | __end_tp_report 02:51:37 INFO - PROCESS | 26887 | __start_cc_report 02:51:37 INFO - PROCESS | 26887 | _x_x_mozilla_cycle_collect,1477 02:51:37 INFO - PROCESS | 26887 | __end_cc_report 02:51:37 INFO - PROCESS | 26887 | __startTimestamp1478602297124__endTimestamp 02:51:37 INFO - PROCESS | 26887 | 02:51:37 INFO - PROCESS | 26887 | ------- Summary: start ------- 02:51:37 INFO - PROCESS | 26887 | Number of tests: 6 02:51:37 INFO - PROCESS | 26887 | 02:51:37 INFO - PROCESS | 26887 | [#0] dojo.html Cycles:165 Average:4652.70 Median:4792.45 stddev:484.80 (10.1%) stddev-sans-first:458.44 02:51:37 INFO - PROCESS | 26887 | Values: 2588.3 2621.7 2628.7 2653.0 2664.8 4618.9 4700.9 4752.5 4786.7 4787.9 4703.8 4740.6 4747.6 4792.4 4792.7 4274.1 4280.2 4290.4 4343.9 4404.1 4283.1 4426.6 4448.1 4454.8 4498.0 4263.3 4306.5 4433.7 4464.3 4483.5 4362.6 4383.2 4385.7 4387.7 4391.4 4356.0 4361.9 4365.4 4369.9 4371.3 4707.5 4718.5 4723.0 4724.4 4728.1 4985.3 5043.8 5046.9 5051.8 5051.9 4871.5 4890.4 4898.3 4998.2 5007.4 4631.3 4631.9 4634.8 4642.5 4679.9 5031.8 5061.4 5073.9 5077.0 5128.9 4816.1 4851.9 4854.5 4926.3 4931.0 5000.8 5004.8 5005.3 5006.6 5010.7 4958.8 4967.4 4967.9 4969.2 4975.3 4962.0 4963.9 4969.2 4970.3 4972.4 4204.5 4210.1 4218.1 4219.0 4219.8 3679.3 3683.4 3727.4 3727.9 3815.4 4321.1 4325.8 4329.9 4381.2 4416.6 5145.9 5156.0 5157.3 5157.7 5161.0 4088.9 4219.2 4225.5 4392.9 4426.7 4423.2 4460.0 4498.4 4527.3 4528.3 4708.5 4708.8 4732.0 4735.8 4768.8 4832.8 4863.1 5051.9 5052.6 5098.7 4634.7 4713.4 4741.4 4749.0 4841.7 5051.6 5051.8 5052.0 5055.8 5101.5 4912.0 5106.8 5118.3 5120.4 5120.8 4836.3 4893.9 4900.3 4923.4 4925.0 4923.9 4932.9 4944.9 4964.8 4998.8 4892.7 4893.0 4895.6 4897.0 4926.3 4833.7 4837.3 4886.0 4905.7 5026.8 4821.6 4845.0 4881.8 4921.0 4921.1 02:51:37 INFO - PROCESS | 26887 | 02:51:37 INFO - PROCESS | 26887 | [#1] ext.html Cycles:180 Average:43252.90 Median:35685.41 stddev:76757.42 (215.1%) stddev-sans-first:76905.74 02:51:37 INFO - PROCESS | 26887 | Values: 537.5 545.1 551.4 563.4 573.0 27926.3 33257.8 34518.3 34697.0 37458.4 40638.6 40999.8 41004.6 41083.4 41178.8 7481.9 7617.1 7625.6 7634.3 7635.2 7463.9 7552.3 7555.9 7566.2 7566.8 7561.5 7585.0 7596.4 7596.4 7599.5 7530.0 7570.0 7574.6 7577.1 7579.6 7399.4 7462.7 7470.8 7475.4 7475.4 37142.0 37760.8 37841.6 37846.0 37903.8 2998.3 3086.5 3117.0 3142.5 3156.7 27973.4 28710.3 28798.0 29682.7 30120.7 3355.7 3388.3 3389.7 3440.8 3441.3 239609.0 239934.0 240185.0 240672.0 241698.8 27715.2 28425.9 52070.7 52505.5 52581.5 33393.7 33690.5 33778.2 33837.7 33860.3 12773.6 12985.7 12985.7 12991.5 12994.7 10534.3 10708.8 10722.5 10724.6 10724.8 7831.9 7839.6 7845.6 7921.0 7928.2 3083.9 3105.5 3112.5 3131.9 3145.3 863.6 895.2 896.4 897.9 951.2 26496.0 26612.9 27276.7 27450.9 27781.4 818.4 892.8 896.7 956.5 1010.6 12625.0 13476.3 13673.9 13703.5 13730.2 371457.0 374538.0 374746.0 374866.0 375369.0 49022.3 49614.5 49685.0 49692.0 49819.3 1046.3 1063.8 1102.2 1125.7 1175.5 27640.0 28419.1 28981.3 29071.0 29382.4 40492.4 41136.4 41142.0 41186.2 41231.0 238277.0 238407.0 238961.0 239267.0 239549.0 37715.8 39340.4 39397.8 41212.8 41451.2 38105.4 38937.6 41571.8 41873.6 42262.0 35018.6 35757.8 35822.6 35835.3 36195.8 35285.8 35542.6 35613.0 35852.5 35889.6 33449.5 34152.3 34761.1 34924.0 35533.5 30110.0 32369.7 32699.2 32779.5 33209.2 24509.8 24652.6 25322.4 25619.0 25745.0 02:51:37 INFO - PROCESS | 26887 | 02:51:37 INFO - PROCESS | 26887 | [#2] jquery.html Cycles:180 Average:25160.47 Median:199185.87 stddev:68097.35 (34.2%) stddev-sans-first:68262.88 02:51:37 INFO - PROCESS | 26887 | Values: 338.1 352.5 358.6 362.1 380.9 12312.6 13364.7 15432.8 16210.2 17638.0 15894.7 15910.4 15963.6 16062.8 16200.3 3989.4 4964.3 5197.2 5206.6 5207.3 3722.7 3878.7 5055.4 5095.5 5681.3 5923.4 6002.8 6021.1 6034.4 6054.9 5666.3 5882.9 5936.3 5942.1 6008.2 5155.0 5184.5 5185.1 5185.7 5190.3 19744.7 20410.6 20465.9 20484.6 20551.7 1706.3 1776.8 1847.8 1936.4 2064.4 8404.9 8571.5 8822.7 8972.7 8993.2 1634.6 1656.5 1667.2 1702.0 1725.1 66565.3 70134.6 70189.6 72073.7 72386.6 8944.8 9261.3 9275.8 9838.7 10152.9 13743.5 13745.2 13766.7 13775.2 13780.3 6883.2 6883.3 6983.6 7160.4 7163.1 6514.2 6530.8 6719.2 6727.1 6730.7 4248.6 4286.8 4287.2 4299.1 4411.6 1636.0 1775.6 1795.4 1838.2 1845.6 723.6 815.8 820.6 849.2 894.3 16205.1 16217.2 16628.8 16808.2 17162.1 802.2 833.4 837.7 877.2 891.4 6785.8 9670.0 9683.2 9685.4 9799.7 394493.0 403864.0 406472.0 426925.0 430646.0 78094.0 80065.6 81465.0 81706.2 82837.0 780.9 792.3 827.3 827.7 831.0 14333.3 14607.3 14765.4 14795.9 15229.6 34754.0 35333.8 35755.3 36811.3 41064.0 51067.5 51109.7 51169.0 51773.0 53532.5 7151.9 10831.7 11039.6 11145.4 11170.9 11899.0 12038.5 12846.0 12955.4 13398.8 10017.1 10019.7 10068.2 10502.3 10779.8 11062.9 11144.8 11461.6 11545.7 11650.9 10082.5 10102.4 10164.8 10257.4 10790.8 11557.5 11651.2 11730.9 11823.8 11919.9 10338.5 10411.5 10582.2 10634.4 10739.8 02:51:37 INFO - PROCESS | 26887 | 02:51:37 INFO - PROCESS | 26887 | [#3] mootools.html Cycles:180 Average:4554.32 Median:5481.31 stddev:2453.98 (44.8%) stddev-sans-first:2448.61 02:51:37 INFO - PROCESS | 26887 | Values: 1290.8 1321.3 1334.1 1626.8 1638.6 6153.2 6405.1 6714.5 7194.9 7207.9 6424.6 6630.8 6652.3 6785.4 6811.2 2028.0 2055.0 2055.3 2056.1 2058.0 1826.9 1899.1 2003.4 2019.8 2025.3 1843.1 1860.4 1863.8 2014.4 2071.7 2028.1 2031.0 2034.3 2035.4 2039.6 2025.0 2064.5 2071.9 2072.5 2080.3 6942.8 7005.0 7009.5 7021.0 7021.6 4037.3 4155.3 4159.9 4162.1 4163.3 2674.9 2751.5 2853.8 2864.5 2904.7 904.5 960.2 962.6 983.9 983.9 9343.4 9347.2 9376.9 9388.8 9392.4 3742.9 3932.6 3933.1 4006.4 4046.4 7075.0 7315.3 7638.2 7645.3 7648.3 4113.6 4217.5 4229.5 4231.5 4244.1 3958.8 3962.9 3964.2 3965.4 3968.9 3138.9 3210.6 3249.2 3304.7 3341.0 1022.0 1035.1 1039.9 1041.3 1042.4 623.2 647.4 712.1 724.2 727.2 4570.8 4616.4 4621.8 4714.8 4820.7 791.8 840.2 843.5 850.2 853.2 3089.2 3104.9 3130.6 3140.0 3201.8 8046.9 8320.3 8347.6 8363.3 8404.4 8285.0 8303.5 8314.3 8326.1 8327.1 6356.3 6509.2 6649.7 6663.3 6664.1 4476.5 4540.6 4592.7 4609.6 4742.5 7566.3 7728.5 7792.2 7846.5 7884.3 7899.0 7927.9 7941.5 7961.8 8050.7 5569.1 5685.5 5687.3 5689.8 5693.3 6473.3 6517.8 6530.5 6539.9 6544.0 5754.7 5929.2 6009.2 6044.3 6074.5 5891.4 5961.5 5971.1 6021.4 6039.3 5423.0 5539.6 5550.1 5550.8 5551.1 4119.5 4173.6 4262.5 4354.6 4361.8 4165.4 4182.6 4243.6 4284.8 4331.0 02:51:37 INFO - PROCESS | 26887 | 02:51:37 INFO - PROCESS | 26887 | [#4] prototype.html Cycles:180 Average:4100.03 Median:4660.96 stddev:1191.89 (25.6%) stddev-sans-first:1160.29 02:51:37 INFO - PROCESS | 26887 | Values: 282.9 288.8 291.8 292.1 293.7 4713.8 4742.0 4768.2 4774.6 4798.9 4710.4 4713.9 4720.0 4722.5 4740.5 3572.9 3616.6 3665.3 3760.4 3768.6 3687.7 3688.1 3698.5 3702.2 3702.6 3671.0 3671.8 3672.7 3679.4 3679.8 3525.6 3571.6 3621.7 3670.2 3671.6 3212.0 3218.1 3229.5 3230.8 3237.8 4585.0 4585.2 4585.8 4602.4 4622.3 4049.4 4149.8 4163.7 4166.3 4167.9 4881.3 4890.1 4898.9 4902.2 4909.5 3551.5 3554.9 3562.8 3563.9 3575.7 5137.3 5140.5 5152.9 5153.8 5167.7 3525.9 3633.6 3644.1 3661.6 3671.1 3689.7 3714.7 3718.3 3719.8 3723.5 4231.8 4237.9 4244.4 4257.2 4268.9 4765.6 4950.4 4966.4 4967.2 4991.6 1215.9 1227.0 1231.2 1232.3 1232.9 822.9 834.7 839.9 854.0 859.6 4210.9 4261.9 4285.4 4305.5 4413.8 5121.6 5136.7 5138.5 5146.8 5148.3 4398.8 4408.7 4413.6 4414.1 4416.7 2571.5 2623.3 2627.7 2629.6 2646.7 4654.8 4657.3 4664.6 4667.9 4670.0 5057.8 5067.2 5078.3 5093.7 5094.8 4420.7 4623.5 4645.4 4685.6 4686.2 4946.2 4972.3 4974.0 4986.5 4988.2 4885.5 4889.4 4891.1 4897.7 4914.2 4524.7 4681.7 4855.0 4880.3 4893.7 3648.6 3667.3 3667.3 3669.4 3673.9 5145.7 5147.6 5164.8 5174.4 5217.3 4879.3 4999.8 5008.3 5018.1 5036.4 4968.5 4969.7 4991.0 5006.6 5006.9 4925.6 4944.9 4948.4 4949.3 4955.0 4805.5 4829.6 4990.5 5030.6 5058.6 4752.7 4805.7 4908.8 4913.5 4921.6 02:51:37 INFO - PROCESS | 26887 | 02:51:37 INFO - PROCESS | 26887 | [#5] yui.html Cycles:180 Average:13288.30 Median:22897.14 stddev:16332.49 (71.3%) stddev-sans-first:16350.54 02:51:37 INFO - PROCESS | 26887 | Values: 607.1 625.1 669.7 710.6 730.6 11638.7 12528.6 12538.8 12581.9 12583.8 11985.7 12220.1 12232.6 12246.8 12247.4 582.0 600.5 728.6 736.0 746.7 748.6 753.3 755.9 755.9 756.6 789.1 792.1 794.9 795.5 798.3 607.8 624.8 625.9 626.5 787.7 463.0 559.4 572.6 576.0 578.7 12335.9 12341.3 12371.8 12381.3 12382.8 10805.8 11058.7 11232.9 11551.1 11716.6 9343.5 9786.4 10125.6 10155.8 10269.9 3940.4 3992.5 3997.8 4002.8 4039.4 41020.0 41126.6 41610.4 41933.6 42031.0 9058.1 9260.6 9531.5 9534.3 9535.5 15827.0 15930.4 15979.8 16056.9 16298.7 6281.1 6294.8 6372.5 6403.5 6415.7 3582.4 3630.9 3638.1 3681.4 3716.7 2538.3 2598.7 2618.3 2619.2 2619.9 451.7 456.4 465.0 470.8 471.2 490.2 504.4 506.2 522.1 539.7 7171.4 7261.1 7376.3 7467.3 7469.1 428.4 480.5 494.2 526.2 552.2 3470.2 3534.3 3546.2 3583.6 3688.6 52929.0 66814.7 71316.0 71617.6 72272.3 34227.3 41721.0 45342.5 46785.0 57107.4 33085.2 33158.3 33727.4 50183.0 52380.2 7566.2 8016.2 8045.9 8072.8 8299.0 35525.3 37791.6 37919.8 38387.0 38718.4 43215.8 49838.3 50151.2 50689.0 51292.0 10237.5 10274.5 10394.7 10403.8 10407.8 11332.0 11376.1 11772.8 12310.4 12341.2 10545.9 10803.1 10829.5 11068.6 11147.7 10521.4 10688.2 10911.0 11150.7 11360.3 10630.6 10788.0 10828.6 10930.7 10987.0 8849.9 8898.6 9221.5 9376.5 9524.9 8587.3 8691.3 9019.6 9214.9 9463.3 02:51:37 INFO - PROCESS | 26887 | -------- Summary: end -------- 02:51:37 INFO - PROCESS | 26887 | 02:51:38 INFO - TEST-INFO | 26887: exit 0 02:51:38 INFO - TEST-OK | dromaeo_css | took 1124536ms 02:51:38 INFO - TEST-START | kraken 02:51:38 INFO - operating with platform_type : linux_ 02:51:38 INFO - Initialising browser for kraken test... 02:51:38 INFO - TEST-INFO | started process 27191 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5w1KZH/profile http://localhost:48901/getInfo.html) 02:51:42 INFO - PROCESS | 27191 | __metrics Screen width/height:1600/1200 02:51:42 INFO - PROCESS | 27191 | colorDepth:24 02:51:42 INFO - PROCESS | 27191 | Browser inner width/height: 1024/697 02:51:42 INFO - PROCESS | 27191 | __metrics 02:51:42 INFO - PROCESS | 27191 | 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" 02:51:42 INFO - PROCESS | 27191 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:51:43 INFO - PROCESS | 27191 | console.error: PushService: 02:51:43 INFO - PROCESS | 27191 | stateChangeProcessEnqueue: Error transitioning state 02:51:43 INFO - PROCESS | 27191 | UnknownError 02:51:44 INFO - TEST-INFO | 27191: exit 0 02:51:44 INFO - Browser initialized. 02:51:44 INFO - Running cycle 1/1 for kraken test... 02:51:44 INFO - TEST-INFO | started process 27271 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5w1KZH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:51:56 INFO - PROCESS | 27271 | RSS: Main: 174292992 02:51:56 INFO - PROCESS | 27271 | 02:51:59 INFO - PROCESS | 27271 | Cycle 1(1): loaded http://localhost:48901/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48901/tests/kraken/driver.html?testName=audio-beat-detection) 02:52:00 INFO - PROCESS | 27271 | RSS: Main: 230141952 02:52:00 INFO - PROCESS | 27271 | 02:52:03 INFO - PROCESS | 27271 | Cycle 1(1): loaded http://localhost:48901/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48901/tests/kraken/driver.html?testName=audio-dft) 02:52:03 INFO - PROCESS | 27271 | RSS: Main: 217874432 02:52:03 INFO - PROCESS | 27271 | 02:52:06 INFO - PROCESS | 27271 | Cycle 1(1): loaded http://localhost:48901/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48901/tests/kraken/driver.html?testName=audio-fft) 02:52:07 INFO - PROCESS | 27271 | RSS: Main: 299159552 02:52:07 INFO - PROCESS | 27271 | 02:52:09 INFO - PROCESS | 27271 | Cycle 1(1): loaded http://localhost:48901/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48901/tests/kraken/driver.html?testName=audio-oscillator) 02:52:10 INFO - PROCESS | 27271 | RSS: Main: 211234816 02:52:10 INFO - PROCESS | 27271 | 02:52:12 INFO - PROCESS | 27271 | Cycle 1(1): loaded http://localhost:48901/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48901/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:52:13 INFO - PROCESS | 27271 | RSS: Main: 214544384 02:52:13 INFO - PROCESS | 27271 | 02:52:16 INFO - PROCESS | 27271 | Cycle 1(1): loaded http://localhost:48901/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48901/tests/kraken/driver.html?testName=imaging-darkroom) 02:52:16 INFO - PROCESS | 27271 | RSS: Main: 249069568 02:52:16 INFO - PROCESS | 27271 | 02:52:20 INFO - PROCESS | 27271 | Cycle 1(1): loaded http://localhost:48901/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48901/tests/kraken/driver.html?testName=imaging-desaturate) 02:52:20 INFO - PROCESS | 27271 | RSS: Main: 248692736 02:52:20 INFO - PROCESS | 27271 | 02:52:23 INFO - PROCESS | 27271 | Cycle 1(1): loaded http://localhost:48901/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48901/tests/kraken/driver.html?testName=json-parse-financial) 02:52:24 INFO - PROCESS | 27271 | RSS: Main: 248602624 02:52:24 INFO - PROCESS | 27271 | 02:52:26 INFO - PROCESS | 27271 | Cycle 1(1): loaded http://localhost:48901/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48901/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:52:26 INFO - PROCESS | 27271 | RSS: Main: 210694144 02:52:26 INFO - PROCESS | 27271 | 02:52:28 INFO - PROCESS | 27271 | Cycle 1(1): loaded http://localhost:48901/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48901/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:52:29 INFO - PROCESS | 27271 | RSS: Main: 218218496 02:52:29 INFO - PROCESS | 27271 | 02:52:31 INFO - PROCESS | 27271 | Cycle 1(1): loaded http://localhost:48901/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48901/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:52:31 INFO - PROCESS | 27271 | RSS: Main: 226799616 02:52:31 INFO - PROCESS | 27271 | 02:52:34 INFO - PROCESS | 27271 | Cycle 1(1): loaded http://localhost:48901/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48901/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:52:35 INFO - PROCESS | 27271 | RSS: Main: 235581440 02:52:35 INFO - PROCESS | 27271 | 02:52:38 INFO - PROCESS | 27271 | Cycle 1(1): loaded http://localhost:48901/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48901/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:52:39 INFO - PROCESS | 27271 | RSS: Main: 231587840 02:52:39 INFO - PROCESS | 27271 | 02:52:40 INFO - PROCESS | 27271 | Cycle 1(1): loaded http://localhost:48901/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48901/tests/kraken/driver.html?testName=ai-astar) 02:52:41 INFO - PROCESS | 27271 | RSS: Main: 282968064 02:52:41 INFO - PROCESS | 27271 | 02:52:41 INFO - PROCESS | 27271 | __start_tp_report 02:52:41 INFO - PROCESS | 27271 | _x_x_mozilla_page_load 02:52:41 INFO - PROCESS | 27271 | _x_x_mozilla_page_load_details 02:52:41 INFO - PROCESS | 27271 | |i|pagename|runs| 02:52:41 INFO - PROCESS | 27271 | |0;ai-astar;107;114;115;114;114;114;116;115;115;113 02:52:41 INFO - PROCESS | 27271 | |1;audio-beat-detection;150;134;136;168;132;128;126;137;162;134 02:52:41 INFO - PROCESS | 27271 | |2;audio-dft;168;161;162;162;162;160;162;160;160;160 02:52:41 INFO - PROCESS | 27271 | |3;audio-fft;75;76;78;111;79;76;77;76;103;76 02:52:41 INFO - PROCESS | 27271 | |4;audio-oscillator;83;84;114;85;85;91;111;83;82;116 02:52:41 INFO - PROCESS | 27271 | |5;imaging-gaussian-blur;117;117;116;117;117;117;117;117;117;117 02:52:41 INFO - PROCESS | 27271 | |6;imaging-darkroom;149;147;147;147;146;147;148;148;148;146 02:52:41 INFO - PROCESS | 27271 | |7;imaging-desaturate;84;84;85;84;84;85;86;85;85;85 02:52:41 INFO - PROCESS | 27271 | |8;json-parse-financial;65;63;63;63;63;65;64;65;66;65 02:52:41 INFO - PROCESS | 27271 | |9;json-stringify-tinderbox;66;67;66;66;68;66;67;65;68;66 02:52:41 INFO - PROCESS | 27271 | |10;stanford-crypto-aes;85;90;84;83;84;92;84;86;83;83 02:52:41 INFO - PROCESS | 27271 | |11;stanford-crypto-ccm;145;151;139;144;141;151;144;153;185;145 02:52:41 INFO - PROCESS | 27271 | |12;stanford-crypto-pbkdf2;176;180;177;176;176;175;176;174;174;176 02:52:41 INFO - PROCESS | 27271 | |13;stanford-crypto-sha256-iterative;69;73;73;73;69;68;68;69;70;67 02:52:41 INFO - PROCESS | 27271 | __end_tp_report 02:52:41 INFO - PROCESS | 27271 | __start_cc_report 02:52:41 INFO - PROCESS | 27271 | _x_x_mozilla_cycle_collect,1949 02:52:41 INFO - PROCESS | 27271 | __end_cc_report 02:52:41 INFO - PROCESS | 27271 | __startTimestamp1478602361126__endTimestamp 02:52:41 INFO - PROCESS | 27271 | 02:52:41 INFO - PROCESS | 27271 | ------- Summary: start ------- 02:52:41 INFO - PROCESS | 27271 | Number of tests: 14 02:52:41 INFO - PROCESS | 27271 | 02:52:41 INFO - PROCESS | 27271 | [#0] ai-astar Cycles:10 Average:113.70 Median:114.50 stddev:2.50 (2.2%) stddev-sans-first:0.88 02:52:41 INFO - PROCESS | 27271 | Values: 107.0 114.0 115.0 114.0 114.0 114.0 116.0 115.0 115.0 113.0 02:52:41 INFO - PROCESS | 27271 | 02:52:41 INFO - PROCESS | 27271 | [#1] audio-beat-detection Cycles:10 Average:140.70 Median:136.50 stddev:14.39 (10.5%) stddev-sans-first:14.87 02:52:41 INFO - PROCESS | 27271 | Values: 150.0 134.0 136.0 168.0 132.0 128.0 126.0 137.0 162.0 134.0 02:52:41 INFO - PROCESS | 27271 | 02:52:41 INFO - PROCESS | 27271 | [#2] audio-dft Cycles:10 Average:161.70 Median:162.00 stddev:2.41 (1.5%) stddev-sans-first:1.00 02:52:41 INFO - PROCESS | 27271 | Values: 168.0 161.0 162.0 162.0 162.0 160.0 162.0 160.0 160.0 160.0 02:52:41 INFO - PROCESS | 27271 | 02:52:41 INFO - PROCESS | 27271 | [#3] audio-fft Cycles:10 Average:82.70 Median:76.00 stddev:13.00 (17.1%) stddev-sans-first:13.48 02:52:41 INFO - PROCESS | 27271 | Values: 75.0 76.0 78.0 111.0 79.0 76.0 77.0 76.0 103.0 76.0 02:52:41 INFO - PROCESS | 27271 | 02:52:41 INFO - PROCESS | 27271 | [#4] audio-oscillator Cycles:10 Average:93.40 Median:83.50 stddev:14.25 (17.1%) stddev-sans-first:14.60 02:52:41 INFO - PROCESS | 27271 | Values: 83.0 84.0 114.0 85.0 85.0 91.0 111.0 83.0 82.0 116.0 02:52:41 INFO - PROCESS | 27271 | 02:52:41 INFO - PROCESS | 27271 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 02:52:41 INFO - PROCESS | 27271 | Values: 117.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 02:52:41 INFO - PROCESS | 27271 | 02:52:41 INFO - PROCESS | 27271 | [#6] imaging-darkroom Cycles:10 Average:147.30 Median:147.50 stddev:0.95 (0.6%) stddev-sans-first:0.78 02:52:41 INFO - PROCESS | 27271 | Values: 149.0 147.0 147.0 147.0 146.0 147.0 148.0 148.0 148.0 146.0 02:52:41 INFO - PROCESS | 27271 | 02:52:41 INFO - PROCESS | 27271 | [#7] imaging-desaturate Cycles:10 Average:84.70 Median:85.00 stddev:0.67 (0.8%) stddev-sans-first:0.67 02:52:41 INFO - PROCESS | 27271 | Values: 84.0 84.0 85.0 84.0 84.0 85.0 86.0 85.0 85.0 85.0 02:52:41 INFO - PROCESS | 27271 | 02:52:41 INFO - PROCESS | 27271 | [#8] json-parse-financial Cycles:10 Average:64.20 Median:65.00 stddev:1.14 (1.7%) stddev-sans-first:1.17 02:52:41 INFO - PROCESS | 27271 | Values: 65.0 63.0 63.0 63.0 63.0 65.0 64.0 65.0 66.0 65.0 02:52:41 INFO - PROCESS | 27271 | 02:52:41 INFO - PROCESS | 27271 | [#9] json-stringify-tinderbox Cycles:10 Average:66.50 Median:66.50 stddev:0.97 (1.5%) stddev-sans-first:1.01 02:52:41 INFO - PROCESS | 27271 | Values: 66.0 67.0 66.0 66.0 68.0 66.0 67.0 65.0 68.0 66.0 02:52:41 INFO - PROCESS | 27271 | 02:52:41 INFO - PROCESS | 27271 | [#10] stanford-crypto-aes Cycles:10 Average:85.40 Median:84.50 stddev:3.13 (3.7%) stddev-sans-first:3.32 02:52:41 INFO - PROCESS | 27271 | Values: 85.0 90.0 84.0 83.0 84.0 92.0 84.0 86.0 83.0 83.0 02:52:41 INFO - PROCESS | 27271 | 02:52:41 INFO - PROCESS | 27271 | [#11] stanford-crypto-ccm Cycles:10 Average:149.80 Median:148.00 stddev:13.16 (8.9%) stddev-sans-first:13.85 02:52:41 INFO - PROCESS | 27271 | Values: 145.0 151.0 139.0 144.0 141.0 151.0 144.0 153.0 185.0 145.0 02:52:41 INFO - PROCESS | 27271 | 02:52:41 INFO - PROCESS | 27271 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.00 Median:176.00 stddev:1.70 (1.0%) stddev-sans-first:1.80 02:52:41 INFO - PROCESS | 27271 | Values: 176.0 180.0 177.0 176.0 176.0 175.0 176.0 174.0 174.0 176.0 02:52:41 INFO - PROCESS | 27271 | 02:52:41 INFO - PROCESS | 27271 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.90 Median:69.50 stddev:2.28 (3.3%) stddev-sans-first:2.40 02:52:41 INFO - PROCESS | 27271 | Values: 69.0 73.0 73.0 73.0 69.0 68.0 68.0 69.0 70.0 67.0 02:52:41 INFO - PROCESS | 27271 | -------- Summary: end -------- 02:52:41 INFO - PROCESS | 27271 | 02:52:42 INFO - TEST-INFO | 27271: exit 0 02:52:42 INFO - TEST-OK | kraken | took 64354ms 02:52:42 INFO - SUITE-END | took 1188s 02:52:42 INFO - Completed test suite (00:19:49) 02:52:42 INFO - javascript benchmark 02:52:42 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2588.262345231609, 2621.7116117227115, 2628.723983981682, 2653.0, 2664.8401095934246, 4618.861434156972, 4700.858974230779, 4752.524747525245, 4786.688865223762, 4787.928181077286, 4703.7883295251795, 4740.620750339973, 4747.62019038477, 4792.448868380137, 4792.736399498035, 4274.1451709658195, 4280.1653677532895, 4290.420793192926, 4343.891402714926, 4404.097160082191, 4283.121959998209, 4426.557344265564, 4448.110377924412, 4454.821807127711, 4498.032922921571, 4263.253930562139, 4306.483222013347, 4433.667474939392, 4464.330350447426, 4483.50681425043, 4362.563743625644, 4383.232934236496, 4385.6710746694125, 4387.73673579583, 4391.363252328427, 4356.041670832412, 4361.9127617447475, 4365.367021781855, 4369.890752731176, 4371.3224450209955, 4707.45864225615, 4718.457377401608, 4723.0, 4724.433068031858, 4728.148933192024, 4985.252212168168, 5043.798248070073, 5046.924296135561, 5051.772670229849, 5051.949480505222, 4871.537203965618, 4890.413150421937, 4898.314236006961, 4998.225275082332, 5007.4491805901325, 4631.282151266559, 4631.884202894955, 4634.814607415733, 4642.4661163966575, 4679.906401871944, 5031.823886163967, 5061.392632884077, 5073.949260507421, 5076.974615126901, 5128.871778205575, 4816.109019831342, 4851.854444366674, 4854.490278520775, 4926.261060840831, 4931.0, 5000.824971125993, 5004.799808007639, 5005.274235235943, 5006.64953453262, 5010.69935803853, 4958.826441074545, 4967.403911530567, 4967.90064198714, 4969.155243608595, 4975.328330675385, 4962.007598480318, 4963.875903102451, 4969.204927211629, 4970.254461830682, 4972.353594032825, 4204.474440694913, 4210.094829611587, 4218.093109981369, 4219.029623186684, 4219.831206751757, 3679.3377192105677, 3683.4290684943876, 3727.38498147808, 3727.9254414912093, 3815.4086116651965, 4321.092570560155, 4325.84859529915, 4329.891752706145, 4381.21138195128, 4416.558344165622, 5145.922811157836, 5156.0, 5157.32954715892, 5157.690538567698, 5161.0, 4088.9182216356103, 4219.2194444027955, 4225.492940847118, 4392.879815646989, 4426.712263702849, 4423.181711383404, 4459.955400446019, 4498.370228168124, 4527.275635898241, 4528.252838281646, 4708.505606911362, 4708.788104535372, 4731.976340118277, 4735.810567577259, 4768.76156192196, 4832.830850920201, 4863.076015557032, 5051.949480505148, 5052.59579233653, 5098.719570423514, 4634.72191668501, 4713.387259656222, 4741.431028276629, 4748.952510474851, 4841.709497430165, 5051.621128415457, 5051.797928082982, 5052.040112378636, 5055.848324550269, 5101.51535604117, 4912.0, 5106.846794596168, 5118.257852611276, 5120.359955005624, 5120.769565369493, 4836.250381190921, 4893.926591101065, 4900.26496025599, 4923.433805112315, 4925.014997000542, 4923.901521969612, 4932.926006109983, 4944.8763780905765, 4964.751762411793, 4998.750062496933, 4892.65751397413, 4893.021395720799, 4895.583875370491, 4897.0450762101045, 4926.285688575208, 4833.709977401367, 4837.298591704112, 4886.047220791911, 4905.656604037683, 5026.84919452417, 4821.63837712166, 4845.0, 4881.780319885543, 4920.975395123001, 4921.064997650578], "value": 4621.893838487855, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [537.4893850841701, 545.1441237257508, 551.3907132618456, 563.4337490821729, 572.9657967368897, 27926.301842453948, 33257.833710831444, 34518.30963380734, 34697.0, 37458.43812342817, 40638.59361406385, 40999.79500102503, 41004.58995410045, 41083.38374924379, 41178.794106029505, 7481.850362992724, 7617.085949686018, 7625.580593067379, 7634.274743899321, 7635.236476352348, 7463.888041679379, 7552.282533159341, 7555.924440755604, 7566.20554841742, 7566.84344961686, 7561.508501947384, 7584.976028236173, 7596.354309883666, 7596.430267729942, 7599.544027358348, 7530.0, 7569.962150189269, 7574.621268936531, 7577.052868391451, 7579.583122928264, 7399.3710534604625, 7462.70149194037, 7470.813229669247, 7475.401967842614, 7475.439342049368, 37142.0, 37760.811195944116, 37841.62158378409, 37846.0, 37903.81048094769, 2998.250437390652, 3086.506159014569, 3116.9688303116905, 3142.5286207068893, 3156.71589556941, 27973.440531189262, 28710.282242943886, 28798.0, 29682.70317296821, 30120.69879301201, 3355.6644335566493, 3388.271521622863, 3389.7288216942584, 3440.8107554084513, 3441.2773317603333, 239609.0, 239934.0, 240185.0, 240672.0, 241698.7915060431, 27715.16854494328, 28425.857870710515, 52070.739646301525, 52505.474945250826, 52581.47418525842, 33393.666063339544, 33690.49464258038, 33778.15554611154, 33837.66162338345, 33860.32279354399, 12773.61679149627, 12985.740285194242, 12985.740285194432, 12991.480340786451, 12994.740105197843, 10534.262601617813, 10708.785824283626, 10722.517486713117, 10724.571017159225, 10724.78550428987, 7831.882521762178, 7839.568823714636, 7845.646945887449, 7921.0, 7928.207179282141, 3083.8612262447796, 3105.534169874537, 3112.4553203189353, 3131.906042818719, 3145.2608636970294, 863.6207249028885, 895.1809094678297, 896.3635818568758, 897.8742975983367, 951.1724799424406, 26496.0, 26612.8669356652, 27276.72723272742, 27450.862745686143, 27781.444371112466, 818.414833394126, 892.7500299916034, 896.6682327538853, 956.5169589357469, 1010.6159659329408, 12625.0, 13476.326183690777, 13673.86326136726, 13703.533363994376, 13730.244836534086, 371457.0, 374538.0, 374746.0, 374866.0, 375369.0, 49022.26466603004, 49614.50385496099, 49685.0, 49692.0, 49819.25271120936, 1046.278068133001, 1063.8138325792954, 1102.239454776202, 1125.7129431994952, 1175.5415387998517, 27640.0, 28419.147425577266, 28981.275468113465, 29071.0, 29382.412351752417, 40492.39261411022, 41136.38295425511, 41141.97145071397, 41186.17627647371, 41231.0, 238277.0, 238407.0, 238961.0, 239267.0, 239549.0, 37715.81142094272, 39340.409893852186, 39397.80301098591, 41212.793936030124, 41451.1709765809, 38105.42841857319, 38937.61062389453, 41571.792141040314, 41873.58126418697, 42262.0, 35018.64981350256, 35757.82121089378, 35822.641773582975, 35835.28329433449, 36195.819020904724, 35285.82357088301, 35542.64457355393, 35613.0, 35852.462213066305, 35889.641103589674, 33449.49825752664, 34152.31695366029, 34761.13097172591, 34924.0, 35533.466997995565, 30110.0, 32369.676303237607, 32699.18252043623, 32779.508307374934, 33209.17721993657, 24509.754902450746, 24652.630210547213, 25322.366940826625, 25619.0, 25745.0], "value": 16058.073485609639, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [338.13100332146394, 352.54521667049505, 358.63419312301454, 362.13269220217586, 380.872407743406, 12312.569060082898, 13364.7327053459, 15432.845671543295, 16210.189490525456, 17638.029908355034, 15894.682106357866, 15910.443134490295, 15963.600909977256, 16062.75905861413, 16200.270987805548, 3989.381645844884, 4964.280179373988, 5197.246399272103, 5206.635535512516, 5207.270982062514, 3722.7394082414244, 3878.747881387715, 5055.368078990126, 5095.464976177504, 5681.318241810988, 5923.407659234085, 6002.759889604411, 6021.126936594192, 6034.396560343975, 6054.878902421949, 5666.348369937468, 5882.852928676774, 5936.317323507808, 5942.138389933479, 6008.158857759917, 5155.046316431472, 5184.533391994701, 5185.144451165553, 5185.688858668492, 5190.273361729323, 19744.70382944257, 20410.591788164154, 20465.897670511553, 20484.590308193754, 20551.691724623994, 1706.2663054886393, 1776.7956684981264, 1847.833694967446, 1936.4287535177157, 2064.4322811226884, 8404.915950840474, 8571.528565928871, 8822.69120580783, 8972.685955991508, 8993.19061284481, 1634.648550561635, 1656.5278895514841, 1667.1664167916042, 1701.9914900425542, 1725.0540010427862, 66565.33434665688, 70134.64932675356, 70189.64905175492, 72073.66637172087, 72386.63806680986, 8944.776380590407, 9261.30540209487, 9275.814483710288, 9838.704838854846, 10152.949235253776, 13743.450261989608, 13745.175289482662, 13766.724665506634, 13775.173489590657, 13780.310984450938, 6883.174019117638, 6883.311668833177, 6983.615901125487, 7160.427165826722, 7163.068801055933, 6514.153160089253, 6530.8367290818105, 6719.160104986877, 6727.058211850345, 6730.697118629673, 4248.553901840324, 4286.849960251377, 4287.206866729603, 4299.14017196562, 4411.580899814512, 1635.959101022484, 1775.6448710258, 1795.371619933039, 1838.1820090060062, 1845.6216475622466, 723.5586292361655, 815.8368326334756, 820.6266148902355, 849.2059923971107, 894.2577660541734, 16205.108719020567, 16217.189140542925, 16628.83371166297, 16808.15959202035, 17162.091973311148, 802.1657476224777, 833.3791325462569, 837.6649340263822, 877.2236570635034, 891.3537685178323, 6785.830354241183, 9669.951650241705, 9683.225341972626, 9685.41887486739, 9799.657012004545, 394493.0, 403864.0, 406472.0, 426925.0, 430646.0, 78094.0, 80065.59967200126, 81465.0, 81706.18293817104, 82837.0, 780.9140994490601, 792.3027735592757, 827.2596026556198, 827.7020272701823, 830.9750707478785, 14333.283335832957, 14607.26963651792, 14765.409383624534, 14795.926020369829, 15229.6192595186, 34754.0, 35333.823330883184, 35755.28489430145, 36811.26377472489, 41064.0, 51067.48932510776, 51109.744451277504, 51169.0, 51773.0, 53532.46467535275, 7151.8569628608175, 10831.729206769578, 11039.558417663204, 11145.387003714874, 11170.888291116984, 11899.0, 12038.458269378074, 12846.0, 12955.352232388532, 13398.799018014543, 10017.14854237398, 10019.749506262402, 10068.24488163376, 10502.26484146133, 10779.838302425313, 11062.889371106508, 11144.832827507757, 11461.598844040418, 11545.653630391102, 11650.941745291218, 10082.546285417027, 10102.444365559964, 10164.847527287244, 10257.435841028815, 10790.784184316113, 11557.537698491966, 11651.242669226813, 11730.941345293219, 11823.76352472963, 11919.94040029829, 10338.534765935701, 10411.47942602882, 10582.153427725609, 10634.361938283728, 10739.837881760868], "value": 8260.516232187201, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1290.7612091763024, 1321.2931081871195, 1334.1261473734703, 1626.8291829357918, 1638.5739707676, 6153.230846144232, 6405.103285540016, 6714.496412769044, 7194.8920766188485, 7207.855842883146, 6424.5824021438575, 6630.834229144274, 6652.268250492442, 6785.389314961652, 6811.182658081025, 2028.0468179955396, 2054.9589008219828, 2055.2601063617085, 2056.0747663551388, 2057.9897100514477, 1826.936057237997, 1899.0694559665803, 2003.388966365258, 2019.8283145932614, 2025.3417639267223, 1843.1429385335816, 1860.4418674397693, 1863.7577114975102, 2014.4359579317816, 2071.7099606055162, 2028.0873606876892, 2031.0048076442586, 2034.3185033013958, 2035.3690355989543, 2039.5920815836892, 2024.9696254556193, 2064.5148390128306, 2071.9171233150655, 2072.5025993761387, 2080.334293026232, 6942.791716248521, 7005.0, 7009.474289428263, 7021.0, 7021.61381124038, 4037.253108174997, 4155.314373128461, 4159.896002599929, 4162.146759914241, 4163.271427500175, 2674.9197524074307, 2751.5047291487526, 2853.7574306184, 2864.5416733322777, 2904.6659634142134, 904.5432056811268, 960.2270172511126, 962.5764663548016, 983.9262055345806, 983.9409635421897, 9343.392679475812, 9347.158755712018, 9376.8593471098, 9388.812223755487, 9392.389494682891, 3742.8877133686033, 3932.5674175840636, 3933.1347103637154, 4006.3990401439432, 4046.4132700758814, 7074.9646251769445, 7315.268473152642, 7638.197989211164, 7645.311921926942, 7648.34989025939, 4113.568075352105, 4217.536071032184, 4229.471316085489, 4231.534531201565, 4244.087521182899, 3958.802059897051, 3962.881113566598, 3964.207158568298, 3965.4448377227213, 3968.920621587552, 3138.9372212556077, 3210.566573512546, 3249.23642943908, 3304.7025767680543, 3341.047801376596, 1021.952498688835, 1035.1304903880775, 1039.8856125826153, 1041.317936751429, 1042.4318746283293, 623.2240860129168, 647.4334956912701, 712.1063065852322, 724.2178447276929, 727.2436665867439, 4570.81716731327, 4616.3537104805355, 4621.838235661736, 4714.787834547454, 4820.71075735457, 791.8376732769768, 840.2018082821344, 843.527624530265, 850.1880703927858, 853.1809462915546, 3089.2276930767307, 3104.9068527944196, 3130.5617213590117, 3140.0, 3201.775875688679, 8046.879296810553, 8320.334373250247, 8347.624356903954, 8363.330933525425, 8404.369672274604, 8285.047219569706, 8303.4602750821, 8314.334853211729, 8326.084130745614, 8327.084020757711, 6356.300806911236, 6509.1863517060365, 6649.734010639617, 6663.267040625527, 6664.067030615718, 4476.5299643538265, 4540.636749060133, 4592.747398893093, 4609.631229501565, 4742.502037286035, 7566.281203285679, 7728.4590078693955, 7792.181820908723, 7846.5292082475235, 7884.250996155356, 7898.960505197438, 7927.920720792718, 7941.523508589503, 7961.8407631848195, 8050.677972881019, 5569.08110161835, 5685.459881311269, 5687.3459552152035, 5689.829305120853, 5693.345265294544, 6473.255575608865, 6517.837054073686, 6530.47756179514, 6539.869202615826, 6544.0, 5754.683492407958, 5929.16991621182, 6009.158717779427, 6044.304904935989, 6074.483668888194, 5891.440313170242, 5961.52307815365, 5971.104334349709, 6021.367756385692, 6039.275286965592, 5422.972885135549, 5539.639923404966, 5550.08423610116, 5550.750216240198, 5551.111822108443, 4119.505659320901, 4173.624373806372, 4262.531121576686, 4354.606525911678, 4361.847335343247, 4165.375193720966, 4182.581741825793, 4243.639290660329, 4284.807183676679, 4330.956690433181], "value": 3723.8079001312, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [282.89532872837054, 288.8180446318819, 291.83657151994873, 292.113435722582, 293.65202235351103, 4713.76431178441, 4742.0, 4768.1894078006735, 4774.618030557555, 4798.928016079757, 4710.434747830265, 4713.882152946178, 4719.952800471994, 4722.480527142012, 4740.478547359797, 3572.92854142917, 3616.6383361663884, 3665.3402387570227, 3760.417135344026, 3768.5854555998817, 3687.6865466435383, 3688.0964163779913, 3698.500702405168, 3702.2410405866867, 3702.592714801383, 3670.9816450917706, 3671.779693218402, 3672.706183505313, 3679.4112941929297, 3679.816009199543, 3525.5769307682986, 3571.5892672342493, 3621.746477746559, 3670.1925576373287, 3671.6144804795513, 3211.96788032119, 3218.1311046017445, 3229.531717900915, 3230.7576931730214, 3237.838108094609, 4584.951007579955, 4585.197590421662, 4585.839495617637, 4602.4477062752685, 4622.260438329851, 4049.400486807724, 4149.771762553059, 4163.708540402173, 4166.291730405808, 4167.895802604929, 4881.267809828554, 4890.144224760688, 4898.877528061791, 4902.166631672624, 4909.459959404463, 3551.5027896094566, 3554.928901421957, 3562.750607457479, 3563.8574457021687, 3575.731820113476, 5137.332146820927, 5140.485951404867, 5152.871178220537, 5153.845384638467, 5167.715775632339, 3525.8765943191866, 3633.6366363363454, 3644.1436262478296, 3661.6338366163172, 3671.054341199169, 3689.686376658014, 3714.665680088805, 3718.2563487302104, 3719.75821571597, 3723.5345581802276, 4231.83624503264, 4237.872863814029, 4244.405783190356, 4257.1698518788535, 4268.893277668083, 4765.5949244314625, 4950.4059512858685, 4966.4355727945585, 4967.205247160437, 4991.600671946236, 1215.8905698487001, 1227.0, 1231.2243286729483, 1232.2852745407642, 1232.8767123287778, 822.8560001999626, 834.6786487202471, 839.882955668971, 853.9573021348908, 859.6303589456594, 4210.915781684349, 4261.932962513179, 4285.357196420499, 4305.526392096866, 4413.801378937956, 5121.641485096082, 5136.691798492103, 5138.460461651547, 5146.845594632167, 5148.304978827885, 4398.846040388635, 4408.691391602557, 4413.638703293723, 4414.1171765647, 4416.712913660602, 2571.5499787537105, 2623.3048242215827, 2627.738685431004, 2629.5529759940855, 2646.682398112239, 4654.8130226791955, 4657.324687920301, 4664.597732167937, 4667.906641867144, 4669.976650116796, 5057.772400241998, 5067.214581739836, 5078.289039534468, 5093.694378337312, 5094.77073531692, 4420.695894711068, 4623.491415944243, 4645.353397582881, 4685.625149987993, 4686.179918514246, 4946.183879659816, 4972.2790195422185, 4973.9554693514765, 4986.526280003394, 4988.156750652093, 4885.4870238624435, 4889.364382630235, 4891.095147397743, 4897.6695846824505, 4914.238293064581, 4524.7015335430815, 4681.729361259854, 4855.0, 4880.341153944172, 4893.7276308160845, 3648.5986541479883, 3667.3215455140885, 3667.339878821731, 3669.449582562637, 3673.8611030580605, 5145.742712864417, 5147.58819294448, 5164.845054648366, 5174.430812610685, 5217.295665085317, 4879.292502587176, 4999.750012499288, 5008.323876276656, 5018.146915024382, 5036.445990941067, 4968.453470118212, 4969.726665033458, 4990.950090499048, 5006.574441172541, 5006.874828129326, 4925.605951523798, 4944.906746051573, 4948.38145231846, 4949.28235405857, 4954.950450495449, 4805.471398146271, 4829.613630909589, 4990.451050384382, 5030.57920613986, 5058.570021548209, 4752.667313288037, 4805.711657300573, 4908.7545622719435, 4913.533214344631, 4921.606271498343], "value": 3719.049230222686, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [607.1330658225955, 625.140431906129, 669.6986356139738, 710.6304721544793, 730.5689643110563, 11638.650840474778, 12528.561500347467, 12538.81191782124, 12581.93709031456, 12583.811242831353, 11985.700357491067, 12220.144589878711, 12232.571859984902, 12246.755064898696, 12247.387630618456, 582.0454454694304, 600.4625859855427, 728.6174758251933, 735.9852802943951, 746.6640011994624, 748.554610007045, 753.2655660730771, 755.8866170074477, 755.9319661230488, 756.6103456719794, 789.0964845252183, 792.0851416613821, 794.9046114466272, 795.4789612803623, 798.3333916179997, 607.8419610901176, 624.8312955502034, 625.8904691678938, 626.4925410417576, 787.7124849429974, 463.02764195190167, 559.3567397492916, 572.5734327925722, 575.9798407055774, 578.6528083150118, 12335.93832030843, 12341.259524428562, 12371.75256494874, 12381.257124572554, 12382.75234495305, 10805.783884322269, 11058.723531911686, 11232.943835280854, 11551.075913926865, 11716.648500544998, 9343.486108264044, 9786.363886347364, 10125.594976200942, 10155.847662285072, 10269.89730102697, 3940.428637847525, 3992.5208974922903, 3997.760134391917, 4002.8198731057173, 4039.3738970459626, 41020.0, 41126.58873411288, 41610.37584436236, 41933.58066419327, 42031.0, 9058.139476749699, 9260.645998701984, 9531.47576883278, 9534.28492863038, 9535.47554884474, 15827.0, 15930.442434514736, 15979.760303595456, 16056.91971540135, 16298.674026519404, 6281.120643109968, 6294.8426289342215, 6372.490200783926, 6403.455706265019, 6415.743370265231, 3582.4089025311055, 3630.854765809338, 3638.1268495560876, 3681.4293784463453, 3716.662001679393, 2538.2892790018823, 2598.740125987424, 2618.3061488705507, 2619.227327938225, 2619.895204191849, 451.7267053432626, 456.40895040922084, 465.03041159182806, 470.81167532986393, 471.2248351461826, 490.1911845455028, 504.4325134223998, 506.2406390414378, 522.1228336394818, 539.6869815506997, 7171.39043181325, 7261.128664560287, 7376.262373762581, 7467.290607392289, 7469.103707555019, 428.42163079841964, 480.4570834956477, 494.16732805223313, 526.1607735661613, 552.1855263486406, 3470.201853573692, 3534.293141371736, 3546.202104526461, 3583.623719509466, 3688.63113688629, 52929.0, 66814.66592667006, 71316.0, 71617.64191179114, 72272.27727722656, 34227.31545369079, 41721.0, 45342.54657453449, 46785.0, 57107.42892571104, 33085.17287067795, 33158.3368332632, 33727.42315248503, 50183.0, 52380.21429678634, 7566.24337566239, 8016.1583033782945, 8045.87931181021, 8072.838543228985, 8299.0, 35525.28949421049, 37791.62208377881, 37919.81040094782, 38387.0, 38718.419223711106, 43215.78392108019, 49838.25242621291, 50151.24773128479, 50689.0, 51292.0, 10237.48812559384, 10274.486275686335, 10394.688159355232, 10403.791924161324, 10407.791844163226, 11331.980121789078, 11376.146788991024, 11772.764544709229, 12310.446029928853, 12341.197822141532, 10545.894541054491, 10803.135749139892, 10829.51267192994, 11068.5572577096, 11147.665570032912, 10521.368717876952, 10688.198385121303, 10911.018008379284, 11150.665480035612, 11360.318380897173, 10630.574777008833, 10788.0, 10828.620998265023, 10930.672079837617, 10987.0, 8849.91150088491, 8898.59956301955, 9221.492817894812, 9376.48429336393, 9524.904750952403, 8587.270082043096, 8691.304695624462, 9019.594118264562, 9214.861777073214, 9463.337566370288], "value": 5751.548516096606, "unit": "score"}], "name": "dromaeo_css", "value": 6045.923911258296, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 114.0, 115.0, 114.0, 114.0, 114.0, 116.0, 115.0, 115.0, 113.0], "value": 113.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 134.0, 136.0, 168.0, 132.0, 128.0, 126.0, 137.0, 162.0, 134.0], "value": 140.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 161.0, 162.0, 162.0, 162.0, 160.0, 162.0, 160.0, 160.0, 160.0], "value": 161.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 78.0, 111.0, 79.0, 76.0, 77.0, 76.0, 103.0, 76.0], "value": 82.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 114.0, 85.0, 85.0, 91.0, 111.0, 83.0, 82.0, 116.0], "value": 93.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 147.0, 147.0, 147.0, 146.0, 147.0, 148.0, 148.0, 148.0, 146.0], "value": 147.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 85.0, 84.0, 84.0, 85.0, 86.0, 85.0, 85.0, 85.0], "value": 84.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 63.0, 63.0, 63.0, 63.0, 65.0, 64.0, 65.0, 66.0, 65.0], "value": 64.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 66.0, 66.0, 68.0, 66.0, 67.0, 65.0, 68.0, 66.0], "value": 66.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 90.0, 84.0, 83.0, 84.0, 92.0, 84.0, 86.0, 83.0, 83.0], "value": 85.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 151.0, 139.0, 144.0, 141.0, 151.0, 144.0, 153.0, 185.0, 145.0], "value": 149.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 180.0, 177.0, 176.0, 176.0, 175.0, 176.0, 174.0, 174.0, 176.0], "value": 176.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 73.0, 73.0, 73.0, 69.0, 68.0, 68.0, 69.0, 70.0, 67.0], "value": 69.9, "unit": "score"}], "name": "kraken", "value": 1552.9, "alertThreshold": 2.0}]} 02:52:42 INFO - Return code: 0 02:52:42 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:52:42 INFO - # TBPL SUCCESS # 02:52:42 INFO - Running post-action listener: _resource_record_post_action 02:52:42 INFO - [mozharness: 2016-11-08 10:52:42.948877Z] Finished run-tests step (success) 02:52:42 INFO - Running post-run listener: _resource_record_post_run 02:52:43 INFO - Total resource usage - Wall time: 1206s; CPU: 13.0%; Read bytes: 4096; Write bytes: 392777728; Read time: 12; Write time: 276124 02:52:43 INFO - TinderboxPrint: CPU usage
13.0% 02:52:43 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 02:52:43 INFO - TinderboxPrint: I/O write bytes / time
392,777,728 / 276,124 02:52:43 INFO - TinderboxPrint: CPU idle
8,365.8 (86.9%) 02:52:43 INFO - TinderboxPrint: CPU user
1,208.1 (12.6%) 02:52:43 INFO - TinderboxPrint: Swap in / out
0 / 0 02:52:43 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 99893248; Read time: 0; Write time: 89992 02:52:43 INFO - run-tests - Wall time: 1190s; CPU: 13.0%; Read bytes: 0; Write bytes: 292884480; Read time: 0; Write time: 186132 02:52:43 INFO - Running post-run listener: _upload_blobber_files 02:52:43 INFO - Blob upload gear active. 02:52:43 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:52:43 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 02:52:43 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', 'Cedar', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 02:52:43 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 Cedar -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 02:52:44 INFO - (blobuploader) - INFO - Open directory for files ... 02:52:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:52:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:52:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:52:47 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:52:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:52:47 INFO - (blobuploader) - INFO - Done attempting. 02:52:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:52:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:52:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:52:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:52:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:52:48 INFO - (blobuploader) - INFO - Done attempting. 02:52:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:52:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:52:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:52:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:52:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:52:49 INFO - (blobuploader) - INFO - Done attempting. 02:52:49 INFO - (blobuploader) - INFO - Iteration through files over. 02:52:49 INFO - Return code: 0 02:52:49 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:52:49 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:52:49 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/b64ced9964ada58fd2ff30faf78c287880c1e047a4a04c10787aaac72f8d4dba7c1830e4900739aaf899845d2ca8b4603cd4d6aaf4a43a03c3cefcabf81fea7b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/8bef75a9f2b76a42f191794a6c9e7344b39ac298ebcc6f6eacc4430fdff805cca44628cd9ace8435c11c730998095e60513609ca1fb1e91bc4713a1227824242", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/e3ab3017972114b8a55d7fed9e7e240f86486660730b97611d7fba4e96d19d535c704078cdbfd90bc1d1748a7ba83312a5f9e7262b3c5defa905a77c80b66055"} 02:52:49 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:52:49 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:52:49 INFO - Contents: 02:52:49 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/b64ced9964ada58fd2ff30faf78c287880c1e047a4a04c10787aaac72f8d4dba7c1830e4900739aaf899845d2ca8b4603cd4d6aaf4a43a03c3cefcabf81fea7b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/8bef75a9f2b76a42f191794a6c9e7344b39ac298ebcc6f6eacc4430fdff805cca44628cd9ace8435c11c730998095e60513609ca1fb1e91bc4713a1227824242", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/e3ab3017972114b8a55d7fed9e7e240f86486660730b97611d7fba4e96d19d535c704078cdbfd90bc1d1748a7ba83312a5f9e7262b3c5defa905a77c80b66055"} 02:52:49 INFO - Running post-run listener: copy_logs_to_upload_dir 02:52:49 INFO - Copying logs to upload dir... 02:52:49 INFO - mkdir: /builds/slave/test/build/upload/logs 02:52:49 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1252.414768 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2016-11-08 02:52:48.651939) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-08 02:52:48.655759) ========= 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=32c5991c409366f7fec8a718000001d2-1478600775.545392-238932751 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/b64ced9964ada58fd2ff30faf78c287880c1e047a4a04c10787aaac72f8d4dba7c1830e4900739aaf899845d2ca8b4603cd4d6aaf4a43a03c3cefcabf81fea7b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/8bef75a9f2b76a42f191794a6c9e7344b39ac298ebcc6f6eacc4430fdff805cca44628cd9ace8435c11c730998095e60513609ca1fb1e91bc4713a1227824242", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/e3ab3017972114b8a55d7fed9e7e240f86486660730b97611d7fba4e96d19d535c704078cdbfd90bc1d1748a7ba83312a5f9e7262b3c5defa905a77c80b66055"} build_url:https://queue.taskcluster.net/v1/task/AztzlPNQQUS07QDvRrf_Hw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011422 build_url: 'https://queue.taskcluster.net/v1/task/AztzlPNQQUS07QDvRrf_Hw/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/Cedar/sha512/b64ced9964ada58fd2ff30faf78c287880c1e047a4a04c10787aaac72f8d4dba7c1830e4900739aaf899845d2ca8b4603cd4d6aaf4a43a03c3cefcabf81fea7b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/8bef75a9f2b76a42f191794a6c9e7344b39ac298ebcc6f6eacc4430fdff805cca44628cd9ace8435c11c730998095e60513609ca1fb1e91bc4713a1227824242", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/e3ab3017972114b8a55d7fed9e7e240f86486660730b97611d7fba4e96d19d535c704078cdbfd90bc1d1748a7ba83312a5f9e7262b3c5defa905a77c80b66055"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-08 02:52:48.680984) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-08 02:52:48.681322) ========= 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=32c5991c409366f7fec8a718000001d2-1478600775.545392-238932751 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004445 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-08 02:52:48.766163) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-08 02:52:48.766484) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-08 02:52:48.766779) ========= ========= Total master_lag: 0.46 =========