builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-001 starttime: 1476963072.84 results: success (0) buildid: 20161020013001 builduid: 518ccc134d8c4bf8a0403db74b54e5a9 revision: 99a239e1866a57f987b08dad796528e4ea30e622 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-20 04:31:12.838831) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-20 04:31:12.839332) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-20 04:31:12.839629) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-20 04:31:12.851209) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 04:31:12.851473) ========= 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=8887e36bb8e381bfd44124ac000001a8-1476963072.416654-1117165592 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-20 04:31:13-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 223M=0s 2016-10-20 04:31:13 (223 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.148704 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 04:31:13.011656) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 04:31:13.011967) ========= 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=8887e36bb8e381bfd44124ac000001a8-1476963072.416654-1117165592 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017044 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 04:31:13.061355) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-20 04:31:13.064726) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 99a239e1866a57f987b08dad796528e4ea30e622 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 99a239e1866a57f987b08dad796528e4ea30e622 --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=8887e36bb8e381bfd44124ac000001a8-1476963072.416654-1117165592 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-20 04:31:13,626 truncating revision to first 12 chars 2016-10-20 04:31:13,626 Setting DEBUG logging. 2016-10-20 04:31:13,626 attempt 1/10 2016-10-20 04:31:13,626 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/99a239e1866a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-20 04:31:14,678 unpacking tar archive at: mozilla-central-99a239e1866a/testing/mozharness/ program finished with exit code 0 elapsedTime=1.370833 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-20 04:31:14.448990) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-20 04:31:14.449304) ========= script_repo_revision: 99a239e1866a57f987b08dad796528e4ea30e622 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-20 04:31:14.449700) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-20 04:31:14.449962) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-20 04:31:14.458914) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-10-20 04:31:14.459199) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=8887e36bb8e381bfd44124ac000001a8-1476963072.416654-1117165592 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:31:15 INFO - MultiFileLogger online at 20161020 04:31:15 in /builds/slave/test 04:31:15 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 04:31:15 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:31:15 INFO - {'append_to_log': False, 04:31:15 INFO - 'base_work_dir': '/builds/slave/test', 04:31:15 INFO - 'blob_upload_branch': 'Firefox', 04:31:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:31:15 INFO - 'branch': 'Firefox', 04:31:15 INFO - 'buildbot_json_path': 'buildprops.json', 04:31:15 INFO - 'config_files': ('talos/linux_config.py',), 04:31:15 INFO - 'default_actions': ('clobber', 04:31:15 INFO - 'read-buildbot-config', 04:31:15 INFO - 'download-and-extract', 04:31:15 INFO - 'populate-webroot', 04:31:15 INFO - 'create-virtualenv', 04:31:15 INFO - 'install', 04:31:15 INFO - 'run-tests'), 04:31:15 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:31:15 INFO - 'download_minidump_stackwalk': True, 04:31:15 INFO - 'download_symbols': 'ondemand', 04:31:15 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:31:15 INFO - 'tooltool.py': '/tools/tooltool.py', 04:31:15 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:31:15 INFO - '/tools/misc-python/virtualenv.py')}, 04:31:15 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:31:15 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:31:15 INFO - 'installer_path': 'installer.exe', 04:31:15 INFO - 'log_level': 'info', 04:31:15 INFO - 'log_name': 'talos', 04:31:15 INFO - 'log_to_console': True, 04:31:15 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:31:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:31:15 INFO - 'opt_config_files': (), 04:31:15 INFO - 'pip_index': False, 04:31:15 INFO - 'sps_profile': False, 04:31:15 INFO - 'sps_profile_interval': 0, 04:31:15 INFO - 'suite': 'dromaeojs', 04:31:15 INFO - 'system_bits': '32', 04:31:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:31:15 INFO - 'title': 'talos-linux64-ix-001', 04:31:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:31:15 INFO - 'use_talos_json': True, 04:31:15 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:31:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:31:15 INFO - 'work_dir': 'build'} 04:31:15 INFO - [mozharness: 2016-10-20 11:31:15.120191Z] Running clobber step. 04:31:15 INFO - Running pre-action listener: _resource_record_pre_action 04:31:15 INFO - Running main action method: clobber 04:31:15 INFO - rmtree: /builds/slave/test/build 04:31:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:31:15 INFO - Running post-action listener: _resource_record_post_action 04:31:15 INFO - [mozharness: 2016-10-20 11:31:15.584280Z] Finished clobber step (success) 04:31:15 INFO - [mozharness: 2016-10-20 11:31:15.584381Z] Running read-buildbot-config step. 04:31:15 INFO - Running pre-action listener: _resource_record_pre_action 04:31:15 INFO - Running main action method: read_buildbot_config 04:31:15 INFO - Using buildbot properties: 04:31:15 INFO - { 04:31:15 INFO - "project": "", 04:31:15 INFO - "product": "firefox", 04:31:15 INFO - "script_repo_revision": "production", 04:31:15 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 04:31:15 INFO - "repository": "", 04:31:15 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 04:31:15 INFO - "buildid": "20161020013001", 04:31:15 INFO - "pgo_build": "True", 04:31:15 INFO - "basedir": "/builds/slave/test", 04:31:15 INFO - "buildnumber": 17, 04:31:15 INFO - "slavename": "talos-linux64-ix-001", 04:31:15 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 04:31:15 INFO - "platform": "ubuntu64_hw", 04:31:15 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 04:31:15 INFO - "branch": "mozilla-central", 04:31:15 INFO - "repo_path": "mozilla-central", 04:31:15 INFO - "revision": "99a239e1866a57f987b08dad796528e4ea30e622", 04:31:15 INFO - "stage_platform": "linux64-pgo", 04:31:15 INFO - "builduid": "518ccc134d8c4bf8a0403db74b54e5a9", 04:31:15 INFO - "slavebuilddir": "test" 04:31:15 INFO - } 04:31:15 INFO - Found installer url https://queue.taskcluster.net/v1/task/Y9xWYVFLRECkYT6pd8IXnw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 04:31:15 INFO - Running post-action listener: _resource_record_post_action 04:31:15 INFO - [mozharness: 2016-10-20 11:31:15.587123Z] Finished read-buildbot-config step (success) 04:31:15 INFO - [mozharness: 2016-10-20 11:31:15.587210Z] Running download-and-extract step. 04:31:15 INFO - Running pre-action listener: _resource_record_pre_action 04:31:15 INFO - Running main action method: download_and_extract 04:31:15 INFO - mkdir: /builds/slave/test/build/tests 04:31:15 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')]} 04:31:15 INFO - trying https://queue.taskcluster.net/v1/task/Y9xWYVFLRECkYT6pd8IXnw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 04:31:15 INFO - Downloading https://queue.taskcluster.net/v1/task/Y9xWYVFLRECkYT6pd8IXnw/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 04:31:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Y9xWYVFLRECkYT6pd8IXnw/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 04:31:16 INFO - Downloaded 1361 bytes. 04:31:16 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 04:31:16 INFO - Using the following test package requirements: 04:31:16 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 04:31:16 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:31:16 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:31:16 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:31:16 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:31:16 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:31:16 INFO - u'jsshell-linux-x86_64.zip'], 04:31:16 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:31:16 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:31:16 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 04:31:16 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:31:16 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:31:16 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:31:16 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:31:16 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:31:16 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:31:16 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:31:16 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:31:16 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:31:16 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Y9xWYVFLRECkYT6pd8IXnw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 04:31:16 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Y9xWYVFLRECkYT6pd8IXnw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:31:16 INFO - Fetch https://queue.taskcluster.net/v1/task/Y9xWYVFLRECkYT6pd8IXnw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 04:31:16 INFO - Http code: 200 04:31:16 INFO - via: 1.1 81871f1c889cc44b6c25e3ef722a3801.cloudfront.net (CloudFront) 04:31:16 INFO - x-amz-cf-id: wslLzIGGfufiRnFH1jNTezaYKzQCE_G273RXFAGGPZpjB4tPG4-bhQ== 04:31:16 INFO - x-amz-version-id: B2CeE1uqeDR1T8a9nE2cEqvCK0ELFK1I 04:31:17 INFO - Expected file size: 22115902 04:31:17 INFO - Obtained file size: 22115902 04:31:21 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 04:31:21 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Y9xWYVFLRECkYT6pd8IXnw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 04:31:21 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Y9xWYVFLRECkYT6pd8IXnw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:31:21 INFO - Fetch https://queue.taskcluster.net/v1/task/Y9xWYVFLRECkYT6pd8IXnw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 04:31:21 INFO - Http code: 200 04:31:21 INFO - via: 1.1 0ffb9964022445351e635c66ad0176ff.cloudfront.net (CloudFront) 04:31:21 INFO - x-amz-cf-id: 6xdOtaOMkMhX1zSqzRYmuSKu5pOPJNfqUB6fsbpnNyVet37ekW6k2Q== 04:31:21 INFO - x-amz-version-id: B2CeE1uqeDR1T8a9nE2cEqvCK0ELFK1I 04:31:21 INFO - Expected file size: 22115902 04:31:21 INFO - Obtained file size: 22115902 04:31:26 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Y9xWYVFLRECkYT6pd8IXnw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 04:31:26 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Y9xWYVFLRECkYT6pd8IXnw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 04:31:26 INFO - Fetch https://queue.taskcluster.net/v1/task/Y9xWYVFLRECkYT6pd8IXnw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 04:31:26 INFO - Http code: 200 04:31:26 INFO - via: 1.1 2a47832c458ab2a6b20c8363f5aa35ea.cloudfront.net (CloudFront) 04:31:26 INFO - x-amz-cf-id: cW9zWAd23fVey24457UUM9JADcvi2dD4XQ8_dZdhxokvwtxFZahffw== 04:31:26 INFO - x-amz-version-id: solsKqfPxkyXXmnKbWc.5mb8v9LlIy_s 04:31:27 INFO - Expected file size: 14409028 04:31:27 INFO - Obtained file size: 14409028 04:31:27 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')]} 04:31:27 INFO - trying https://queue.taskcluster.net/v1/task/Y9xWYVFLRECkYT6pd8IXnw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 04:31:27 INFO - Downloading https://queue.taskcluster.net/v1/task/Y9xWYVFLRECkYT6pd8IXnw/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 04:31:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Y9xWYVFLRECkYT6pd8IXnw/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 04:31:28 INFO - Downloaded 59478914 bytes. 04:31:28 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Y9xWYVFLRECkYT6pd8IXnw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 04:31:28 INFO - mkdir: /builds/slave/test/properties 04:31:28 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:31:28 INFO - Writing to file /builds/slave/test/properties/build_url 04:31:28 INFO - Contents: 04:31:28 INFO - build_url:https://queue.taskcluster.net/v1/task/Y9xWYVFLRECkYT6pd8IXnw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 04:31:29 INFO - Running post-action listener: _resource_record_post_action 04:31:29 INFO - Running post-action listener: set_extra_try_arguments 04:31:29 INFO - [mozharness: 2016-10-20 11:31:29.334265Z] Finished download-and-extract step (success) 04:31:29 INFO - [mozharness: 2016-10-20 11:31:29.334493Z] Running populate-webroot step. 04:31:29 INFO - Running pre-action listener: _resource_record_pre_action 04:31:29 INFO - Running main action method: populate_webroot 04:31:29 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:31:29 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:31:29 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:31:29 INFO - '--tppagecycles', 04:31:29 INFO - '7'], 04:31:29 INFO - 'tests': ['tsvgm']}}, 04:31:29 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:31:29 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:31:29 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:31:29 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:31:29 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:31:29 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:31:29 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:31:29 INFO - 'talos_options': ['--disable-e10s'], 04:31:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:31:29 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:31:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:31:29 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:31:29 INFO - 'talos_options': ['--disable-e10s'], 04:31:29 INFO - 'tests': ['damp', 'tps']}, 04:31:29 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:31:29 INFO - 'tests': ['damp', 'tps']}, 04:31:29 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:31:29 INFO - 'tests': ['dromaeo_dom']}, 04:31:29 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:31:29 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:31:29 INFO - 'tests': ['basic_compositor_video']}, 04:31:29 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:31:29 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:31:29 INFO - 'tests': ['a11yr', 04:31:29 INFO - 'ts_paint', 04:31:29 INFO - 'tpaint', 04:31:29 INFO - 'sessionrestore', 04:31:29 INFO - 'sessionrestore_no_auto_restore', 04:31:29 INFO - 'tabpaint']}, 04:31:29 INFO - 'other-e10s': {'tests': ['a11yr', 04:31:29 INFO - 'ts_paint', 04:31:29 INFO - 'tpaint', 04:31:29 INFO - 'sessionrestore', 04:31:29 INFO - 'sessionrestore_no_auto_restore', 04:31:29 INFO - 'tabpaint']}, 04:31:29 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:31:29 INFO - 'ts_paint', 04:31:29 INFO - 'tpaint', 04:31:29 INFO - 'sessionrestore', 04:31:29 INFO - 'sessionrestore_no_auto_restore', 04:31:29 INFO - 'tabpaint']}, 04:31:29 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:31:29 INFO - 'ts_paint', 04:31:29 INFO - 'tpaint', 04:31:29 INFO - 'sessionrestore', 04:31:29 INFO - 'sessionrestore_no_auto_restore', 04:31:29 INFO - 'tabpaint']}, 04:31:29 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:31:29 INFO - 'tests': ['a11yr', 04:31:29 INFO - 'ts_paint', 04:31:29 INFO - 'tpaint', 04:31:29 INFO - 'sessionrestore', 04:31:29 INFO - 'sessionrestore_no_auto_restore', 04:31:29 INFO - 'tabpaint']}, 04:31:29 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:31:29 INFO - 'tests': ['a11yr', 04:31:29 INFO - 'ts_paint', 04:31:29 INFO - 'tpaint', 04:31:29 INFO - 'sessionrestore', 04:31:29 INFO - 'sessionrestore_no_auto_restore', 04:31:29 INFO - 'tabpaint']}, 04:31:29 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:31:29 INFO - 'tests': ['tsvgx', 04:31:29 INFO - 'tsvgr_opacity', 04:31:29 INFO - 'tart', 04:31:29 INFO - 'tscrollx', 04:31:29 INFO - 'cart']}, 04:31:29 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:31:29 INFO - 'tsvgr_opacity', 04:31:29 INFO - 'tart', 04:31:29 INFO - 'tscrollx', 04:31:29 INFO - 'cart']}, 04:31:29 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:31:29 INFO - 'talos_options': ['--disable-e10s'], 04:31:29 INFO - 'tests': ['tp5o']}, 04:31:29 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:31:29 INFO - 'tests': ['tp5o']}, 04:31:29 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:31:29 INFO - 'talos_options': ['--disable-e10s', 04:31:29 INFO - '--xperf_path', 04:31:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:31:29 INFO - 'tests': ['tp5n']}, 04:31:29 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:31:29 INFO - 'talos_options': ['--xperf_path', 04:31:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:31:29 INFO - 'tests': ['tp5n']}}, 04:31:29 INFO - 'talos.zip': {'path': '', 04:31:29 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:31:29 INFO - Running post-action listener: _resource_record_post_action 04:31:29 INFO - [mozharness: 2016-10-20 11:31:29.356962Z] Finished populate-webroot step (success) 04:31:29 INFO - [mozharness: 2016-10-20 11:31:29.357059Z] Running create-virtualenv step. 04:31:29 INFO - Running pre-action listener: _resource_record_pre_action 04:31:29 INFO - Running main action method: create_virtualenv 04:31:29 INFO - Creating virtualenv /builds/slave/test/build/venv 04:31:29 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 04:31:29 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:31:29 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:31:29 INFO - Using real prefix '/usr' 04:31:29 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:31:29 INFO - Installing distribute.............................................................................................................................................................................................done. 04:31:31 INFO - Installing pip.................done. 04:31:31 INFO - Return code: 0 04:31:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:31:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:31:32 INFO - Reading from file tmpfile_stdout 04:31:32 INFO - Output received: 04:31:32 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) 04:31:32 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:31: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')]} 04:31:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:31:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31: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')]} 04:31:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:31:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:32 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 0x7f042a5a2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x137a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1447790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1444930>, '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 0x1445830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1445cc0>, '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': '8887e36bb8e381bfd44124ac000001a8-1476963072.416654-1117165592', '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 04:31:32 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 04:31:32 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 04:31:32 INFO - Using env: {'DISPLAY': ':0', 04:31:32 INFO - 'HOME': '/home/cltbld', 04:31:32 INFO - 'LANG': 'en_US.UTF-8', 04:31:32 INFO - 'LANGUAGE': 'en_US:en', 04:31:32 INFO - 'LOGNAME': 'cltbld', 04:31:32 INFO - 'MAIL': '/var/mail/cltbld', 04:31:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:31:32 INFO - 'MOZ_NO_REMOTE': '1', 04:31:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:31:32 INFO - 'NO_EM_RESTART': '1', 04:31:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:31:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:31:32 INFO - 'PWD': '/builds/slave/test', 04:31:32 INFO - 'SHELL': '/bin/bash', 04:31:32 INFO - 'SHLVL': '1', 04:31:32 INFO - 'TERM': 'linux', 04:31:32 INFO - 'TMOUT': '86400', 04:31:32 INFO - 'USER': 'cltbld', 04:31:32 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1476963072.416654-1117165592', 04:31:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:31:32 INFO - '_': '/tools/buildbot/bin/python'} 04:31:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:31:32 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 04:31:32 INFO - Cleaning up... 04:31:32 INFO - Return code: 0 04:31:32 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:31: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')]} 04:31:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:31:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31: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')]} 04:31:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:31:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:32 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 0x7f042a5a2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x137a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1447790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1444930>, '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 0x1445830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1445cc0>, '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': '8887e36bb8e381bfd44124ac000001a8-1476963072.416654-1117165592', '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 04:31:32 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 04:31:32 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 04:31:32 INFO - Using env: {'DISPLAY': ':0', 04:31:32 INFO - 'HOME': '/home/cltbld', 04:31:32 INFO - 'LANG': 'en_US.UTF-8', 04:31:32 INFO - 'LANGUAGE': 'en_US:en', 04:31:32 INFO - 'LOGNAME': 'cltbld', 04:31:32 INFO - 'MAIL': '/var/mail/cltbld', 04:31:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:31:32 INFO - 'MOZ_NO_REMOTE': '1', 04:31:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:31:32 INFO - 'NO_EM_RESTART': '1', 04:31:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:31:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:31:32 INFO - 'PWD': '/builds/slave/test', 04:31:32 INFO - 'SHELL': '/bin/bash', 04:31:32 INFO - 'SHLVL': '1', 04:31:32 INFO - 'TERM': 'linux', 04:31:32 INFO - 'TMOUT': '86400', 04:31:32 INFO - 'USER': 'cltbld', 04:31:32 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1476963072.416654-1117165592', 04:31:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:31:32 INFO - '_': '/tools/buildbot/bin/python'} 04:31:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:31:32 INFO - Downloading/unpacking psutil>=3.1.1 04:31:32 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 04:31:32 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 04:31:32 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 04:31:32 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 04:31:32 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 04:31:32 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 04:31:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:31:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:31:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:31:34 INFO - Installing collected packages: psutil 04:31:34 INFO - Running setup.py install for psutil 04:31:34 INFO - building 'psutil._psutil_linux' extension 04:31:34 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 04:31:34 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 04:31:34 INFO - building 'psutil._psutil_posix' extension 04:31:34 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 04:31:35 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 04:31:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:31:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:31:35 INFO - Successfully installed psutil 04:31:35 INFO - Cleaning up... 04:31:35 INFO - Return code: 0 04:31:35 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:31:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:31:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:31:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:31:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:31:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f042a5a2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x137a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1447790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1444930>, '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 0x1445830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1445cc0>, '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': '8887e36bb8e381bfd44124ac000001a8-1476963072.416654-1117165592', '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 04:31:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:31:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 04:31:35 INFO - Using env: {'DISPLAY': ':0', 04:31:35 INFO - 'HOME': '/home/cltbld', 04:31:35 INFO - 'LANG': 'en_US.UTF-8', 04:31:35 INFO - 'LANGUAGE': 'en_US:en', 04:31:35 INFO - 'LOGNAME': 'cltbld', 04:31:35 INFO - 'MAIL': '/var/mail/cltbld', 04:31:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:31:35 INFO - 'MOZ_NO_REMOTE': '1', 04:31:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:31:35 INFO - 'NO_EM_RESTART': '1', 04:31:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:31:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:31:35 INFO - 'PWD': '/builds/slave/test', 04:31:35 INFO - 'SHELL': '/bin/bash', 04:31:35 INFO - 'SHLVL': '1', 04:31:35 INFO - 'TERM': 'linux', 04:31:35 INFO - 'TMOUT': '86400', 04:31:35 INFO - 'USER': 'cltbld', 04:31:35 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1476963072.416654-1117165592', 04:31:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:31:35 INFO - '_': '/tools/buildbot/bin/python'} 04:31:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:31:35 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:31:35 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 04:31:35 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 04:31:35 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 04:31:35 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 04:31:35 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 04:31:35 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 04:31:37 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:31:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:31:37 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:31:37 INFO - Installing collected packages: mozsystemmonitor 04:31:37 INFO - Running setup.py install for mozsystemmonitor 04:31:37 INFO - Successfully installed mozsystemmonitor 04:31:37 INFO - Cleaning up... 04:31:37 INFO - Return code: 0 04:31:37 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:31:37 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')]} 04:31:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:31:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:37 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')]} 04:31:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:31:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:37 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 0x7f042a5a2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x137a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1447790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1444930>, '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 0x1445830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1445cc0>, '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': '8887e36bb8e381bfd44124ac000001a8-1476963072.416654-1117165592', '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 04:31:37 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 04:31:37 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 04:31:37 INFO - Using env: {'DISPLAY': ':0', 04:31:37 INFO - 'HOME': '/home/cltbld', 04:31:37 INFO - 'LANG': 'en_US.UTF-8', 04:31:37 INFO - 'LANGUAGE': 'en_US:en', 04:31:37 INFO - 'LOGNAME': 'cltbld', 04:31:37 INFO - 'MAIL': '/var/mail/cltbld', 04:31:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:31:37 INFO - 'MOZ_NO_REMOTE': '1', 04:31:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:31:37 INFO - 'NO_EM_RESTART': '1', 04:31:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:31:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:31:37 INFO - 'PWD': '/builds/slave/test', 04:31:37 INFO - 'SHELL': '/bin/bash', 04:31:37 INFO - 'SHLVL': '1', 04:31:37 INFO - 'TERM': 'linux', 04:31:37 INFO - 'TMOUT': '86400', 04:31:37 INFO - 'USER': 'cltbld', 04:31:37 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1476963072.416654-1117165592', 04:31:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:31:37 INFO - '_': '/tools/buildbot/bin/python'} 04:31:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:31:37 INFO - Downloading/unpacking jsonschema==2.5.1 04:31:37 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 04:31:37 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 04:31:37 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 04:31:37 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 04:31:37 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 04:31:37 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 04:31:39 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:31:39 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:31:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:39 INFO - Downloading functools32-3.2.3-2.tar.gz 04:31:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:31:39 INFO - warning: no files found matching '*.txt' 04:31:39 INFO - no previously-included directories found matching 'build' 04:31:39 INFO - no previously-included directories found matching 'dist' 04:31:39 INFO - no previously-included directories found matching '.git*' 04:31:39 INFO - Installing collected packages: jsonschema, functools32 04:31:40 INFO - Running setup.py install for functools32 04:31:40 INFO - warning: no files found matching '*.txt' 04:31:40 INFO - no previously-included directories found matching 'build' 04:31:40 INFO - no previously-included directories found matching 'dist' 04:31:40 INFO - no previously-included directories found matching '.git*' 04:31:40 INFO - Successfully installed jsonschema functools32 04:31:40 INFO - Cleaning up... 04:31:40 INFO - Return code: 0 04:31:40 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:31:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:31:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:31:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:31:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:31:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f042a5a2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x137a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1447790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1444930>, '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 0x1445830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1445cc0>, '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': '8887e36bb8e381bfd44124ac000001a8-1476963072.416654-1117165592', '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 04:31:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 04:31:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 04:31:40 INFO - Using env: {'DISPLAY': ':0', 04:31:40 INFO - 'HOME': '/home/cltbld', 04:31:40 INFO - 'LANG': 'en_US.UTF-8', 04:31:40 INFO - 'LANGUAGE': 'en_US:en', 04:31:40 INFO - 'LOGNAME': 'cltbld', 04:31:40 INFO - 'MAIL': '/var/mail/cltbld', 04:31:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:31:40 INFO - 'MOZ_NO_REMOTE': '1', 04:31:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:31:40 INFO - 'NO_EM_RESTART': '1', 04:31:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:31:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:31:40 INFO - 'PWD': '/builds/slave/test', 04:31:40 INFO - 'SHELL': '/bin/bash', 04:31:40 INFO - 'SHLVL': '1', 04:31:40 INFO - 'TERM': 'linux', 04:31:40 INFO - 'TMOUT': '86400', 04:31:40 INFO - 'USER': 'cltbld', 04:31:40 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1476963072.416654-1117165592', 04:31:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:31:40 INFO - '_': '/tools/buildbot/bin/python'} 04:31:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:31:40 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:31:40 INFO - Cleaning up... 04:31:40 INFO - Return code: 0 04:31:40 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:31:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:31:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:31:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:31:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:31:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f042a5a2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x137a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1447790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1444930>, '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 0x1445830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1445cc0>, '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': '8887e36bb8e381bfd44124ac000001a8-1476963072.416654-1117165592', '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 04:31:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:31:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:31:40 INFO - Using env: {'DISPLAY': ':0', 04:31:40 INFO - 'HOME': '/home/cltbld', 04:31:40 INFO - 'LANG': 'en_US.UTF-8', 04:31:40 INFO - 'LANGUAGE': 'en_US:en', 04:31:40 INFO - 'LOGNAME': 'cltbld', 04:31:40 INFO - 'MAIL': '/var/mail/cltbld', 04:31:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:31:40 INFO - 'MOZ_NO_REMOTE': '1', 04:31:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:31:40 INFO - 'NO_EM_RESTART': '1', 04:31:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:31:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:31:40 INFO - 'PWD': '/builds/slave/test', 04:31:40 INFO - 'SHELL': '/bin/bash', 04:31:40 INFO - 'SHLVL': '1', 04:31:40 INFO - 'TERM': 'linux', 04:31:40 INFO - 'TMOUT': '86400', 04:31:40 INFO - 'USER': 'cltbld', 04:31:40 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1476963072.416654-1117165592', 04:31:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:31:40 INFO - '_': '/tools/buildbot/bin/python'} 04:31:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:31:40 INFO - Downloading/unpacking blobuploader==1.2.4 04:31:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:42 INFO - Downloading blobuploader-1.2.4.tar.gz 04:31:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:31:42 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:31:42 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 04:31:42 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 04:31:42 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 04:31:42 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 04:31:42 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 04:31:42 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 04:31:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:31:43 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:31:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:43 INFO - Downloading docopt-0.6.1.tar.gz 04:31:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:31:43 INFO - Installing collected packages: blobuploader, requests, docopt 04:31:43 INFO - Running setup.py install for blobuploader 04:31:43 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:31:43 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:31:43 INFO - Running setup.py install for requests 04:31:43 INFO - Running setup.py install for docopt 04:31:43 INFO - Successfully installed blobuploader requests docopt 04:31:43 INFO - Cleaning up... 04:31:43 INFO - Return code: 0 04:31:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:31:43 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')]} 04:31:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:31:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:43 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')]} 04:31:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:31:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:43 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 0x7f042a5a2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x137a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1447790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1444930>, '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 0x1445830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1445cc0>, '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': '8887e36bb8e381bfd44124ac000001a8-1476963072.416654-1117165592', '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 04:31:43 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 04:31:43 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 04:31:43 INFO - Using env: {'DISPLAY': ':0', 04:31:43 INFO - 'HOME': '/home/cltbld', 04:31:43 INFO - 'LANG': 'en_US.UTF-8', 04:31:43 INFO - 'LANGUAGE': 'en_US:en', 04:31:43 INFO - 'LOGNAME': 'cltbld', 04:31:43 INFO - 'MAIL': '/var/mail/cltbld', 04:31:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:31:43 INFO - 'MOZ_NO_REMOTE': '1', 04:31:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:31:43 INFO - 'NO_EM_RESTART': '1', 04:31:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:31:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:31:43 INFO - 'PWD': '/builds/slave/test', 04:31:43 INFO - 'SHELL': '/bin/bash', 04:31:43 INFO - 'SHLVL': '1', 04:31:43 INFO - 'TERM': 'linux', 04:31:43 INFO - 'TMOUT': '86400', 04:31:43 INFO - 'USER': 'cltbld', 04:31:43 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1476963072.416654-1117165592', 04:31:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:31:43 INFO - '_': '/tools/buildbot/bin/python'} 04:31:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:31:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:31:44 INFO - Running setup.py (path:/tmp/pip-auH8pk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:31:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:31:44 INFO - Running setup.py (path:/tmp/pip-ePS4PM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:31:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:31:44 INFO - Running setup.py (path:/tmp/pip-1FGVAo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:31:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:31:44 INFO - Running setup.py (path:/tmp/pip-zM8RF6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:31:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:31:44 INFO - Running setup.py (path:/tmp/pip-N4x8Dr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:31:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:31:44 INFO - Running setup.py (path:/tmp/pip-b_jc1B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:31:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:31:44 INFO - Running setup.py (path:/tmp/pip-nNYova-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:31:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:31:44 INFO - Running setup.py (path:/tmp/pip-p9UDR5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:31:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:31:44 INFO - Running setup.py (path:/tmp/pip-v4trAR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:31:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:31:44 INFO - Running setup.py (path:/tmp/pip-qOoiFx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:31:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:31:44 INFO - Running setup.py (path:/tmp/pip-YIxy6X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:31:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:31:44 INFO - Running setup.py (path:/tmp/pip-Fdpm60-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:31:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:31:44 INFO - Running setup.py (path:/tmp/pip-Nf2hGo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:31:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:31:45 INFO - Running setup.py (path:/tmp/pip-Jcaj6U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:31:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:31:45 INFO - Running setup.py (path:/tmp/pip-2DGnUU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:31:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:31:45 INFO - Running setup.py (path:/tmp/pip-Ihqe3u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:31:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:31:45 INFO - Running setup.py (path:/tmp/pip-RzKEXw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:31:45 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:31:45 INFO - Running setup.py install for manifestparser 04:31:45 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:31:45 INFO - Running setup.py install for mozcrash 04:31:45 INFO - Running setup.py install for mozdebug 04:31:45 INFO - Running setup.py install for mozdevice 04:31:45 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:31:45 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:31:45 INFO - Running setup.py install for mozfile 04:31:45 INFO - Running setup.py install for mozhttpd 04:31:45 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:31:45 INFO - Running setup.py install for mozinfo 04:31:46 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:31:46 INFO - Running setup.py install for mozInstall 04:31:46 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:31:46 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:31:46 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:31:46 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:31:46 INFO - Running setup.py install for mozleak 04:31:46 INFO - Running setup.py install for mozlog 04:31:46 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:31:46 INFO - Running setup.py install for moznetwork 04:31:46 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:31:46 INFO - Running setup.py install for mozprocess 04:31:46 INFO - Running setup.py install for mozprofile 04:31:46 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:31:46 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:31:46 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:31:46 INFO - Running setup.py install for mozrunner 04:31:46 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:31:46 INFO - Running setup.py install for mozscreenshot 04:31:46 INFO - Running setup.py install for moztest 04:31:47 INFO - Running setup.py install for mozversion 04:31:47 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:31:47 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:31:47 INFO - Cleaning up... 04:31:47 INFO - Return code: 0 04:31:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:31:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:31:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:31:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:31:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:31:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:47 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 0x7f042a5a2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x137a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1447790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1444930>, '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 0x1445830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1445cc0>, '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': '8887e36bb8e381bfd44124ac000001a8-1476963072.416654-1117165592', '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 04:31:47 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 04:31:47 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 04:31:47 INFO - Using env: {'DISPLAY': ':0', 04:31:47 INFO - 'HOME': '/home/cltbld', 04:31:47 INFO - 'LANG': 'en_US.UTF-8', 04:31:47 INFO - 'LANGUAGE': 'en_US:en', 04:31:47 INFO - 'LOGNAME': 'cltbld', 04:31:47 INFO - 'MAIL': '/var/mail/cltbld', 04:31:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:31:47 INFO - 'MOZ_NO_REMOTE': '1', 04:31:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:31:47 INFO - 'NO_EM_RESTART': '1', 04:31:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:31:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:31:47 INFO - 'PWD': '/builds/slave/test', 04:31:47 INFO - 'SHELL': '/bin/bash', 04:31:47 INFO - 'SHLVL': '1', 04:31:47 INFO - 'TERM': 'linux', 04:31:47 INFO - 'TMOUT': '86400', 04:31:47 INFO - 'USER': 'cltbld', 04:31:47 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1476963072.416654-1117165592', 04:31:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:31:47 INFO - '_': '/tools/buildbot/bin/python'} 04:31:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:31:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:31:47 INFO - Running setup.py (path:/tmp/pip-jAMl1n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:31:47 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)) 04:31:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:31:47 INFO - Running setup.py (path:/tmp/pip-NvgaCL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:31:47 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)) 04:31:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:31:47 INFO - Running setup.py (path:/tmp/pip-WxrGL0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:31:47 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)) 04:31:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:31:47 INFO - Running setup.py (path:/tmp/pip-XJhBc8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:31:47 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)) 04:31:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:31:47 INFO - Running setup.py (path:/tmp/pip-Qil6n2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:31:47 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)) 04:31:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:31:47 INFO - Running setup.py (path:/tmp/pip-kUthUm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:31:47 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)) 04:31:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:31:47 INFO - Running setup.py (path:/tmp/pip-VjMP0P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:31:47 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)) 04:31:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:31:47 INFO - Running setup.py (path:/tmp/pip-JlUM3y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:31:47 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)) 04:31:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:31:47 INFO - Running setup.py (path:/tmp/pip-ETyVLV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:31:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 04:31:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:31:48 INFO - Running setup.py (path:/tmp/pip-lC7cTQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:31:48 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)) 04:31:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:31:48 INFO - Running setup.py (path:/tmp/pip-pYxkfC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:31:48 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)) 04:31:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:31:48 INFO - Running setup.py (path:/tmp/pip-X4TstW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:31:48 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)) 04:31:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:31:48 INFO - Running setup.py (path:/tmp/pip-LLB5O8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:31:48 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)) 04:31:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:31:48 INFO - Running setup.py (path:/tmp/pip-vWYaHe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:31:48 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)) 04:31:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:31:48 INFO - Running setup.py (path:/tmp/pip-m3_scW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:31:48 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)) 04:31:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:31:48 INFO - Running setup.py (path:/tmp/pip-ZNPgcV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:31:48 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)) 04:31:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:31:48 INFO - Running setup.py (path:/tmp/pip-1Fu2Xp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:31:48 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)) 04:31:48 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)) 04:31:48 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)) 04:31:48 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)) 04:31:48 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)) 04:31:48 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)) 04:31:48 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:31:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:50 INFO - Downloading blessings-1.6.tar.gz 04:31:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:31:50 INFO - Installing collected packages: blessings 04:31:50 INFO - Running setup.py install for blessings 04:31:50 INFO - Successfully installed blessings 04:31:50 INFO - Cleaning up... 04:31:50 INFO - Return code: 0 04:31:50 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:31:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:31:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:31:51 INFO - Reading from file tmpfile_stdout 04:31:51 INFO - Current package versions: 04:31:51 INFO - argparse == 1.2.1 04:31:51 INFO - blessings == 1.6 04:31:51 INFO - blobuploader == 1.2.4 04:31:51 INFO - docopt == 0.6.1 04:31:51 INFO - functools32 == 3.2.3-2 04:31:51 INFO - jsonschema == 2.5.1 04:31:51 INFO - manifestparser == 1.1 04:31:51 INFO - mozInstall == 1.12 04:31:51 INFO - mozcrash == 0.17 04:31:51 INFO - mozdebug == 0.1 04:31:51 INFO - mozdevice == 0.48 04:31:51 INFO - mozfile == 1.2 04:31:51 INFO - mozhttpd == 0.7 04:31:51 INFO - mozinfo == 0.9 04:31:51 INFO - mozleak == 0.1 04:31:51 INFO - mozlog == 3.4 04:31:51 INFO - moznetwork == 0.27 04:31:51 INFO - mozprocess == 0.23 04:31:51 INFO - mozprofile == 0.28 04:31:51 INFO - mozrunner == 6.12 04:31:51 INFO - mozscreenshot == 0.1 04:31:51 INFO - mozsystemmonitor == 0.3 04:31:51 INFO - moztest == 0.7 04:31:51 INFO - mozversion == 1.4 04:31:51 INFO - psutil == 3.1.1 04:31:51 INFO - requests == 1.2.3 04:31:51 INFO - wsgiref == 0.1.2 04:31:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:31:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:31:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:31:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:31:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:31:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f042a5a2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x137a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1447790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1444930>, '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 0x1445830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1445cc0>, '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': '8887e36bb8e381bfd44124ac000001a8-1476963072.416654-1117165592', '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 04:31:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 04:31:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:31:51 INFO - Using env: {'DISPLAY': ':0', 04:31:51 INFO - 'HOME': '/home/cltbld', 04:31:51 INFO - 'LANG': 'en_US.UTF-8', 04:31:51 INFO - 'LANGUAGE': 'en_US:en', 04:31:51 INFO - 'LOGNAME': 'cltbld', 04:31:51 INFO - 'MAIL': '/var/mail/cltbld', 04:31:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:31:51 INFO - 'MOZ_NO_REMOTE': '1', 04:31:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:31:51 INFO - 'NO_EM_RESTART': '1', 04:31:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:31:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:31:51 INFO - 'PWD': '/builds/slave/test', 04:31:51 INFO - 'SHELL': '/bin/bash', 04:31:51 INFO - 'SHLVL': '1', 04:31:51 INFO - 'TERM': 'linux', 04:31:51 INFO - 'TMOUT': '86400', 04:31:51 INFO - 'USER': 'cltbld', 04:31:51 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1476963072.416654-1117165592', 04:31:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:31:51 INFO - '_': '/tools/buildbot/bin/python'} 04:31:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:31:51 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)) 04:31:51 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)) 04:31:51 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)) 04:31:51 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)) 04:31:51 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)) 04:31:51 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)) 04:31:51 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)) 04:31:51 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)) 04:31:51 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)) 04:31:51 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)) 04:31:51 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)) 04:31:51 INFO - Cleaning up... 04:31:51 INFO - Return code: 0 04:31:51 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:31:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:31:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:31:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:31:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:31:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:51 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 0x7f042a5a2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x137a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1447790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1444930>, '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 0x1445830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1445cc0>, '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': '8887e36bb8e381bfd44124ac000001a8-1476963072.416654-1117165592', '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 04:31:51 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 04:31:51 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 04:31:51 INFO - Using env: {'DISPLAY': ':0', 04:31:51 INFO - 'HOME': '/home/cltbld', 04:31:51 INFO - 'LANG': 'en_US.UTF-8', 04:31:51 INFO - 'LANGUAGE': 'en_US:en', 04:31:51 INFO - 'LOGNAME': 'cltbld', 04:31:51 INFO - 'MAIL': '/var/mail/cltbld', 04:31:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:31:51 INFO - 'MOZ_NO_REMOTE': '1', 04:31:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:31:51 INFO - 'NO_EM_RESTART': '1', 04:31:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:31:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:31:51 INFO - 'PWD': '/builds/slave/test', 04:31:51 INFO - 'SHELL': '/bin/bash', 04:31:51 INFO - 'SHLVL': '1', 04:31:51 INFO - 'TERM': 'linux', 04:31:51 INFO - 'TMOUT': '86400', 04:31:51 INFO - 'USER': 'cltbld', 04:31:51 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1476963072.416654-1117165592', 04:31:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:31:51 INFO - '_': '/tools/buildbot/bin/python'} 04:31:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:31:51 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:31:51 INFO - Cleaning up... 04:31:51 INFO - Return code: 0 04:31:51 INFO - Running post-action listener: _resource_record_post_action 04:31:51 INFO - Running post-action listener: _start_resource_monitoring 04:31:51 INFO - Starting resource monitoring. 04:31:51 INFO - [mozharness: 2016-10-20 11:31:51.518683Z] Finished create-virtualenv step (success) 04:31:51 INFO - [mozharness: 2016-10-20 11:31:51.519150Z] Running install step. 04:31:51 INFO - Running pre-action listener: _resource_record_pre_action 04:31:51 INFO - Running main action method: install 04:31:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:31:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:31:51 INFO - Reading from file tmpfile_stdout 04:31:51 INFO - Detecting whether we're running mozinstall >=1.0... 04:31:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:31:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:31:51 INFO - Reading from file tmpfile_stdout 04:31:51 INFO - Output received: 04:31:51 INFO - Usage: mozinstall [options] installer 04:31:51 INFO - Options: 04:31:51 INFO - -h, --help show this help message and exit 04:31:51 INFO - -d DEST, --destination=DEST 04:31:51 INFO - Directory to install application into. [default: 04:31:51 INFO - "/builds/slave/test"] 04:31:51 INFO - --app=APP Application being installed. [default: firefox] 04:31:51 INFO - mkdir: /builds/slave/test/build/application 04:31:51 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'] 04:31:51 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 04:32:08 INFO - Reading from file tmpfile_stdout 04:32:08 INFO - Output received: 04:32:08 INFO - /builds/slave/test/build/application/firefox/firefox 04:32:08 INFO - Running post-action listener: _resource_record_post_action 04:32:08 INFO - [mozharness: 2016-10-20 11:32:08.745788Z] Finished install step (success) 04:32:08 INFO - [mozharness: 2016-10-20 11:32:08.746033Z] Running run-tests step. 04:32:08 INFO - Running pre-action listener: _resource_record_pre_action 04:32:08 INFO - Running main action method: run_tests 04:32:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:32:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:32:08 INFO - Python 2.7.3 04:32:08 INFO - Return code: 0 04:32:08 INFO - grabbing minidump binary from tooltool 04:32:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:32:08 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1444930>, '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 0x1445830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1445cc0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:32:08 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 04:32:08 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 04:32:08 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 04:32:08 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:32:08 INFO - Return code: 0 04:32:08 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:32:08 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:32:08 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:32:08 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:32:08 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:32:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Y9xWYVFLRECkYT6pd8IXnw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--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 04:32:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Y9xWYVFLRECkYT6pd8IXnw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-001 --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 04:32:08 INFO - Using env: {'DISPLAY': ':0', 04:32:08 INFO - 'HOME': '/home/cltbld', 04:32:08 INFO - 'LANG': 'en_US.UTF-8', 04:32:08 INFO - 'LANGUAGE': 'en_US:en', 04:32:08 INFO - 'LOGNAME': 'cltbld', 04:32:08 INFO - 'MAIL': '/var/mail/cltbld', 04:32:08 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:32:08 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:32:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:32:08 INFO - 'MOZ_NO_REMOTE': '1', 04:32:08 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:32:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:32:08 INFO - 'NO_EM_RESTART': '1', 04:32:08 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:32:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:32:08 INFO - 'PWD': '/builds/slave/test', 04:32:08 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:32:08 INFO - 'SHELL': '/bin/bash', 04:32:08 INFO - 'SHLVL': '1', 04:32:08 INFO - 'TERM': 'linux', 04:32:08 INFO - 'TMOUT': '86400', 04:32:08 INFO - 'USER': 'cltbld', 04:32:08 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1476963072.416654-1117165592', 04:32:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:32:08 INFO - '_': '/tools/buildbot/bin/python'} 04:32:08 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Y9xWYVFLRECkYT6pd8IXnw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--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 04:32:09 INFO - mozversion application_buildid: 20161020013001 04:32:09 INFO - mozversion application_changeset: 99a239e1866a57f987b08dad796528e4ea30e622 04:32:09 INFO - mozversion application_display_name: Nightly 04:32:09 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:32:09 INFO - mozversion application_name: Firefox 04:32:09 INFO - mozversion application_remotingname: firefox 04:32:09 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:32:09 INFO - mozversion application_vendor: Mozilla 04:32:09 INFO - mozversion application_version: 52.0a1 04:32:09 INFO - mozversion platform_buildid: 20161020013001 04:32:09 INFO - mozversion platform_changeset: 99a239e1866a57f987b08dad796528e4ea30e622 04:32:09 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:32:09 INFO - mozversion platform_version: 52.0a1 04:32:09 INFO - using testdate: 1476963129 04:32:09 INFO - actual date: 1476963129 04:32:09 INFO - starting webserver on 'localhost:48292' 04:32:09 INFO - SUITE-START | Running 2 tests 04:32:09 INFO - TEST-START | dromaeo_css 04:32:09 INFO - operating with platform_type : linux_ 04:32:09 INFO - Initialising browser for dromaeo_css test... 04:32:09 INFO - TEST-INFO | started process 19028 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjLy9In/profile http://localhost:48292/getInfo.html) 04:32:12 INFO - PROCESS | 19028 | __metrics Screen width/height:1600/1200 04:32:12 INFO - PROCESS | 19028 | colorDepth:24 04:32:12 INFO - PROCESS | 19028 | Browser inner width/height: 1024/697 04:32:12 INFO - PROCESS | 19028 | __metrics 04:32:13 INFO - PROCESS | 19028 | 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" 04:32:13 INFO - PROCESS | 19028 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:32:14 INFO - PROCESS | 19028 | console.error: PushService: 04:32:14 INFO - PROCESS | 19028 | stateChangeProcessEnqueue: Error transitioning state 04:32:14 INFO - PROCESS | 19028 | UnknownError 04:32:14 INFO - TEST-INFO | 19028: exit 0 04:32:14 INFO - Browser initialized. 04:32:14 INFO - Running cycle 1/1 for dromaeo_css test... 04:32:14 INFO - TEST-INFO | started process 19110 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjLy9In/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:32:27 INFO - PROCESS | 19110 | RSS: Main: 171966464 04:32:27 INFO - PROCESS | 19110 | 04:33:18 INFO - PROCESS | 19110 | 1476963198475 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] 04:35:28 INFO - PROCESS | 19110 | Cycle 1(1): loaded http://localhost:48292/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48292/tests/dromaeo/cssquery-ext.html) 04:35:31 INFO - PROCESS | 19110 | RSS: Main: 406478848 04:35:31 INFO - PROCESS | 19110 | 04:38:33 INFO - PROCESS | 19110 | Cycle 1(1): loaded http://localhost:48292/tests/dromaeo/cssquery-ext.html (next: http://localhost:48292/tests/dromaeo/cssquery-jquery.html) 04:38:34 INFO - PROCESS | 19110 | RSS: Main: 281882624 04:38:34 INFO - PROCESS | 19110 | 04:41:36 INFO - PROCESS | 19110 | Cycle 1(1): loaded http://localhost:48292/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48292/tests/dromaeo/cssquery-mootools.html) 04:41:36 INFO - PROCESS | 19110 | RSS: Main: 258674688 04:41:36 INFO - PROCESS | 19110 | 04:44:38 INFO - PROCESS | 19110 | Cycle 1(1): loaded http://localhost:48292/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48292/tests/dromaeo/cssquery-prototype.html) 04:44:39 INFO - PROCESS | 19110 | RSS: Main: 271724544 04:44:39 INFO - PROCESS | 19110 | 04:47:42 INFO - PROCESS | 19110 | Cycle 1(1): loaded http://localhost:48292/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48292/tests/dromaeo/cssquery-yui.html) 04:47:42 INFO - PROCESS | 19110 | RSS: Main: 219164672 04:47:42 INFO - PROCESS | 19110 | 04:50:45 INFO - PROCESS | 19110 | Cycle 1(1): loaded http://localhost:48292/tests/dromaeo/cssquery-yui.html (next: http://localhost:48292/tests/dromaeo/cssquery-dojo.html) 04:50:45 INFO - PROCESS | 19110 | RSS: Main: 315052032 04:50:45 INFO - PROCESS | 19110 | 04:50:45 INFO - PROCESS | 19110 | __start_tp_report 04:50:45 INFO - PROCESS | 19110 | _x_x_mozilla_page_load 04:50:45 INFO - PROCESS | 19110 | _x_x_mozilla_page_load_details 04:50:45 INFO - PROCESS | 19110 | |i|pagename|runs| 04:50:45 INFO - PROCESS | 19110 | |0;dojo.html;3028.515437529995;3060.908172754818;3090.0729781065684;3104.2549788050874;3107.39405815866;5202.8699282517955;5276.208568714695;5322.095243808552;5380.273663055486;5421.186821976706;5308.362996440423;5313.654612450188;5322.787088516455;5331.2003199520095;5340.279062326585;4842.588379987706;4859.829905953292;4888.975555122237;4921.335619691332;4924.261360795891;4864.805407783702;4897.975510122462;4931.926021109686;4954.7522623868845;4964.702117872939;4962.40451145863;4968.35411396518;4971.4034315882145;5015.448300686921;5019.096562618727;617.925217966772;4930.112579735646;4964.032013757283;4966.130927087764;5022.271770593262;2987.0944480937915;4836.613070954315;4860.416749989989;4887.486813884527;4918.926216106761;5271.683698978073;5323.387810401815;5327.840164795062;5328.92006619901;5332.600054995852;5693.4875861172695;5747.48272655463;5770.365259821417;5772.5703107846275;5828.388019257959;5602.635828671123;5650.943490565124;5655.688937108457;5687.061634830289;5783.190353350535;5395.838124856261;5410.648307859977;5416.458354164552;5417.702026388508;5456.945430545684;5892.852678683067;5894.115882617642;5895.587308888336;5897.7935772247765;5899.616524925866;5517.310336207974;5578.442155784389;5578.832635020955;5645.435456454322;5664.037113690682;5652.123920792284;5712.542996560265;5715.085586306171;5719.828405147852;5721.942780572224;5686.3744988051285;5691.430856914276;5706;5715.942840571541;5720.599558030981;5663.801766938137;5700.3444603871085;5715.142728590661;5718.1708652246025;5718.399568045378;4367.497737760134;4375.27807911691;4380.759058251763;4382.868513944587;4385.780710964439;3909.863154789569;3921.7254792164845;3924.823382947774;3940.960590394059;3999.860004899873;5475.589330800126;5476.069068258405;5481.588880833953;5484.972575137179;5494.752736126884;5721.799737009184;5751.252337196138;5799.88400231993;5807.8548036299435;5820.82537523875;5250.238715386324;5327.520523152934;5335.733213339317;5351.197320401893;5411.56707463402;4972.801087956441;4975.925361119586;4991.975040124848;5005.34930459038;5047.823326183639;5926.703664816742;5936.050231962865;5938.524918006549;5944.64332140073;5945.672987985616;5591.077472217201;5626.88746225065;5636.915446268391;5750.051241545266;5809.838032393623;5852.5317974561085;5885.617434866891;5907.911381329198;5929.377415371497;5997.880042399215;5645.1532270159805;5651.124075768263;5651.745671444713;5657.32112146545;5660.85847853807;5576.86057848557;5747.5689323300085;5748.735278238781;5750.568707347049;5754.884902302014;5443.863903402288;5601.5238704710555;5603.767171222325;5609.691466969192;5611.018071837494;5537.335519737658;5574.749136288958;5598.580106491948;5598.86002849932;5600.747966341443;5567.192757050286;5572.4148964358155;5575.358833734173;5576.749046292845;5588.720563971704;5640.32316122068;5658.122990936411;5660.094384898396;5666.914996275142;5667;5483.506484416422;5510.366307874646;5513.972430137824;5514.751836167302;5518 04:50:45 INFO - PROCESS | 19110 | |1;ext.html;615.6306216270239;633.4552285034869;635.4662083849566;655.698378745777;657.2179106862833;30640.846795766018;41757.58242417575;42661.360079598795;42771.57228427715;46142.30786538205;43704;44076.77961610196;44092;44203.778981105046;44243.3363499547;8140.308073813733;8784.95607521963;8947.597358118868;8957.283417326631;8963.058878817728;8035.276825085741;8385;8385.077641459435;10491.527881245323;10741.462926853665;10795.2443328967;10845.620403285886;10859.837102443431;10861.294015888981;10867.565297388135;10625.574977000912;10702.46487675613;10716.73208169798;10726.517306721216;10742.033217010428;10541.683749487527;10605.893941060567;10619.991100845407;10620.150387968944;10633.096186824052;40016.59983400158;40025.399619005446;40091.39862902059;40424;40473.19053618911;3132.0760375688997;3180.8409579521162;3216.0994921421807;3402.6937575618067;3525.6474352564796;30643.540346894813;31093.689063109305;31147.84426077855;31323;31545.36909261802;3992.920917099171;4066.6340029397497;4088.468499095128;4138.772367519785;4205.537390887;289801;290042;290721;290855.54572227213;291764;51367.7431612847;51517;51521.7423912878;51550.22674659883;51797;33756.662433375845;34911;34946.126346841025;35768.82115589405;35802.64197358045;12775.425105870258;12940.417681204368;12941.676458088436;12945.352732363344;12949.54676586315;9565.904340956502;9664.081912218327;9676.371035882645;9678.370905891095;9703.320767546204;16169.514914552583;16635.251413686412;17519.38682146144;17849.910750446164;18260;6807.217170025411;6813.659317034128;7039.577625342496;7144.7129124448575;7150.892736608955;853.9701110461104;1045.1220974381556;1046.2414749306693;1069.3476979042778;1124.2299025167786;29865.850670746506;30389.69610303913;30648.540271895938;31032;31261.687383126333;1015.243643485608;1019.4087429291142;1051.6897515233024;1053.1732589916878;1065.1212749481708;15234.619134521725;16371.590710232102;16373.836261637469;16375;16609.67806438717;468543;468626;469804;470432.7740335591;478582;53675;54063.72968135213;54088.729556351966;54163.45836541663;54165.729171353894;1207.879212078785;1250.5560526013317;1288.6134159752037;1291.9806202907153;1315.9210447373189;27837.304067398476;31362.21594460157;31444.371112577162;31666.208344791565;31890.362192756478;46128.769356153;46130.53869461397;46314.30528542007;46426;46550.30174547317;332862;333181;333209;334766;335348;25993.350166245997;26207.4758504825;27345.72654273432;27394.315142121606;28007;44657.55342446664;45406.545934540234;45436;45460.77269613631;45754;37946.8102659496;38017;38750.418743718306;39845.40231896582;40323.79838100791;38000.429993549566;38422;38586.22827543489;38776.80611596924;39566.20867582575;37852;37961;38552.614473856025;38761.6123838758;39272.60727392689;32116.554755035613;33890.66109338875;34572.30855382929;34627.65372346244;34857.65142348544;24065.269883168137;24065.879670601535;24211.515769684156;24343.391415214763;24758.752412475646 04:50:45 INFO - PROCESS | 19110 | |2;jquery.html;346.5581383735735;362.84760400631717;367.3772954841543;367.5956447907302;380.7030516197367;13855.584332470029;17455.82544174558;17879.642407151867;18978.051097445143;19207.423777286705;14187.645308867284;14794.40822367104;15765.290561924712;15903.44337948172;15987.360505579793;5116.053530096935;5306.442823503535;5525.668459892399;5555.166724991263;5558.583106267026;4021.718479706422;4223.72545784523;5447.210154527591;5543.805966791163;5869.295684517864;6121.989871671191;6168.1364608954555;6168.352323006087;6175.04286835539;6198.0083186690135;5348.224507446418;5600.019996500596;5641.323041235037;5720.513756330717;6181.783637572686;5436.130219164954;5488.204210389471;5526.944730552724;5533.059379905426;5535.418781027975;13375.398107085204;14922.030068045542;21747.347579572637;22525.887370563043;22591.435214119614;2087.1338394566237;2136.743590769118;2276.8292378071546;2543.682039745032;2818.886539816761;9673.129418352382;9734.610615575368;9842.803143937153;10019.348742331726;10203.744906377326;1675.0954484578313;1825.561865152367;1847.8798878073017;1932.3623204342534;1968.8720233184797;75507.62246188734;76570;76742;78244;79391;9794.363366381305;9849.753756156153;9933.751656208653;10340.844887326695;10446.634367797242;13995.86004139966;14006.229657368738;14037.649058773612;14043.438262469386;14045.78931316031;6848;7170.533915295593;7230.710771569184;7292.8906066409045;7423.740169094056;6689.76585819494;6694.163229596301;6905.75829845953;6943.618101004493;6950.652467376611;4258.169656916872;4390.714603550759;4402.119576084732;4513.977430112828;4527.909441811145;1765.6115654555977;1852.4350073227795;1869.5226878006897;1877.0989924836156;1880.2572983671373;813.556611646654;871.2246100970142;907.9954600226956;946.7396465971775;947.6827210177859;17255.066638671455;18566.164522596515;18802;18973.90513047426;19225.230990760494;853.9573021348908;883.9337049721297;939.6664184214642;962.711186644004;1017.976933182162;7024.438044956391;10173.135283500837;10261.230407719451;10404.353968917303;10498.47507624631;441957;447860;448666;449501;449699;87937;88438.55780721056;89660.5516972411;90203.54898225467;90642.54678726564;969.340848223215;990.935589186715;1016.6441745389203;1017.3234798858824;1021.6066814276409;14594.708105837612;15609.297581608627;15824.173627043861;16228.756568651244;16511.752323714914;36887;37091;37934.8103259493;38486.807565963114;39132.608673912895;49414.75292623514;49744.502554975435;51923.48076519187;53204;53991.73004135111;7769.223077692412;7809.687612495437;7926.920730792618;8099.514029158269;8392.412531122764;10987;12561.87438125607;12658.683532911751;12947.352632368156;13145.868541314465;5878.735456904535;10594.47027648599;10981.20423672535;11485.885141148481;11599.014083802971;10812.026917577456;10835.133189344675;10872.510737016695;11014.39420831862;11044.944775276072;10834.620788272372;11134.164937629548;11185.88814111881;11400;11766.352850593299;7935.40484463656;7994.320482759031;8080.393970452122;8112.18878112184;8324.500529968222;8823.558822059;10729.195310351599;11091.778164436504;11112.166587505808;11150.665480035612 04:50:45 INFO - PROCESS | 19110 | |3;mootools.html;1309.2798960571683;1467.6771110355721;1481.214956073281;1483.799687042249;1521.809773778277;7559.622018899054;8097.797555061126;8105.230003149699;8339.20777526134;8357;8507.234348908598;8529.957350213255;8533.786655333619;8537.957310213456;8546.871796923051;2215.5125872308067;2239.6640503924377;2241.6301310283866;2245.7978781909624;2249.640057590786;2179.6730490426403;2215.8005779479845;2228.186711850179;2229.3869185973904;2229.732432108141;2141.8179454746364;2166.7833216678364;2213.5904857601313;2221.2891874600136;2231.665250212465;2174.7281589801273;2197.890105494727;2201.2295696506176;2202.218212534551;2205.040807248836;2165.2962787094257;2169.5227050048966;2173.0981642618294;2176.5211653436218;2178.2811672148155;8387.287080598157;8422.410431269813;8442.662293508252;8445.957770211171;8451.23938845507;4873.780679869415;5032.220005899091;5032.4967503249745;5085.059264036128;5096.311997880276;3147.732442742347;3332.4001679697644;3354.2117602363423;3370.8483118259737;3375;951.5432592355639;977.9706608801747;993.881882881758;1007.2445665750687;1011.519528224095;12281.263124212575;12301.815472767916;12383.75232495354;12395.132340736152;12395.876041239562;4315.09383029561;4423.203823311835;4468.173387923244;4559.133764584718;4610.53894610543;9703.563339649732;9710.126088652056;9713.611455541699;9713.70858874235;9719.271054670928;4907.803687852517;4912.606991440676;4916.188828843201;4920.5571498565305;4927.926081108714;4077.857274995361;4105.794710264475;4138.689598280141;4532.7280363178315;4554.4990051094355;3342.3148254607745;3651.1419816343137;3665.4318580620047;3677.1542545214215;3696.057505336176;1046.895310468947;1065.8347956066823;1067.685032915292;1070.5450183671908;1071.27153535595;858.0347109501811;864.9913500865036;868.8218915122385;895.83427065993;913.8583519554479;5544.362398324163;5680.801171958961;5699.572532060112;5799.39106393831;5995.130706047598;888.5201990924958;889.3952112563519;889.6530353162271;919.8298314811648;952.5903861339552;3658.762180458315;3819.3316169670197;3862.8841134766003;3879.650831425185;3891.669208117285;10849.891501085045;11076.280041797258;11239.775204495865;11260.94369528147;11270.09839212861;11069.944650276697;11080.944595277133;11081.335119892832;11086.334819910831;11121.555137794398;8090.514569125871;8244.29923456501;8244.917550824415;8245.587720613825;8248.711295104642;5959.463648271676;5989.8203053908455;5990.820275391745;6230.221222347207;6299.370062993664;9728.464934428674;9777.657781977596;9911.454869981932;9939;10266.948665256627;8465.703700370705;10310.948445257725;10430.322029068086;10464.215183861394;10483.52824122901;7075.433965282868;7469.1037075551285;7646.9617651911385;7739.1100023495765;7885.881711774443;8443.8733419;8457.788555286166;8461.069282379056;8546.2308392245;8554.91445085541;7518.436117291116;7600.695972161052;7661.310482056641;7684.5773482459;7742.341900938258;7462;7525.397968162643;7594.468387212842;7627.161012288533;7858.960705196666;6725.697343619451;6835.7949261522235;6856.588604683735;6919.757808476679;6990.685419156252;4966.900661986812;4983.8504844854715;5056.84829455117;5060.114479966065;5170.844874653766;4753.073150735711;4821.132196204717;4839.080574690797;4852.320675105418;4881 04:50:45 INFO - PROCESS | 19110 | |4;prototype.html;304.52038040086853;314.8709029297988;320.0622177021327;322.2732737676539;322.7724454259747;5066.9493305066935;5207.557357624597;5213.66111202772;5255.816046438375;5257.763400646975;5034.496550344964;5153.278541004253;5176.611754118438;5186.896262074756;5187.896242075156;4063;4077.918441631158;4085.6527195188446;4091.672666186713;4099.836006559749;3857.305684976703;4059.8985025374304;4099.385092236159;4101.118259574191;4117.711760176789;3983.422403751454;4002.019505221225;4013.97993010036;4017.3773065174946;4031.8185681644395;3982.342913419297;4002.399640053986;4007.8597249096433;4015.8393664253686;4028.482198625859;3430.588329400488;3526.188976535386;3536.1159710072484;3542.36237477254;3560.928781424383;5090.796368145269;5092.618053645954;5099.643024988252;5113.897722045538;5125.026245013435;4616.930746038812;4618.1918164321105;4619.953800461986;4630.120277147331;4635.930461043087;5317.787288508455;5411.350637923435;5426.945730542683;5464.644798088151;5479;3872.380419132953;3884.514435695538;3893.863714769998;3903.1998440319667;3904.863329783472;5623.325200975909;5667.971660141714;5681.630694004876;5683.715814209273;5686.715664216773;3803.695704343646;3937.9803100984313;3968.761874287552;3972.2254160439015;3972.682185425159;3994.800259986989;3995.220931918306;4002.1595464952684;4006;4015.3374693175297;4592.97703511487;4600.815967361335;4608.700434471749;4610.170169369479;4610.631149508032;5114.496569849591;5478.780848766005;5484.314460692413;5498.8075417361;5509.752061157257;1337.3246510512324;1377.9724405511834;1383.4673650644575;1387.2855479428104;1397.4200706706806;841.2386789955101;868.3530769576706;881.8324518341494;884.4825776920574;889.573004957624;4665.880188754742;4668;4697.906041879143;4719.244920812654;4724.267738500538;4918.336024636628;4922.950770492249;4943.209086546207;4949.727764972961;4951.777170027357;4463.642908567372;4658.883527911761;4666.603338716247;4688.929666055012;4698.248280275139;2632.7762140217915;2651.57574788033;2655.721149279298;2656.3491944473726;2667.346500107486;5056.696598204119;5066.316047333637;5069.619778516626;5074.5686616637995;5087.720175390315;4817.879553011133;4978.108318838818;5009.797648564391;5012.621529079533;5031.396232452129;5034.974825125851;5043.604287963188;5053.393592768891;5062.544371006627;5082.119615742199;4915.3855768029;4920;4926.48271931442;4947.851564453073;4954.702717836942;4546.772661366852;4749.952500475089;4864.805407783649;4883.8290659826735;4909.239067944474;4958.380202474691;4995.275685025724;5007.0472515718175;5039.79045029183;5129.743512824419;3632.9818350908076;3782.1868298315994;3806.638369354907;3871.2838124945847;3873.1479074603544;5526.778928842962;5527.640703354269;5527.972360138174;5531.45119366578;5538.723063846872;5412.404635490172;5423.322084739408;5423.457654234545;5432.511074003359;5457.372402173642;5173.81891633791;5390;5422.539084177732;5431.456854314695;5451.536619387238;5316.893662126813;5350.946490535045;5361.437049109787;5432.392451623322;5432.918506222489;5193.507615912285;5363.865903352447;5417.268668729671;5429.809956651657;5449.2371068049715;5354.919676204938;5386.892262154814;5414.35027796667;5417.43116972728;5420.728963551728 04:50:45 INFO - PROCESS | 19110 | |5;yui.html;617.283950617284;629.3611983836405;629.5718911140423;706.1667232665453;725.2240103089696;14029.719405611895;14725.337359818806;14754.704905901888;14761.630959226024;15668;14929.477468288585;15070.773938390932;15132.697346053072;15135;15150.469733559328;776.2974508070206;801.2668408406302;805.3557154276584;805.8871757953891;805.907320658126;663.4460225711513;680.8025672554953;776.2470403708394;794.9602519873984;801.3348920396057;850.2305413600701;854.9230569248766;857.4512312120248;857.6483641706901;857.6998050682242;846.01861840265;846.7586737779734;846.7756044648204;846.9534175620338;847.6736456464275;508.1640701046757;520.1859090523357;599.3077994915835;610.0391882784587;617.305531277313;14831.70336593262;14853.554393368217;14875.47935822252;14882.479113230986;14885.255737213096;13281.468741250339;13606.183628982293;13917.443302267897;14146.36341364641;14408.63978400538;12575.811362829565;12584.68538286541;12653.936730316382;12766.297853618047;13358.064935454522;4199.475065616798;4217.810198541042;4230.809613567397;4373.890652733675;4427.9557204427865;57515;57858.42141578573;77317.61341193259;80991.19008809836;81496;10753.139748820076;10884.945575272073;10971.341719496855;10986.340819550853;11040.33757974508;20705.378838634864;21122.366329010154;21218;21293.89353053225;21363.786362136492;7239;7441.404687624977;7552.735654252075;7674.961625191839;7680.3471704905705;4263.296556068276;4345.956540434555;4412.580804823537;4442.155990361885;4480.215962206666;3273.9836300818342;3425.880094196691;3426.3318652862454;3431.330890476383;3432.673895979878;603.6559161278117;606.9180660610849;608.7025599269086;622.5144387377852;623.803501896901;672.7544446277171;685.2291172431015;701.1340993872564;726.6693654387241;764.7211310295351;9184.770380740534;9190.540472976325;9203.263738900872;9407.247420206504;9678.661246856327;613.5521069619114;700.6461736822973;701.5019336271305;704.429412176139;708.3907839258234;4119.423280740699;4486.51944858196;4500.167469018242;4533.410656614619;4567.314902764546;117812.41093794476;118391;119416.40291798486;120522;121225.54485048194;99498.8505976401;100098.49162821096;100989.45547450382;101110.4944475273;102176;79241;80191.19808801837;81337.59331203424;83874;86814;8326.583670816555;8456.365772566958;8560.614772335135;8647.524386158822;8819.250363719155;51226.48773512217;51400.74299628478;52730.61771351937;53306.73346633242;53406.73296633492;65672.6716366415;77244;77979.61010194913;80397.59801200956;81087.18912810796;10468.842967355647;10635.521401536795;10890.346579205274;11103.777924441305;11387.772244554897;12005.219660722025;12620.55828046014;13084.214947103204;13237.669058273621;13271.402786874807;11197.949137410735;12139.939300303442;12315.13794034409;12425;12743.235405875677;14188.787168192692;14234.288285585886;14593.85406145925;14790.778138327718;15120.621984450478;13504.594862154152;13761.38073786702;14116.858831411555;14139.929300353844;14537.78193327122;11063.778724425305;11154.104060598534;11489.195756296978;11609.6517104487;11750.35373054456;12292.262464252173;12348.876511234772;12439.253644781342;12636.810447843105;12646.494140234288 04:50:45 INFO - PROCESS | 19110 | __end_tp_report 04:50:45 INFO - PROCESS | 19110 | __start_cc_report 04:50:45 INFO - PROCESS | 19110 | _x_x_mozilla_cycle_collect,2606 04:50:45 INFO - PROCESS | 19110 | __end_cc_report 04:50:45 INFO - PROCESS | 19110 | __startTimestamp1476964245728__endTimestamp 04:50:45 INFO - PROCESS | 19110 | 04:50:45 INFO - PROCESS | 19110 | ------- Summary: start ------- 04:50:45 INFO - PROCESS | 19110 | Number of tests: 6 04:50:45 INFO - PROCESS | 19110 | 04:50:45 INFO - PROCESS | 19110 | [#0] dojo.html Cycles:165 Average:5291.37 Median:5567.19 stddev:721.37 (13.0%) stddev-sans-first:701.40 04:50:45 INFO - PROCESS | 19110 | Values: 3028.5 3060.9 3090.1 3104.3 3107.4 5202.9 5276.2 5322.1 5380.3 5421.2 5308.4 5313.7 5322.8 5331.2 5340.3 4842.6 4859.8 4889.0 4921.3 4924.3 4864.8 4898.0 4931.9 4954.8 4964.7 4962.4 4968.4 4971.4 5015.4 5019.1 617.9 4930.1 4964.0 4966.1 5022.3 2987.1 4836.6 4860.4 4887.5 4918.9 5271.7 5323.4 5327.8 5328.9 5332.6 5693.5 5747.5 5770.4 5772.6 5828.4 5602.6 5650.9 5655.7 5687.1 5783.2 5395.8 5410.6 5416.5 5417.7 5456.9 5892.9 5894.1 5895.6 5897.8 5899.6 5517.3 5578.4 5578.8 5645.4 5664.0 5652.1 5712.5 5715.1 5719.8 5721.9 5686.4 5691.4 5706.0 5715.9 5720.6 5663.8 5700.3 5715.1 5718.2 5718.4 4367.5 4375.3 4380.8 4382.9 4385.8 3909.9 3921.7 3924.8 3941.0 3999.9 5475.6 5476.1 5481.6 5485.0 5494.8 5721.8 5751.3 5799.9 5807.9 5820.8 5250.2 5327.5 5335.7 5351.2 5411.6 4972.8 4975.9 4992.0 5005.3 5047.8 5926.7 5936.1 5938.5 5944.6 5945.7 5591.1 5626.9 5636.9 5750.1 5809.8 5852.5 5885.6 5907.9 5929.4 5997.9 5645.2 5651.1 5651.7 5657.3 5660.9 5576.9 5747.6 5748.7 5750.6 5754.9 5443.9 5601.5 5603.8 5609.7 5611.0 5537.3 5574.7 5598.6 5598.9 5600.7 5567.2 5572.4 5575.4 5576.7 5588.7 5640.3 5658.1 5660.1 5666.9 5667.0 5483.5 5510.4 5514.0 5514.8 5518.0 04:50:45 INFO - PROCESS | 19110 | 04:50:45 INFO - PROCESS | 19110 | [#1] ext.html Cycles:180 Average:51989.46 Median:34742.65 stddev:98619.27 (283.9%) stddev-sans-first:98820.49 04:50:45 INFO - PROCESS | 19110 | Values: 615.6 633.5 635.5 655.7 657.2 30640.8 41757.6 42661.4 42771.6 46142.3 43704.0 44076.8 44092.0 44203.8 44243.3 8140.3 8785.0 8947.6 8957.3 8963.1 8035.3 8385.0 8385.1 10491.5 10741.5 10795.2 10845.6 10859.8 10861.3 10867.6 10625.6 10702.5 10716.7 10726.5 10742.0 10541.7 10605.9 10620.0 10620.2 10633.1 40016.6 40025.4 40091.4 40424.0 40473.2 3132.1 3180.8 3216.1 3402.7 3525.6 30643.5 31093.7 31147.8 31323.0 31545.4 3992.9 4066.6 4088.5 4138.8 4205.5 289801.0 290042.0 290721.0 290855.5 291764.0 51367.7 51517.0 51521.7 51550.2 51797.0 33756.7 34911.0 34946.1 35768.8 35802.6 12775.4 12940.4 12941.7 12945.4 12949.5 9565.9 9664.1 9676.4 9678.4 9703.3 16169.5 16635.3 17519.4 17849.9 18260.0 6807.2 6813.7 7039.6 7144.7 7150.9 854.0 1045.1 1046.2 1069.3 1124.2 29865.9 30389.7 30648.5 31032.0 31261.7 1015.2 1019.4 1051.7 1053.2 1065.1 15234.6 16371.6 16373.8 16375.0 16609.7 468543.0 468626.0 469804.0 470432.8 478582.0 53675.0 54063.7 54088.7 54163.5 54165.7 1207.9 1250.6 1288.6 1292.0 1315.9 27837.3 31362.2 31444.4 31666.2 31890.4 46128.8 46130.5 46314.3 46426.0 46550.3 332862.0 333181.0 333209.0 334766.0 335348.0 25993.4 26207.5 27345.7 27394.3 28007.0 44657.6 45406.5 45436.0 45460.8 45754.0 37946.8 38017.0 38750.4 39845.4 40323.8 38000.4 38422.0 38586.2 38776.8 39566.2 37852.0 37961.0 38552.6 38761.6 39272.6 32116.6 33890.7 34572.3 34627.7 34857.7 24065.3 24065.9 24211.5 24343.4 24758.8 04:50:45 INFO - PROCESS | 19110 | 04:50:45 INFO - PROCESS | 19110 | [#2] jquery.html Cycles:180 Average:26681.21 Median:4122.72 stddev:73953.06 (1793.8%) stddev-sans-first:74134.08 04:50:45 INFO - PROCESS | 19110 | Values: 346.6 362.8 367.4 367.6 380.7 13855.6 17455.8 17879.6 18978.1 19207.4 14187.6 14794.4 15765.3 15903.4 15987.4 5116.1 5306.4 5525.7 5555.2 5558.6 4021.7 4223.7 5447.2 5543.8 5869.3 6122.0 6168.1 6168.4 6175.0 6198.0 5348.2 5600.0 5641.3 5720.5 6181.8 5436.1 5488.2 5526.9 5533.1 5535.4 13375.4 14922.0 21747.3 22525.9 22591.4 2087.1 2136.7 2276.8 2543.7 2818.9 9673.1 9734.6 9842.8 10019.3 10203.7 1675.1 1825.6 1847.9 1932.4 1968.9 75507.6 76570.0 76742.0 78244.0 79391.0 9794.4 9849.8 9933.8 10340.8 10446.6 13995.9 14006.2 14037.6 14043.4 14045.8 6848.0 7170.5 7230.7 7292.9 7423.7 6689.8 6694.2 6905.8 6943.6 6950.7 4258.2 4390.7 4402.1 4514.0 4527.9 1765.6 1852.4 1869.5 1877.1 1880.3 813.6 871.2 908.0 946.7 947.7 17255.1 18566.2 18802.0 18973.9 19225.2 854.0 883.9 939.7 962.7 1018.0 7024.4 10173.1 10261.2 10404.4 10498.5 441957.0 447860.0 448666.0 449501.0 449699.0 87937.0 88438.6 89660.6 90203.5 90642.5 969.3 990.9 1016.6 1017.3 1021.6 14594.7 15609.3 15824.2 16228.8 16511.8 36887.0 37091.0 37934.8 38486.8 39132.6 49414.8 49744.5 51923.5 53204.0 53991.7 7769.2 7809.7 7926.9 8099.5 8392.4 10987.0 12561.9 12658.7 12947.4 13145.9 5878.7 10594.5 10981.2 11485.9 11599.0 10812.0 10835.1 10872.5 11014.4 11044.9 10834.6 11134.2 11185.9 11400.0 11766.4 7935.4 7994.3 8080.4 8112.2 8324.5 8823.6 10729.2 11091.8 11112.2 11150.7 04:50:45 INFO - PROCESS | 19110 | 04:50:45 INFO - PROCESS | 19110 | [#3] mootools.html Cycles:180 Average:5643.38 Median:4918.37 stddev:3311.61 (67.3%) stddev-sans-first:3304.88 04:50:45 INFO - PROCESS | 19110 | Values: 1309.3 1467.7 1481.2 1483.8 1521.8 7559.6 8097.8 8105.2 8339.2 8357.0 8507.2 8530.0 8533.8 8538.0 8546.9 2215.5 2239.7 2241.6 2245.8 2249.6 2179.7 2215.8 2228.2 2229.4 2229.7 2141.8 2166.8 2213.6 2221.3 2231.7 2174.7 2197.9 2201.2 2202.2 2205.0 2165.3 2169.5 2173.1 2176.5 2178.3 8387.3 8422.4 8442.7 8446.0 8451.2 4873.8 5032.2 5032.5 5085.1 5096.3 3147.7 3332.4 3354.2 3370.8 3375.0 951.5 978.0 993.9 1007.2 1011.5 12281.3 12301.8 12383.8 12395.1 12395.9 4315.1 4423.2 4468.2 4559.1 4610.5 9703.6 9710.1 9713.6 9713.7 9719.3 4907.8 4912.6 4916.2 4920.6 4927.9 4077.9 4105.8 4138.7 4532.7 4554.5 3342.3 3651.1 3665.4 3677.2 3696.1 1046.9 1065.8 1067.7 1070.5 1071.3 858.0 865.0 868.8 895.8 913.9 5544.4 5680.8 5699.6 5799.4 5995.1 888.5 889.4 889.7 919.8 952.6 3658.8 3819.3 3862.9 3879.7 3891.7 10849.9 11076.3 11239.8 11260.9 11270.1 11069.9 11080.9 11081.3 11086.3 11121.6 8090.5 8244.3 8244.9 8245.6 8248.7 5959.5 5989.8 5990.8 6230.2 6299.4 9728.5 9777.7 9911.5 9939.0 10266.9 8465.7 10310.9 10430.3 10464.2 10483.5 7075.4 7469.1 7647.0 7739.1 7885.9 8443.9 8457.8 8461.1 8546.2 8554.9 7518.4 7600.7 7661.3 7684.6 7742.3 7462.0 7525.4 7594.5 7627.2 7859.0 6725.7 6835.8 6856.6 6919.8 6990.7 4966.9 4983.9 5056.8 5060.1 5170.8 4753.1 4821.1 4839.1 4852.3 4881.0 04:50:45 INFO - PROCESS | 19110 | 04:50:45 INFO - PROCESS | 19110 | [#4] prototype.html Cycles:180 Average:4396.92 Median:4934.85 stddev:1271.25 (25.8%) stddev-sans-first:1237.15 04:50:45 INFO - PROCESS | 19110 | Values: 304.5 314.9 320.1 322.3 322.8 5066.9 5207.6 5213.7 5255.8 5257.8 5034.5 5153.3 5176.6 5186.9 5187.9 4063.0 4077.9 4085.7 4091.7 4099.8 3857.3 4059.9 4099.4 4101.1 4117.7 3983.4 4002.0 4014.0 4017.4 4031.8 3982.3 4002.4 4007.9 4015.8 4028.5 3430.6 3526.2 3536.1 3542.4 3560.9 5090.8 5092.6 5099.6 5113.9 5125.0 4616.9 4618.2 4620.0 4630.1 4635.9 5317.8 5411.4 5426.9 5464.6 5479.0 3872.4 3884.5 3893.9 3903.2 3904.9 5623.3 5668.0 5681.6 5683.7 5686.7 3803.7 3938.0 3968.8 3972.2 3972.7 3994.8 3995.2 4002.2 4006.0 4015.3 4593.0 4600.8 4608.7 4610.2 4610.6 5114.5 5478.8 5484.3 5498.8 5509.8 1337.3 1378.0 1383.5 1387.3 1397.4 841.2 868.4 881.8 884.5 889.6 4665.9 4668.0 4697.9 4719.2 4724.3 4918.3 4923.0 4943.2 4949.7 4951.8 4463.6 4658.9 4666.6 4688.9 4698.2 2632.8 2651.6 2655.7 2656.3 2667.3 5056.7 5066.3 5069.6 5074.6 5087.7 4817.9 4978.1 5009.8 5012.6 5031.4 5035.0 5043.6 5053.4 5062.5 5082.1 4915.4 4920.0 4926.5 4947.9 4954.7 4546.8 4750.0 4864.8 4883.8 4909.2 4958.4 4995.3 5007.0 5039.8 5129.7 3633.0 3782.2 3806.6 3871.3 3873.1 5526.8 5527.6 5528.0 5531.5 5538.7 5412.4 5423.3 5423.5 5432.5 5457.4 5173.8 5390.0 5422.5 5431.5 5451.5 5316.9 5350.9 5361.4 5432.4 5432.9 5193.5 5363.9 5417.3 5429.8 5449.2 5354.9 5386.9 5414.4 5417.4 5420.7 04:50:45 INFO - PROCESS | 19110 | 04:50:45 INFO - PROCESS | 19110 | [#5] yui.html Cycles:180 Average:20631.59 Median:4393.24 stddev:30218.38 (687.8%) stddev-sans-first:30265.78 04:50:45 INFO - PROCESS | 19110 | Values: 617.3 629.4 629.6 706.2 725.2 14029.7 14725.3 14754.7 14761.6 15668.0 14929.5 15070.8 15132.7 15135.0 15150.5 776.3 801.3 805.4 805.9 805.9 663.4 680.8 776.2 795.0 801.3 850.2 854.9 857.5 857.6 857.7 846.0 846.8 846.8 847.0 847.7 508.2 520.2 599.3 610.0 617.3 14831.7 14853.6 14875.5 14882.5 14885.3 13281.5 13606.2 13917.4 14146.4 14408.6 12575.8 12584.7 12653.9 12766.3 13358.1 4199.5 4217.8 4230.8 4373.9 4428.0 57515.0 57858.4 77317.6 80991.2 81496.0 10753.1 10884.9 10971.3 10986.3 11040.3 20705.4 21122.4 21218.0 21293.9 21363.8 7239.0 7441.4 7552.7 7675.0 7680.3 4263.3 4346.0 4412.6 4442.2 4480.2 3274.0 3425.9 3426.3 3431.3 3432.7 603.7 606.9 608.7 622.5 623.8 672.8 685.2 701.1 726.7 764.7 9184.8 9190.5 9203.3 9407.2 9678.7 613.6 700.6 701.5 704.4 708.4 4119.4 4486.5 4500.2 4533.4 4567.3 117812.4 118391.0 119416.4 120522.0 121225.5 99498.9 100098.5 100989.5 101110.5 102176.0 79241.0 80191.2 81337.6 83874.0 86814.0 8326.6 8456.4 8560.6 8647.5 8819.3 51226.5 51400.7 52730.6 53306.7 53406.7 65672.7 77244.0 77979.6 80397.6 81087.2 10468.8 10635.5 10890.3 11103.8 11387.8 12005.2 12620.6 13084.2 13237.7 13271.4 11197.9 12139.9 12315.1 12425.0 12743.2 14188.8 14234.3 14593.9 14790.8 15120.6 13504.6 13761.4 14116.9 14139.9 14537.8 11063.8 11154.1 11489.2 11609.7 11750.4 12292.3 12348.9 12439.3 12636.8 12646.5 04:50:45 INFO - PROCESS | 19110 | -------- Summary: end -------- 04:50:45 INFO - PROCESS | 19110 | 04:50:46 INFO - TEST-INFO | 19110: exit 0 04:50:46 INFO - TEST-OK | dromaeo_css | took 1117684ms 04:50:46 INFO - TEST-START | kraken 04:50:46 INFO - operating with platform_type : linux_ 04:50:46 INFO - Initialising browser for kraken test... 04:50:46 INFO - TEST-INFO | started process 19419 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOQyvpj/profile http://localhost:48292/getInfo.html) 04:50:50 INFO - PROCESS | 19419 | __metrics Screen width/height:1600/1200 04:50:50 INFO - PROCESS | 19419 | colorDepth:24 04:50:50 INFO - PROCESS | 19419 | Browser inner width/height: 1024/697 04:50:50 INFO - PROCESS | 19419 | __metrics 04:50:51 INFO - PROCESS | 19419 | 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" 04:50:51 INFO - PROCESS | 19419 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:50:51 INFO - PROCESS | 19419 | console.error: PushService: 04:50:51 INFO - PROCESS | 19419 | stateChangeProcessEnqueue: Error transitioning state 04:50:51 INFO - PROCESS | 19419 | UnknownError 04:50:52 INFO - TEST-INFO | 19419: exit 0 04:50:52 INFO - Browser initialized. 04:50:52 INFO - Running cycle 1/1 for kraken test... 04:50:52 INFO - TEST-INFO | started process 19500 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOQyvpj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:51:04 INFO - PROCESS | 19500 | RSS: Main: 172064768 04:51:04 INFO - PROCESS | 19500 | 04:51:07 INFO - PROCESS | 19500 | Cycle 1(1): loaded http://localhost:48292/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48292/tests/kraken/driver.html?testName=audio-beat-detection) 04:51:08 INFO - PROCESS | 19500 | RSS: Main: 229474304 04:51:08 INFO - PROCESS | 19500 | 04:51:10 INFO - PROCESS | 19500 | Cycle 1(1): loaded http://localhost:48292/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48292/tests/kraken/driver.html?testName=audio-dft) 04:51:11 INFO - PROCESS | 19500 | RSS: Main: 215773184 04:51:11 INFO - PROCESS | 19500 | 04:51:14 INFO - PROCESS | 19500 | Cycle 1(1): loaded http://localhost:48292/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48292/tests/kraken/driver.html?testName=audio-fft) 04:51:15 INFO - PROCESS | 19500 | RSS: Main: 297242624 04:51:15 INFO - PROCESS | 19500 | 04:51:17 INFO - PROCESS | 19500 | Cycle 1(1): loaded http://localhost:48292/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48292/tests/kraken/driver.html?testName=audio-oscillator) 04:51:17 INFO - PROCESS | 19500 | RSS: Main: 206417920 04:51:17 INFO - PROCESS | 19500 | 04:51:20 INFO - PROCESS | 19500 | Cycle 1(1): loaded http://localhost:48292/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48292/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:51:20 INFO - PROCESS | 19500 | RSS: Main: 211697664 04:51:20 INFO - PROCESS | 19500 | 04:51:23 INFO - PROCESS | 19500 | Cycle 1(1): loaded http://localhost:48292/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48292/tests/kraken/driver.html?testName=imaging-darkroom) 04:51:24 INFO - PROCESS | 19500 | RSS: Main: 247312384 04:51:24 INFO - PROCESS | 19500 | 04:51:27 INFO - PROCESS | 19500 | Cycle 1(1): loaded http://localhost:48292/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48292/tests/kraken/driver.html?testName=imaging-desaturate) 04:51:28 INFO - PROCESS | 19500 | RSS: Main: 247271424 04:51:28 INFO - PROCESS | 19500 | 04:51:30 INFO - PROCESS | 19500 | Cycle 1(1): loaded http://localhost:48292/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48292/tests/kraken/driver.html?testName=json-parse-financial) 04:51:31 INFO - PROCESS | 19500 | RSS: Main: 246321152 04:51:31 INFO - PROCESS | 19500 | 04:51:32 INFO - PROCESS | 19500 | Cycle 1(1): loaded http://localhost:48292/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48292/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:51:33 INFO - PROCESS | 19500 | RSS: Main: 208703488 04:51:33 INFO - PROCESS | 19500 | 04:51:35 INFO - PROCESS | 19500 | Cycle 1(1): loaded http://localhost:48292/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48292/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:51:35 INFO - PROCESS | 19500 | RSS: Main: 216993792 04:51:35 INFO - PROCESS | 19500 | 04:51:38 INFO - PROCESS | 19500 | Cycle 1(1): loaded http://localhost:48292/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48292/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:51:38 INFO - PROCESS | 19500 | RSS: Main: 225755136 04:51:38 INFO - PROCESS | 19500 | 04:51:41 INFO - PROCESS | 19500 | Cycle 1(1): loaded http://localhost:48292/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48292/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:51:41 INFO - PROCESS | 19500 | RSS: Main: 234078208 04:51:41 INFO - PROCESS | 19500 | 04:51:44 INFO - PROCESS | 19500 | Cycle 1(1): loaded http://localhost:48292/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48292/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:51:45 INFO - PROCESS | 19500 | RSS: Main: 230887424 04:51:45 INFO - PROCESS | 19500 | 04:51:47 INFO - PROCESS | 19500 | Cycle 1(1): loaded http://localhost:48292/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48292/tests/kraken/driver.html?testName=ai-astar) 04:51:47 INFO - PROCESS | 19500 | RSS: Main: 282718208 04:51:47 INFO - PROCESS | 19500 | 04:51:47 INFO - PROCESS | 19500 | __start_tp_report 04:51:47 INFO - PROCESS | 19500 | _x_x_mozilla_page_load 04:51:47 INFO - PROCESS | 19500 | _x_x_mozilla_page_load_details 04:51:47 INFO - PROCESS | 19500 | |i|pagename|runs| 04:51:47 INFO - PROCESS | 19500 | |0;ai-astar;107;110;111;110;112;112;111;111;111;110 04:51:47 INFO - PROCESS | 19500 | |1;audio-beat-detection;150;121;122;156;126;124;134;121;158;124 04:51:47 INFO - PROCESS | 19500 | |2;audio-dft;161;162;161;162;161;162;162;161;163;163 04:51:47 INFO - PROCESS | 19500 | |3;audio-fft;76;75;79;113;76;76;75;76;97;76 04:51:47 INFO - PROCESS | 19500 | |4;audio-oscillator;84;83;118;83;83;83;111;84;81;123 04:51:47 INFO - PROCESS | 19500 | |5;imaging-gaussian-blur;117;124;117;117;117;117;117;117;117;118 04:51:47 INFO - PROCESS | 19500 | |6;imaging-darkroom;146;147;147;147;147;147;146;146;146;146 04:51:47 INFO - PROCESS | 19500 | |7;imaging-desaturate;85;85;85;84;85;85;85;84;85;84 04:51:47 INFO - PROCESS | 19500 | |8;json-parse-financial;53;51;52;52;52;54;54;54;54;54 04:51:47 INFO - PROCESS | 19500 | |9;json-stringify-tinderbox;61;61;61;60;61;60;61;61;60;60 04:51:47 INFO - PROCESS | 19500 | |10;stanford-crypto-aes;81;81;90;81;80;85;84;81;87;81 04:51:47 INFO - PROCESS | 19500 | |11;stanford-crypto-ccm;147;130;131;132;141;132;138;142;176;132 04:51:47 INFO - PROCESS | 19500 | |12;stanford-crypto-pbkdf2;171;167;169;173;167;170;176;170;171;169 04:51:47 INFO - PROCESS | 19500 | |13;stanford-crypto-sha256-iterative;66;69;67;66;66;65;64;68;64;66 04:51:47 INFO - PROCESS | 19500 | __end_tp_report 04:51:47 INFO - PROCESS | 19500 | __start_cc_report 04:51:47 INFO - PROCESS | 19500 | _x_x_mozilla_cycle_collect,1706 04:51:47 INFO - PROCESS | 19500 | __end_cc_report 04:51:47 INFO - PROCESS | 19500 | __startTimestamp1476964307370__endTimestamp 04:51:47 INFO - PROCESS | 19500 | 04:51:47 INFO - PROCESS | 19500 | ------- Summary: start ------- 04:51:47 INFO - PROCESS | 19500 | Number of tests: 14 04:51:47 INFO - PROCESS | 19500 | 04:51:47 INFO - PROCESS | 19500 | [#0] ai-astar Cycles:10 Average:110.50 Median:111.00 stddev:1.43 (1.3%) stddev-sans-first:0.78 04:51:47 INFO - PROCESS | 19500 | Values: 107.0 110.0 111.0 110.0 112.0 112.0 111.0 111.0 111.0 110.0 04:51:47 INFO - PROCESS | 19500 | 04:51:47 INFO - PROCESS | 19500 | [#1] audio-beat-detection Cycles:10 Average:133.60 Median:130.00 stddev:15.13 (11.6%) stddev-sans-first:14.84 04:51:47 INFO - PROCESS | 19500 | Values: 150.0 121.0 122.0 156.0 126.0 124.0 134.0 121.0 158.0 124.0 04:51:47 INFO - PROCESS | 19500 | 04:51:47 INFO - PROCESS | 19500 | [#2] audio-dft Cycles:10 Average:161.80 Median:162.00 stddev:0.79 (0.5%) stddev-sans-first:0.78 04:51:47 INFO - PROCESS | 19500 | Values: 161.0 162.0 161.0 162.0 161.0 162.0 162.0 161.0 163.0 163.0 04:51:47 INFO - PROCESS | 19500 | 04:51:47 INFO - PROCESS | 19500 | [#3] audio-fft Cycles:10 Average:81.90 Median:76.00 stddev:12.79 (16.8%) stddev-sans-first:13.39 04:51:47 INFO - PROCESS | 19500 | Values: 76.0 75.0 79.0 113.0 76.0 76.0 75.0 76.0 97.0 76.0 04:51:47 INFO - PROCESS | 19500 | 04:51:47 INFO - PROCESS | 19500 | [#4] audio-oscillator Cycles:10 Average:93.30 Median:83.00 stddev:16.85 (20.3%) stddev-sans-first:17.53 04:51:47 INFO - PROCESS | 19500 | Values: 84.0 83.0 118.0 83.0 83.0 83.0 111.0 84.0 81.0 123.0 04:51:47 INFO - PROCESS | 19500 | 04:51:47 INFO - PROCESS | 19500 | [#5] imaging-gaussian-blur Cycles:10 Average:117.80 Median:117.00 stddev:2.20 (1.9%) stddev-sans-first:2.32 04:51:47 INFO - PROCESS | 19500 | Values: 117.0 124.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 118.0 04:51:47 INFO - PROCESS | 19500 | 04:51:47 INFO - PROCESS | 19500 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:147.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 04:51:47 INFO - PROCESS | 19500 | Values: 146.0 147.0 147.0 147.0 147.0 147.0 146.0 146.0 146.0 146.0 04:51:47 INFO - PROCESS | 19500 | 04:51:47 INFO - PROCESS | 19500 | [#7] imaging-desaturate Cycles:10 Average:84.70 Median:85.00 stddev:0.48 (0.6%) stddev-sans-first:0.50 04:51:47 INFO - PROCESS | 19500 | Values: 85.0 85.0 85.0 84.0 85.0 85.0 85.0 84.0 85.0 84.0 04:51:47 INFO - PROCESS | 19500 | 04:51:47 INFO - PROCESS | 19500 | [#8] json-parse-financial Cycles:10 Average:53.00 Median:54.00 stddev:1.15 (2.1%) stddev-sans-first:1.22 04:51:47 INFO - PROCESS | 19500 | Values: 53.0 51.0 52.0 52.0 52.0 54.0 54.0 54.0 54.0 54.0 04:51:47 INFO - PROCESS | 19500 | 04:51:47 INFO - PROCESS | 19500 | [#9] json-stringify-tinderbox Cycles:10 Average:60.60 Median:61.00 stddev:0.52 (0.8%) stddev-sans-first:0.53 04:51:47 INFO - PROCESS | 19500 | Values: 61.0 61.0 61.0 60.0 61.0 60.0 61.0 61.0 60.0 60.0 04:51:47 INFO - PROCESS | 19500 | 04:51:47 INFO - PROCESS | 19500 | [#10] stanford-crypto-aes Cycles:10 Average:83.10 Median:82.50 stddev:3.31 (4.0%) stddev-sans-first:3.43 04:51:47 INFO - PROCESS | 19500 | Values: 81.0 81.0 90.0 81.0 80.0 85.0 84.0 81.0 87.0 81.0 04:51:47 INFO - PROCESS | 19500 | 04:51:47 INFO - PROCESS | 19500 | [#11] stanford-crypto-ccm Cycles:10 Average:140.10 Median:139.50 stddev:13.85 (9.9%) stddev-sans-first:14.47 04:51:47 INFO - PROCESS | 19500 | Values: 147.0 130.0 131.0 132.0 141.0 132.0 138.0 142.0 176.0 132.0 04:51:47 INFO - PROCESS | 19500 | 04:51:47 INFO - PROCESS | 19500 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.30 Median:170.50 stddev:2.71 (1.6%) stddev-sans-first:2.86 04:51:47 INFO - PROCESS | 19500 | Values: 171.0 167.0 169.0 173.0 167.0 170.0 176.0 170.0 171.0 169.0 04:51:47 INFO - PROCESS | 19500 | 04:51:47 INFO - PROCESS | 19500 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.10 Median:66.00 stddev:1.60 (2.4%) stddev-sans-first:1.69 04:51:47 INFO - PROCESS | 19500 | Values: 66.0 69.0 67.0 66.0 66.0 65.0 64.0 68.0 64.0 66.0 04:51:47 INFO - PROCESS | 19500 | -------- Summary: end -------- 04:51:47 INFO - PROCESS | 19500 | 04:51:48 INFO - TEST-INFO | 19500: exit 0 04:51:48 INFO - TEST-OK | kraken | took 61947ms 04:51:48 INFO - SUITE-END | took 1179s 04:51:49 INFO - Completed test suite (00:19:40) 04:51:49 INFO - javascript benchmark 04:51:49 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3028.515437529995, 3060.908172754818, 3090.0729781065684, 3104.2549788050874, 3107.39405815866, 5202.8699282517955, 5276.208568714695, 5322.095243808552, 5380.273663055486, 5421.186821976706, 5308.362996440423, 5313.654612450188, 5322.787088516455, 5331.2003199520095, 5340.279062326585, 4842.588379987706, 4859.829905953292, 4888.975555122237, 4921.335619691332, 4924.261360795891, 4864.805407783702, 4897.975510122462, 4931.926021109686, 4954.7522623868845, 4964.702117872939, 4962.40451145863, 4968.35411396518, 4971.4034315882145, 5015.448300686921, 5019.096562618727, 617.925217966772, 4930.112579735646, 4964.032013757283, 4966.130927087764, 5022.271770593262, 2987.0944480937915, 4836.613070954315, 4860.416749989989, 4887.486813884527, 4918.926216106761, 5271.683698978073, 5323.387810401815, 5327.840164795062, 5328.92006619901, 5332.600054995852, 5693.4875861172695, 5747.48272655463, 5770.365259821417, 5772.5703107846275, 5828.388019257959, 5602.635828671123, 5650.943490565124, 5655.688937108457, 5687.061634830289, 5783.190353350535, 5395.838124856261, 5410.648307859977, 5416.458354164552, 5417.702026388508, 5456.945430545684, 5892.852678683067, 5894.115882617642, 5895.587308888336, 5897.7935772247765, 5899.616524925866, 5517.310336207974, 5578.442155784389, 5578.832635020955, 5645.435456454322, 5664.037113690682, 5652.123920792284, 5712.542996560265, 5715.085586306171, 5719.828405147852, 5721.942780572224, 5686.3744988051285, 5691.430856914276, 5706.0, 5715.942840571541, 5720.599558030981, 5663.801766938137, 5700.3444603871085, 5715.142728590661, 5718.1708652246025, 5718.399568045378, 4367.497737760134, 4375.27807911691, 4380.759058251763, 4382.868513944587, 4385.780710964439, 3909.863154789569, 3921.7254792164845, 3924.823382947774, 3940.960590394059, 3999.860004899873, 5475.589330800126, 5476.069068258405, 5481.588880833953, 5484.972575137179, 5494.752736126884, 5721.799737009184, 5751.252337196138, 5799.88400231993, 5807.8548036299435, 5820.82537523875, 5250.238715386324, 5327.520523152934, 5335.733213339317, 5351.197320401893, 5411.56707463402, 4972.801087956441, 4975.925361119586, 4991.975040124848, 5005.34930459038, 5047.823326183639, 5926.703664816742, 5936.050231962865, 5938.524918006549, 5944.64332140073, 5945.672987985616, 5591.077472217201, 5626.88746225065, 5636.915446268391, 5750.051241545266, 5809.838032393623, 5852.5317974561085, 5885.617434866891, 5907.911381329198, 5929.377415371497, 5997.880042399215, 5645.1532270159805, 5651.124075768263, 5651.745671444713, 5657.32112146545, 5660.85847853807, 5576.86057848557, 5747.5689323300085, 5748.735278238781, 5750.568707347049, 5754.884902302014, 5443.863903402288, 5601.5238704710555, 5603.767171222325, 5609.691466969192, 5611.018071837494, 5537.335519737658, 5574.749136288958, 5598.580106491948, 5598.86002849932, 5600.747966341443, 5567.192757050286, 5572.4148964358155, 5575.358833734173, 5576.749046292845, 5588.720563971704, 5640.32316122068, 5658.122990936411, 5660.094384898396, 5666.914996275142, 5667.0, 5483.506484416422, 5510.366307874646, 5513.972430137824, 5514.751836167302, 5518.0], "value": 5245.493690138137, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [615.6306216270239, 633.4552285034869, 635.4662083849566, 655.698378745777, 657.2179106862833, 30640.846795766018, 41757.58242417575, 42661.360079598795, 42771.57228427715, 46142.30786538205, 43704.0, 44076.77961610196, 44092.0, 44203.778981105046, 44243.3363499547, 8140.308073813733, 8784.95607521963, 8947.597358118868, 8957.283417326631, 8963.058878817728, 8035.276825085741, 8385.0, 8385.077641459435, 10491.527881245323, 10741.462926853665, 10795.2443328967, 10845.620403285886, 10859.837102443431, 10861.294015888981, 10867.565297388135, 10625.574977000912, 10702.46487675613, 10716.73208169798, 10726.517306721216, 10742.033217010428, 10541.683749487527, 10605.893941060567, 10619.991100845407, 10620.150387968944, 10633.096186824052, 40016.59983400158, 40025.399619005446, 40091.39862902059, 40424.0, 40473.19053618911, 3132.0760375688997, 3180.8409579521162, 3216.0994921421807, 3402.6937575618067, 3525.6474352564796, 30643.540346894813, 31093.689063109305, 31147.84426077855, 31323.0, 31545.36909261802, 3992.920917099171, 4066.6340029397497, 4088.468499095128, 4138.772367519785, 4205.537390887, 289801.0, 290042.0, 290721.0, 290855.54572227213, 291764.0, 51367.7431612847, 51517.0, 51521.7423912878, 51550.22674659883, 51797.0, 33756.662433375845, 34911.0, 34946.126346841025, 35768.82115589405, 35802.64197358045, 12775.425105870258, 12940.417681204368, 12941.676458088436, 12945.352732363344, 12949.54676586315, 9565.904340956502, 9664.081912218327, 9676.371035882645, 9678.370905891095, 9703.320767546204, 16169.514914552583, 16635.251413686412, 17519.38682146144, 17849.910750446164, 18260.0, 6807.217170025411, 6813.659317034128, 7039.577625342496, 7144.7129124448575, 7150.892736608955, 853.9701110461104, 1045.1220974381556, 1046.2414749306693, 1069.3476979042778, 1124.2299025167786, 29865.850670746506, 30389.69610303913, 30648.540271895938, 31032.0, 31261.687383126333, 1015.243643485608, 1019.4087429291142, 1051.6897515233024, 1053.1732589916878, 1065.1212749481708, 15234.619134521725, 16371.590710232102, 16373.836261637469, 16375.0, 16609.67806438717, 468543.0, 468626.0, 469804.0, 470432.7740335591, 478582.0, 53675.0, 54063.72968135213, 54088.729556351966, 54163.45836541663, 54165.729171353894, 1207.879212078785, 1250.5560526013317, 1288.6134159752037, 1291.9806202907153, 1315.9210447373189, 27837.304067398476, 31362.21594460157, 31444.371112577162, 31666.208344791565, 31890.362192756478, 46128.769356153, 46130.53869461397, 46314.30528542007, 46426.0, 46550.30174547317, 332862.0, 333181.0, 333209.0, 334766.0, 335348.0, 25993.350166245997, 26207.4758504825, 27345.72654273432, 27394.315142121606, 28007.0, 44657.55342446664, 45406.545934540234, 45436.0, 45460.77269613631, 45754.0, 37946.8102659496, 38017.0, 38750.418743718306, 39845.40231896582, 40323.79838100791, 38000.429993549566, 38422.0, 38586.22827543489, 38776.80611596924, 39566.20867582575, 37852.0, 37961.0, 38552.614473856025, 38761.6123838758, 39272.60727392689, 32116.554755035613, 33890.66109338875, 34572.30855382929, 34627.65372346244, 34857.65142348544, 24065.269883168137, 24065.879670601535, 24211.515769684156, 24343.391415214763, 24758.752412475646], "value": 18796.36610077519, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [346.5581383735735, 362.84760400631717, 367.3772954841543, 367.5956447907302, 380.7030516197367, 13855.584332470029, 17455.82544174558, 17879.642407151867, 18978.051097445143, 19207.423777286705, 14187.645308867284, 14794.40822367104, 15765.290561924712, 15903.44337948172, 15987.360505579793, 5116.053530096935, 5306.442823503535, 5525.668459892399, 5555.166724991263, 5558.583106267026, 4021.718479706422, 4223.72545784523, 5447.210154527591, 5543.805966791163, 5869.295684517864, 6121.989871671191, 6168.1364608954555, 6168.352323006087, 6175.04286835539, 6198.0083186690135, 5348.224507446418, 5600.019996500596, 5641.323041235037, 5720.513756330717, 6181.783637572686, 5436.130219164954, 5488.204210389471, 5526.944730552724, 5533.059379905426, 5535.418781027975, 13375.398107085204, 14922.030068045542, 21747.347579572637, 22525.887370563043, 22591.435214119614, 2087.1338394566237, 2136.743590769118, 2276.8292378071546, 2543.682039745032, 2818.886539816761, 9673.129418352382, 9734.610615575368, 9842.803143937153, 10019.348742331726, 10203.744906377326, 1675.0954484578313, 1825.561865152367, 1847.8798878073017, 1932.3623204342534, 1968.8720233184797, 75507.62246188734, 76570.0, 76742.0, 78244.0, 79391.0, 9794.363366381305, 9849.753756156153, 9933.751656208653, 10340.844887326695, 10446.634367797242, 13995.86004139966, 14006.229657368738, 14037.649058773612, 14043.438262469386, 14045.78931316031, 6848.0, 7170.533915295593, 7230.710771569184, 7292.8906066409045, 7423.740169094056, 6689.76585819494, 6694.163229596301, 6905.75829845953, 6943.618101004493, 6950.652467376611, 4258.169656916872, 4390.714603550759, 4402.119576084732, 4513.977430112828, 4527.909441811145, 1765.6115654555977, 1852.4350073227795, 1869.5226878006897, 1877.0989924836156, 1880.2572983671373, 813.556611646654, 871.2246100970142, 907.9954600226956, 946.7396465971775, 947.6827210177859, 17255.066638671455, 18566.164522596515, 18802.0, 18973.90513047426, 19225.230990760494, 853.9573021348908, 883.9337049721297, 939.6664184214642, 962.711186644004, 1017.976933182162, 7024.438044956391, 10173.135283500837, 10261.230407719451, 10404.353968917303, 10498.47507624631, 441957.0, 447860.0, 448666.0, 449501.0, 449699.0, 87937.0, 88438.55780721056, 89660.5516972411, 90203.54898225467, 90642.54678726564, 969.340848223215, 990.935589186715, 1016.6441745389203, 1017.3234798858824, 1021.6066814276409, 14594.708105837612, 15609.297581608627, 15824.173627043861, 16228.756568651244, 16511.752323714914, 36887.0, 37091.0, 37934.8103259493, 38486.807565963114, 39132.608673912895, 49414.75292623514, 49744.502554975435, 51923.48076519187, 53204.0, 53991.73004135111, 7769.223077692412, 7809.687612495437, 7926.920730792618, 8099.514029158269, 8392.412531122764, 10987.0, 12561.87438125607, 12658.683532911751, 12947.352632368156, 13145.868541314465, 5878.735456904535, 10594.47027648599, 10981.20423672535, 11485.885141148481, 11599.014083802971, 10812.026917577456, 10835.133189344675, 10872.510737016695, 11014.39420831862, 11044.944775276072, 10834.620788272372, 11134.164937629548, 11185.88814111881, 11400.0, 11766.352850593299, 7935.40484463656, 7994.320482759031, 8080.393970452122, 8112.18878112184, 8324.500529968222, 8823.558822059, 10729.195310351599, 11091.778164436504, 11112.166587505808, 11150.665480035612], "value": 8559.186204110205, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1309.2798960571683, 1467.6771110355721, 1481.214956073281, 1483.799687042249, 1521.809773778277, 7559.622018899054, 8097.797555061126, 8105.230003149699, 8339.20777526134, 8357.0, 8507.234348908598, 8529.957350213255, 8533.786655333619, 8537.957310213456, 8546.871796923051, 2215.5125872308067, 2239.6640503924377, 2241.6301310283866, 2245.7978781909624, 2249.640057590786, 2179.6730490426403, 2215.8005779479845, 2228.186711850179, 2229.3869185973904, 2229.732432108141, 2141.8179454746364, 2166.7833216678364, 2213.5904857601313, 2221.2891874600136, 2231.665250212465, 2174.7281589801273, 2197.890105494727, 2201.2295696506176, 2202.218212534551, 2205.040807248836, 2165.2962787094257, 2169.5227050048966, 2173.0981642618294, 2176.5211653436218, 2178.2811672148155, 8387.287080598157, 8422.410431269813, 8442.662293508252, 8445.957770211171, 8451.23938845507, 4873.780679869415, 5032.220005899091, 5032.4967503249745, 5085.059264036128, 5096.311997880276, 3147.732442742347, 3332.4001679697644, 3354.2117602363423, 3370.8483118259737, 3375.0, 951.5432592355639, 977.9706608801747, 993.881882881758, 1007.2445665750687, 1011.519528224095, 12281.263124212575, 12301.815472767916, 12383.75232495354, 12395.132340736152, 12395.876041239562, 4315.09383029561, 4423.203823311835, 4468.173387923244, 4559.133764584718, 4610.53894610543, 9703.563339649732, 9710.126088652056, 9713.611455541699, 9713.70858874235, 9719.271054670928, 4907.803687852517, 4912.606991440676, 4916.188828843201, 4920.5571498565305, 4927.926081108714, 4077.857274995361, 4105.794710264475, 4138.689598280141, 4532.7280363178315, 4554.4990051094355, 3342.3148254607745, 3651.1419816343137, 3665.4318580620047, 3677.1542545214215, 3696.057505336176, 1046.895310468947, 1065.8347956066823, 1067.685032915292, 1070.5450183671908, 1071.27153535595, 858.0347109501811, 864.9913500865036, 868.8218915122385, 895.83427065993, 913.8583519554479, 5544.362398324163, 5680.801171958961, 5699.572532060112, 5799.39106393831, 5995.130706047598, 888.5201990924958, 889.3952112563519, 889.6530353162271, 919.8298314811648, 952.5903861339552, 3658.762180458315, 3819.3316169670197, 3862.8841134766003, 3879.650831425185, 3891.669208117285, 10849.891501085045, 11076.280041797258, 11239.775204495865, 11260.94369528147, 11270.09839212861, 11069.944650276697, 11080.944595277133, 11081.335119892832, 11086.334819910831, 11121.555137794398, 8090.514569125871, 8244.29923456501, 8244.917550824415, 8245.587720613825, 8248.711295104642, 5959.463648271676, 5989.8203053908455, 5990.820275391745, 6230.221222347207, 6299.370062993664, 9728.464934428674, 9777.657781977596, 9911.454869981932, 9939.0, 10266.948665256627, 8465.703700370705, 10310.948445257725, 10430.322029068086, 10464.215183861394, 10483.52824122901, 7075.433965282868, 7469.1037075551285, 7646.9617651911385, 7739.1100023495765, 7885.881711774443, 8443.8733419, 8457.788555286166, 8461.069282379056, 8546.2308392245, 8554.91445085541, 7518.436117291116, 7600.695972161052, 7661.310482056641, 7684.5773482459, 7742.341900938258, 7462.0, 7525.397968162643, 7594.468387212842, 7627.161012288533, 7858.960705196666, 6725.697343619451, 6835.7949261522235, 6856.588604683735, 6919.757808476679, 6990.685419156252, 4966.900661986812, 4983.8504844854715, 5056.84829455117, 5060.114479966065, 5170.844874653766, 4753.073150735711, 4821.132196204717, 4839.080574690797, 4852.320675105418, 4881.0], "value": 4446.283385834803, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [304.52038040086853, 314.8709029297988, 320.0622177021327, 322.2732737676539, 322.7724454259747, 5066.9493305066935, 5207.557357624597, 5213.66111202772, 5255.816046438375, 5257.763400646975, 5034.496550344964, 5153.278541004253, 5176.611754118438, 5186.896262074756, 5187.896242075156, 4063.0, 4077.918441631158, 4085.6527195188446, 4091.672666186713, 4099.836006559749, 3857.305684976703, 4059.8985025374304, 4099.385092236159, 4101.118259574191, 4117.711760176789, 3983.422403751454, 4002.019505221225, 4013.97993010036, 4017.3773065174946, 4031.8185681644395, 3982.342913419297, 4002.399640053986, 4007.8597249096433, 4015.8393664253686, 4028.482198625859, 3430.588329400488, 3526.188976535386, 3536.1159710072484, 3542.36237477254, 3560.928781424383, 5090.796368145269, 5092.618053645954, 5099.643024988252, 5113.897722045538, 5125.026245013435, 4616.930746038812, 4618.1918164321105, 4619.953800461986, 4630.120277147331, 4635.930461043087, 5317.787288508455, 5411.350637923435, 5426.945730542683, 5464.644798088151, 5479.0, 3872.380419132953, 3884.514435695538, 3893.863714769998, 3903.1998440319667, 3904.863329783472, 5623.325200975909, 5667.971660141714, 5681.630694004876, 5683.715814209273, 5686.715664216773, 3803.695704343646, 3937.9803100984313, 3968.761874287552, 3972.2254160439015, 3972.682185425159, 3994.800259986989, 3995.220931918306, 4002.1595464952684, 4006.0, 4015.3374693175297, 4592.97703511487, 4600.815967361335, 4608.700434471749, 4610.170169369479, 4610.631149508032, 5114.496569849591, 5478.780848766005, 5484.314460692413, 5498.8075417361, 5509.752061157257, 1337.3246510512324, 1377.9724405511834, 1383.4673650644575, 1387.2855479428104, 1397.4200706706806, 841.2386789955101, 868.3530769576706, 881.8324518341494, 884.4825776920574, 889.573004957624, 4665.880188754742, 4668.0, 4697.906041879143, 4719.244920812654, 4724.267738500538, 4918.336024636628, 4922.950770492249, 4943.209086546207, 4949.727764972961, 4951.777170027357, 4463.642908567372, 4658.883527911761, 4666.603338716247, 4688.929666055012, 4698.248280275139, 2632.7762140217915, 2651.57574788033, 2655.721149279298, 2656.3491944473726, 2667.346500107486, 5056.696598204119, 5066.316047333637, 5069.619778516626, 5074.5686616637995, 5087.720175390315, 4817.879553011133, 4978.108318838818, 5009.797648564391, 5012.621529079533, 5031.396232452129, 5034.974825125851, 5043.604287963188, 5053.393592768891, 5062.544371006627, 5082.119615742199, 4915.3855768029, 4920.0, 4926.48271931442, 4947.851564453073, 4954.702717836942, 4546.772661366852, 4749.952500475089, 4864.805407783649, 4883.8290659826735, 4909.239067944474, 4958.380202474691, 4995.275685025724, 5007.0472515718175, 5039.79045029183, 5129.743512824419, 3632.9818350908076, 3782.1868298315994, 3806.638369354907, 3871.2838124945847, 3873.1479074603544, 5526.778928842962, 5527.640703354269, 5527.972360138174, 5531.45119366578, 5538.723063846872, 5412.404635490172, 5423.322084739408, 5423.457654234545, 5432.511074003359, 5457.372402173642, 5173.81891633791, 5390.0, 5422.539084177732, 5431.456854314695, 5451.536619387238, 5316.893662126813, 5350.946490535045, 5361.437049109787, 5432.392451623322, 5432.918506222489, 5193.507615912285, 5363.865903352447, 5417.268668729671, 5429.809956651657, 5449.2371068049715, 5354.919676204938, 5386.892262154814, 5414.35027796667, 5417.43116972728, 5420.728963551728], "value": 3991.1762304270223, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [617.283950617284, 629.3611983836405, 629.5718911140423, 706.1667232665453, 725.2240103089696, 14029.719405611895, 14725.337359818806, 14754.704905901888, 14761.630959226024, 15668.0, 14929.477468288585, 15070.773938390932, 15132.697346053072, 15135.0, 15150.469733559328, 776.2974508070206, 801.2668408406302, 805.3557154276584, 805.8871757953891, 805.907320658126, 663.4460225711513, 680.8025672554953, 776.2470403708394, 794.9602519873984, 801.3348920396057, 850.2305413600701, 854.9230569248766, 857.4512312120248, 857.6483641706901, 857.6998050682242, 846.01861840265, 846.7586737779734, 846.7756044648204, 846.9534175620338, 847.6736456464275, 508.1640701046757, 520.1859090523357, 599.3077994915835, 610.0391882784587, 617.305531277313, 14831.70336593262, 14853.554393368217, 14875.47935822252, 14882.479113230986, 14885.255737213096, 13281.468741250339, 13606.183628982293, 13917.443302267897, 14146.36341364641, 14408.63978400538, 12575.811362829565, 12584.68538286541, 12653.936730316382, 12766.297853618047, 13358.064935454522, 4199.475065616798, 4217.810198541042, 4230.809613567397, 4373.890652733675, 4427.9557204427865, 57515.0, 57858.42141578573, 77317.61341193259, 80991.19008809836, 81496.0, 10753.139748820076, 10884.945575272073, 10971.341719496855, 10986.340819550853, 11040.33757974508, 20705.378838634864, 21122.366329010154, 21218.0, 21293.89353053225, 21363.786362136492, 7239.0, 7441.404687624977, 7552.735654252075, 7674.961625191839, 7680.3471704905705, 4263.296556068276, 4345.956540434555, 4412.580804823537, 4442.155990361885, 4480.215962206666, 3273.9836300818342, 3425.880094196691, 3426.3318652862454, 3431.330890476383, 3432.673895979878, 603.6559161278117, 606.9180660610849, 608.7025599269086, 622.5144387377852, 623.803501896901, 672.7544446277171, 685.2291172431015, 701.1340993872564, 726.6693654387241, 764.7211310295351, 9184.770380740534, 9190.540472976325, 9203.263738900872, 9407.247420206504, 9678.661246856327, 613.5521069619114, 700.6461736822973, 701.5019336271305, 704.429412176139, 708.3907839258234, 4119.423280740699, 4486.51944858196, 4500.167469018242, 4533.410656614619, 4567.314902764546, 117812.41093794476, 118391.0, 119416.40291798486, 120522.0, 121225.54485048194, 99498.8505976401, 100098.49162821096, 100989.45547450382, 101110.4944475273, 102176.0, 79241.0, 80191.19808801837, 81337.59331203424, 83874.0, 86814.0, 8326.583670816555, 8456.365772566958, 8560.614772335135, 8647.524386158822, 8819.250363719155, 51226.48773512217, 51400.74299628478, 52730.61771351937, 53306.73346633242, 53406.73296633492, 65672.6716366415, 77244.0, 77979.61010194913, 80397.59801200956, 81087.18912810796, 10468.842967355647, 10635.521401536795, 10890.346579205274, 11103.777924441305, 11387.772244554897, 12005.219660722025, 12620.55828046014, 13084.214947103204, 13237.669058273621, 13271.402786874807, 11197.949137410735, 12139.939300303442, 12315.13794034409, 12425.0, 12743.235405875677, 14188.787168192692, 14234.288285585886, 14593.85406145925, 14790.778138327718, 15120.621984450478, 13504.594862154152, 13761.38073786702, 14116.858831411555, 14139.929300353844, 14537.78193327122, 11063.778724425305, 11154.104060598534, 11489.195756296978, 11609.6517104487, 11750.35373054456, 12292.262464252173, 12348.876511234772, 12439.253644781342, 12636.810447843105, 12646.494140234288], "value": 7356.9624076622185, "unit": "score"}], "name": "dromaeo_css", "value": 6923.98079457258, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 110.0, 111.0, 110.0, 112.0, 112.0, 111.0, 111.0, 111.0, 110.0], "value": 110.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 121.0, 122.0, 156.0, 126.0, 124.0, 134.0, 121.0, 158.0, 124.0], "value": 133.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 161.0, 162.0, 161.0, 162.0, 162.0, 161.0, 163.0, 163.0], "value": 161.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 79.0, 113.0, 76.0, 76.0, 75.0, 76.0, 97.0, 76.0], "value": 81.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 118.0, 83.0, 83.0, 83.0, 111.0, 84.0, 81.0, 123.0], "value": 93.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 124.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0], "value": 117.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 147.0, 147.0, 147.0, 147.0, 146.0, 146.0, 146.0, 146.0], "value": 146.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 85.0, 84.0, 85.0, 85.0, 85.0, 84.0, 85.0, 84.0], "value": 84.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 51.0, 52.0, 52.0, 52.0, 54.0, 54.0, 54.0, 54.0, 54.0], "value": 53.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 61.0, 60.0, 61.0, 60.0, 61.0, 61.0, 60.0, 60.0], "value": 60.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 81.0, 90.0, 81.0, 80.0, 85.0, 84.0, 81.0, 87.0, 81.0], "value": 83.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 130.0, 131.0, 132.0, 141.0, 132.0, 138.0, 142.0, 176.0, 132.0], "value": 140.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 167.0, 169.0, 173.0, 167.0, 170.0, 176.0, 170.0, 171.0, 169.0], "value": 170.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 69.0, 67.0, 66.0, 66.0, 65.0, 64.0, 68.0, 64.0, 66.0], "value": 66.1, "unit": "score"}], "name": "kraken", "value": 1503.2999999999995, "alertThreshold": 2.0}]} 04:51:49 INFO - Return code: 0 04:51:49 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:51:49 INFO - # TBPL SUCCESS # 04:51:49 INFO - Running post-action listener: _resource_record_post_action 04:51:49 INFO - [mozharness: 2016-10-20 11:51:49.200573Z] Finished run-tests step (success) 04:51:49 INFO - Running post-run listener: _resource_record_post_run 04:51:49 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 4096; Write bytes: 398262272; Read time: 16; Write time: 261644 04:51:49 INFO - TinderboxPrint: CPU usage
13.1% 04:51:49 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 04:51:49 INFO - TinderboxPrint: I/O write bytes / time
398,262,272 / 261,644 04:51:49 INFO - TinderboxPrint: CPU idle
8,295.0 (86.8%) 04:51:49 INFO - TinderboxPrint: CPU user
1,203.9 (12.6%) 04:51:49 INFO - TinderboxPrint: Swap in / out
0 / 0 04:51:49 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 110891008; Read time: 0; Write time: 76744 04:51:49 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 0; Write bytes: 287371264; Read time: 0; Write time: 184900 04:51:49 INFO - Running post-run listener: _upload_blobber_files 04:51:49 INFO - Blob upload gear active. 04:51:49 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:51:49 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 04:51:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:51:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:51:50 INFO - (blobuploader) - INFO - Open directory for files ... 04:51:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:51:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:51:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:51:53 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:51:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:51:53 INFO - (blobuploader) - INFO - Done attempting. 04:51:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:51:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:51:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:51:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:51:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:51:54 INFO - (blobuploader) - INFO - Done attempting. 04:51:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:51:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:51:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:51:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:51:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:51:55 INFO - (blobuploader) - INFO - Done attempting. 04:51:55 INFO - (blobuploader) - INFO - Iteration through files over. 04:51:55 INFO - Return code: 0 04:51:55 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:51:55 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:51:55 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/548c13a3f47f74855ee41e11bbe82636183e31d3331914101d45dacb2468242a66e0773b81abcc82b5afc35d50ee0dbdb00b7e95354098b1524180861dbb4c7a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ac3e3a66eb7d9d0e97d03271d37a56358829d33afd4e686ac51bc2d1351f4706d7b7d4f7da2e9a930aac2dd254493f42bec722a071dfff8654e03817d74eb768", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0a8804d79d43161156138c3e29c4d6ef89d8b378f7f3c649ff3b78d1380fa1fe65f5199c93f05b1822179b1c3c833a2c07be6a3a1f3980b8bd175faf74cb9bdf"} 04:51:55 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:51:55 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:51:55 INFO - Contents: 04:51:55 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/548c13a3f47f74855ee41e11bbe82636183e31d3331914101d45dacb2468242a66e0773b81abcc82b5afc35d50ee0dbdb00b7e95354098b1524180861dbb4c7a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ac3e3a66eb7d9d0e97d03271d37a56358829d33afd4e686ac51bc2d1351f4706d7b7d4f7da2e9a930aac2dd254493f42bec722a071dfff8654e03817d74eb768", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0a8804d79d43161156138c3e29c4d6ef89d8b378f7f3c649ff3b78d1380fa1fe65f5199c93f05b1822179b1c3c833a2c07be6a3a1f3980b8bd175faf74cb9bdf"} 04:51:55 INFO - Running post-run listener: copy_logs_to_upload_dir 04:51:55 INFO - Copying logs to upload dir... 04:51:55 INFO - mkdir: /builds/slave/test/build/upload/logs 04:51:55 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.296693 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-10-20 04:51:54.804459) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-20 04:51:54.809064) ========= 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=8887e36bb8e381bfd44124ac000001a8-1476963072.416654-1117165592 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/548c13a3f47f74855ee41e11bbe82636183e31d3331914101d45dacb2468242a66e0773b81abcc82b5afc35d50ee0dbdb00b7e95354098b1524180861dbb4c7a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ac3e3a66eb7d9d0e97d03271d37a56358829d33afd4e686ac51bc2d1351f4706d7b7d4f7da2e9a930aac2dd254493f42bec722a071dfff8654e03817d74eb768", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0a8804d79d43161156138c3e29c4d6ef89d8b378f7f3c649ff3b78d1380fa1fe65f5199c93f05b1822179b1c3c833a2c07be6a3a1f3980b8bd175faf74cb9bdf"} build_url:https://queue.taskcluster.net/v1/task/Y9xWYVFLRECkYT6pd8IXnw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011420 build_url: 'https://queue.taskcluster.net/v1/task/Y9xWYVFLRECkYT6pd8IXnw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/548c13a3f47f74855ee41e11bbe82636183e31d3331914101d45dacb2468242a66e0773b81abcc82b5afc35d50ee0dbdb00b7e95354098b1524180861dbb4c7a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ac3e3a66eb7d9d0e97d03271d37a56358829d33afd4e686ac51bc2d1351f4706d7b7d4f7da2e9a930aac2dd254493f42bec722a071dfff8654e03817d74eb768", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0a8804d79d43161156138c3e29c4d6ef89d8b378f7f3c649ff3b78d1380fa1fe65f5199c93f05b1822179b1c3c833a2c07be6a3a1f3980b8bd175faf74cb9bdf"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-20 04:51:54.834571) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 04:51:54.834896) ========= 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=8887e36bb8e381bfd44124ac000001a8-1476963072.416654-1117165592 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004433 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 04:51:54.918480) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-20 04:51:54.918843) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-20 04:51:54.919130) ========= ========= Total master_lag: 0.20 =========