builder: larch_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-025 starttime: 1479330731.0 results: success (0) buildid: 20161116115308 builduid: 1497f4d1756d4f24abd0249dc8978a72 revision: 4de23d5b8758f314a92b3409087d6ba01ddb64dc ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-16 13:12:11.004772) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-16 13:12:11.005285) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-16 13:12:11.005677) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-16 13:12:11.160427) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-16 13:12:11.160708) ========= 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=232498196343f89f466a4a9a000001c8-1479329177.668491-1164925588 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-16 13:12:12-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 45.8M=0s 2016-11-16 13:12:12 (45.8 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.089082 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-16 13:12:11.275483) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-16 13:12:11.275812) ========= 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=232498196343f89f466a4a9a000001c8-1479329177.668491-1164925588 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020311 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-16 13:12:11.329160) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-16 13:12:11.329489) ========= bash -c 'python archiver_client.py mozharness --repo projects/larch --rev 4de23d5b8758f314a92b3409087d6ba01ddb64dc --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/larch --rev 4de23d5b8758f314a92b3409087d6ba01ddb64dc --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=232498196343f89f466a4a9a000001c8-1479329177.668491-1164925588 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-16 13:12:12,328 truncating revision to first 12 chars 2016-11-16 13:12:12,328 Setting DEBUG logging. 2016-11-16 13:12:12,328 attempt 1/10 2016-11-16 13:12:12,328 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/larch/4de23d5b8758?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-16 13:12:12,671 unpacking tar archive at: larch-4de23d5b8758/testing/mozharness/ program finished with exit code 0 elapsedTime=0.661247 ========= master_lag: 0.08 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-16 13:12:12.068957) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-16 13:12:12.069259) ========= script_repo_revision: 4de23d5b8758f314a92b3409087d6ba01ddb64dc ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-16 13:12:12.069655) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-16 13:12:12.069925) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-16 13:12:12.254960) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-11-16 13:12:12.255223) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Larch-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Larch-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Larch-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Larch-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=232498196343f89f466a4a9a000001c8-1479329177.668491-1164925588 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:12:13 INFO - MultiFileLogger online at 20161116 13:12:13 in /builds/slave/test 13:12:13 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Larch-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Larch-Non-PGO 13:12:13 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:12:13 INFO - {'append_to_log': False, 13:12:13 INFO - 'base_work_dir': '/builds/slave/test', 13:12:13 INFO - 'blob_upload_branch': 'Larch-Non-PGO', 13:12:13 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:12:13 INFO - 'branch': 'Larch-Non-PGO', 13:12:13 INFO - 'buildbot_json_path': 'buildprops.json', 13:12:13 INFO - 'config_files': ('talos/linux_config.py',), 13:12:13 INFO - 'default_actions': ('clobber', 13:12:13 INFO - 'read-buildbot-config', 13:12:13 INFO - 'download-and-extract', 13:12:13 INFO - 'populate-webroot', 13:12:13 INFO - 'create-virtualenv', 13:12:13 INFO - 'install', 13:12:13 INFO - 'run-tests'), 13:12:13 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:12:13 INFO - 'download_minidump_stackwalk': True, 13:12:13 INFO - 'download_symbols': 'ondemand', 13:12:13 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:12:13 INFO - 'tooltool.py': '/tools/tooltool.py', 13:12:13 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:12:13 INFO - '/tools/misc-python/virtualenv.py')}, 13:12:13 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:12:13 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:12:13 INFO - 'installer_path': 'installer.exe', 13:12:13 INFO - 'log_level': 'info', 13:12:13 INFO - 'log_name': 'talos', 13:12:13 INFO - 'log_to_console': True, 13:12:13 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:12:13 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:12:13 INFO - 'opt_config_files': (), 13:12:13 INFO - 'pip_index': False, 13:12:13 INFO - 'sps_profile': False, 13:12:13 INFO - 'sps_profile_interval': 0, 13:12:13 INFO - 'suite': 'dromaeojs', 13:12:13 INFO - 'system_bits': '32', 13:12:13 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:12:13 INFO - 'title': 'talos-linux64-ix-025', 13:12:13 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:12:13 INFO - 'use_talos_json': True, 13:12:13 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:12:13 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:12:13 INFO - 'work_dir': 'build'} 13:12:13 INFO - [mozharness: 2016-11-16 21:12:13.402379Z] Running clobber step. 13:12:13 INFO - Running pre-action listener: _resource_record_pre_action 13:12:13 INFO - Running main action method: clobber 13:12:13 INFO - rmtree: /builds/slave/test/build 13:12:13 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:12:14 INFO - Running post-action listener: _resource_record_post_action 13:12:14 INFO - [mozharness: 2016-11-16 21:12:14.380153Z] Finished clobber step (success) 13:12:14 INFO - [mozharness: 2016-11-16 21:12:14.380250Z] Running read-buildbot-config step. 13:12:14 INFO - Running pre-action listener: _resource_record_pre_action 13:12:14 INFO - Running main action method: read_buildbot_config 13:12:14 INFO - Using buildbot properties: 13:12:14 INFO - { 13:12:14 INFO - "project": "", 13:12:14 INFO - "product": "firefox", 13:12:14 INFO - "script_repo_revision": "production", 13:12:14 INFO - "builddir": "larch_ubuntu64_hw_test-dromaeojs", 13:12:14 INFO - "repository": "", 13:12:14 INFO - "buildername": "Ubuntu HW 12.04 x64 larch talos dromaeojs", 13:12:14 INFO - "buildid": "20161116115308", 13:12:14 INFO - "pgo_build": "False", 13:12:14 INFO - "basedir": "/builds/slave/test", 13:12:14 INFO - "buildnumber": 7, 13:12:14 INFO - "slavename": "talos-linux64-ix-025", 13:12:14 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 13:12:14 INFO - "platform": "ubuntu64_hw", 13:12:14 INFO - "scheduler": "tests-larch-linux64-talos", 13:12:14 INFO - "branch": "larch", 13:12:14 INFO - "repo_path": "projects/larch", 13:12:14 INFO - "revision": "4de23d5b8758f314a92b3409087d6ba01ddb64dc", 13:12:14 INFO - "stage_platform": "linux64", 13:12:14 INFO - "builduid": "1497f4d1756d4f24abd0249dc8978a72", 13:12:14 INFO - "slavebuilddir": "test" 13:12:14 INFO - } 13:12:14 INFO - Found installer url https://queue.taskcluster.net/v1/task/V88YIN3vQT-q01pw9WKF7g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 13:12:14 INFO - Running post-action listener: _resource_record_post_action 13:12:14 INFO - [mozharness: 2016-11-16 21:12:14.382639Z] Finished read-buildbot-config step (success) 13:12:14 INFO - [mozharness: 2016-11-16 21:12:14.382726Z] Running download-and-extract step. 13:12:14 INFO - Running pre-action listener: _resource_record_pre_action 13:12:14 INFO - Running main action method: download_and_extract 13:12:14 INFO - mkdir: /builds/slave/test/build/tests 13:12:14 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')]} 13:12:14 INFO - trying https://queue.taskcluster.net/v1/task/V88YIN3vQT-q01pw9WKF7g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 13:12:14 INFO - Downloading https://queue.taskcluster.net/v1/task/V88YIN3vQT-q01pw9WKF7g/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 13:12:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/V88YIN3vQT-q01pw9WKF7g/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 13:12:14 INFO - Downloaded 1361 bytes. 13:12:14 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 13:12:14 INFO - Using the following test package requirements: 13:12:14 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 13:12:14 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 13:12:14 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 13:12:14 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 13:12:14 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 13:12:14 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 13:12:14 INFO - u'jsshell-linux-x86_64.zip'], 13:12:14 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 13:12:14 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 13:12:14 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 13:12:14 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 13:12:14 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 13:12:14 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 13:12:14 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 13:12:14 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 13:12:14 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 13:12:14 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 13:12:14 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 13:12:14 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:12:14 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/V88YIN3vQT-q01pw9WKF7g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 13:12:14 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/V88YIN3vQT-q01pw9WKF7g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:12:14 INFO - Fetch https://queue.taskcluster.net/v1/task/V88YIN3vQT-q01pw9WKF7g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 13:12:15 INFO - Http code: 200 13:12:15 INFO - via: 1.1 23172d761378a3865feafcda78328053.cloudfront.net (CloudFront) 13:12:15 INFO - x-amz-cf-id: 7cPJch8cM3AOJ3kalHHP_unFObI_wyrSp-p6ZXnAmSpGceErD0QedA== 13:12:15 INFO - x-amz-version-id: YhNLxaWWNgGNer6WdihBRlifXVLwROn7 13:12:15 INFO - Expected file size: 20414097 13:12:15 INFO - Obtained file size: 20414097 13:12:19 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 13:12:19 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/V88YIN3vQT-q01pw9WKF7g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 13:12:19 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/V88YIN3vQT-q01pw9WKF7g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:12:19 INFO - Fetch https://queue.taskcluster.net/v1/task/V88YIN3vQT-q01pw9WKF7g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 13:12:20 INFO - Http code: 200 13:12:20 INFO - via: 1.1 ccaa055c9a26ce13da709353563e04a5.cloudfront.net (CloudFront) 13:12:20 INFO - x-amz-cf-id: aXItrGQfWfbDUnlcHxqUgcMgYQtyZ6uHW6oW05hYOB3nYf947Ou3Kw== 13:12:20 INFO - x-amz-version-id: YhNLxaWWNgGNer6WdihBRlifXVLwROn7 13:12:20 INFO - Expected file size: 20414097 13:12:20 INFO - Obtained file size: 20414097 13:12:25 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/V88YIN3vQT-q01pw9WKF7g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 13:12:25 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/V88YIN3vQT-q01pw9WKF7g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 13:12:25 INFO - Fetch https://queue.taskcluster.net/v1/task/V88YIN3vQT-q01pw9WKF7g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 13:12:25 INFO - Http code: 200 13:12:25 INFO - via: 1.1 ba26a6eef2785fa2e20e601890b882b2.cloudfront.net (CloudFront) 13:12:25 INFO - x-amz-cf-id: L_Qcp8bYQ1btAKZ3_BpzsmgQdU4ysOR0Xi4sf5NsR9Sk153H1zbavA== 13:12:25 INFO - x-amz-version-id: ecZAFdPixk2pQ3yiBGOiUu.Jy5IvP3jq 13:12:25 INFO - Expected file size: 14409038 13:12:25 INFO - Obtained file size: 14409038 13:12:26 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')]} 13:12:26 INFO - trying https://queue.taskcluster.net/v1/task/V88YIN3vQT-q01pw9WKF7g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 13:12:26 INFO - Downloading https://queue.taskcluster.net/v1/task/V88YIN3vQT-q01pw9WKF7g/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 13:12:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/V88YIN3vQT-q01pw9WKF7g/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 13:12:27 INFO - Downloaded 55755197 bytes. 13:12:27 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/V88YIN3vQT-q01pw9WKF7g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 13:12:27 INFO - mkdir: /builds/slave/test/properties 13:12:27 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:12:27 INFO - Writing to file /builds/slave/test/properties/build_url 13:12:27 INFO - Contents: 13:12:27 INFO - build_url:https://queue.taskcluster.net/v1/task/V88YIN3vQT-q01pw9WKF7g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 13:12:28 INFO - Running post-action listener: _resource_record_post_action 13:12:28 INFO - Running post-action listener: set_extra_try_arguments 13:12:28 INFO - [mozharness: 2016-11-16 21:12:28.616262Z] Finished download-and-extract step (success) 13:12:28 INFO - [mozharness: 2016-11-16 21:12:28.616487Z] Running populate-webroot step. 13:12:28 INFO - Running pre-action listener: _resource_record_pre_action 13:12:28 INFO - Running main action method: populate_webroot 13:12:28 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:12:28 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:12:28 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:12:28 INFO - '--tppagecycles', 13:12:28 INFO - '7'], 13:12:28 INFO - 'tests': ['tsvgm']}}, 13:12:28 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:12:28 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:12:28 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:12:28 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:12:28 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:12:28 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:12:28 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:12:28 INFO - 'talos_options': ['--disable-e10s'], 13:12:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:12:28 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:12:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:12:28 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:12:28 INFO - 'talos_options': ['--disable-e10s'], 13:12:28 INFO - 'tests': ['damp', 'tps']}, 13:12:28 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:12:28 INFO - 'tests': ['damp', 'tps']}, 13:12:28 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:12:28 INFO - 'tests': ['dromaeo_dom']}, 13:12:28 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:12:28 INFO - 'g4': {'talos_options': ['--disable-e10s'], 13:12:28 INFO - 'tests': ['basic_compositor_video']}, 13:12:28 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 13:12:28 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:12:28 INFO - 'tests': ['a11yr', 13:12:28 INFO - 'ts_paint', 13:12:28 INFO - 'tpaint', 13:12:28 INFO - 'sessionrestore', 13:12:28 INFO - 'sessionrestore_no_auto_restore', 13:12:28 INFO - 'tabpaint']}, 13:12:28 INFO - 'other-e10s': {'tests': ['a11yr', 13:12:28 INFO - 'ts_paint', 13:12:28 INFO - 'tpaint', 13:12:28 INFO - 'sessionrestore', 13:12:28 INFO - 'sessionrestore_no_auto_restore', 13:12:28 INFO - 'tabpaint']}, 13:12:28 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:12:28 INFO - 'ts_paint', 13:12:28 INFO - 'tpaint', 13:12:28 INFO - 'sessionrestore', 13:12:28 INFO - 'sessionrestore_no_auto_restore', 13:12:28 INFO - 'tabpaint']}, 13:12:28 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:12:28 INFO - 'ts_paint', 13:12:28 INFO - 'tpaint', 13:12:28 INFO - 'sessionrestore', 13:12:28 INFO - 'sessionrestore_no_auto_restore', 13:12:28 INFO - 'tabpaint']}, 13:12:28 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:12:28 INFO - 'tests': ['a11yr', 13:12:28 INFO - 'ts_paint', 13:12:28 INFO - 'tpaint', 13:12:28 INFO - 'sessionrestore', 13:12:28 INFO - 'sessionrestore_no_auto_restore', 13:12:28 INFO - 'tabpaint']}, 13:12:28 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:12:28 INFO - 'tests': ['a11yr', 13:12:28 INFO - 'ts_paint', 13:12:28 INFO - 'tpaint', 13:12:28 INFO - 'sessionrestore', 13:12:28 INFO - 'sessionrestore_no_auto_restore', 13:12:28 INFO - 'tabpaint']}, 13:12:28 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:12:28 INFO - 'tests': ['tsvgx', 13:12:28 INFO - 'tsvgr_opacity', 13:12:28 INFO - 'tart', 13:12:28 INFO - 'tscrollx', 13:12:28 INFO - 'cart']}, 13:12:28 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:12:28 INFO - 'tsvgr_opacity', 13:12:28 INFO - 'tart', 13:12:28 INFO - 'tscrollx', 13:12:28 INFO - 'cart']}, 13:12:28 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:12:28 INFO - 'talos_options': ['--disable-e10s'], 13:12:28 INFO - 'tests': ['tp5o']}, 13:12:28 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:12:28 INFO - 'tests': ['tp5o']}, 13:12:28 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:12:28 INFO - 'talos_options': ['--disable-e10s', 13:12:28 INFO - '--xperf_path', 13:12:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:12:28 INFO - 'tests': ['tp5n']}, 13:12:28 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:12:28 INFO - 'talos_options': ['--xperf_path', 13:12:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:12:28 INFO - 'tests': ['tp5n']}}, 13:12:28 INFO - 'talos.zip': {'path': '', 13:12:28 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:12:28 INFO - Running post-action listener: _resource_record_post_action 13:12:28 INFO - [mozharness: 2016-11-16 21:12:28.634284Z] Finished populate-webroot step (success) 13:12:28 INFO - [mozharness: 2016-11-16 21:12:28.634371Z] Running create-virtualenv step. 13:12:28 INFO - Running pre-action listener: _resource_record_pre_action 13:12:28 INFO - Running main action method: create_virtualenv 13:12:28 INFO - Creating virtualenv /builds/slave/test/build/venv 13:12:28 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 13:12:28 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:12:28 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:12:28 INFO - Using real prefix '/usr' 13:12:28 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:12:29 INFO - Installing distribute.............................................................................................................................................................................................done. 13:12:31 INFO - Installing pip.................done. 13:12:31 INFO - Return code: 0 13:12:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 13:12:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 13:12:31 INFO - Reading from file tmpfile_stdout 13:12:31 INFO - Output received: 13:12:31 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) 13:12:31 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:12:31 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')]} 13:12:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:12:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:12:31 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')]} 13:12:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:12:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:12:31 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 0x7f41b9903f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14e1ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14def60>, '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 0x14dfd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14e01d0>, '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': '232498196343f89f466a4a9a000001c8-1479329177.668491-1164925588', '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 13:12:31 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 13:12:31 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 13:12:31 INFO - Using env: {'DISPLAY': ':0', 13:12:31 INFO - 'HOME': '/home/cltbld', 13:12:31 INFO - 'LANG': 'en_US.UTF-8', 13:12:31 INFO - 'LANGUAGE': 'en_US:en', 13:12:31 INFO - 'LOGNAME': 'cltbld', 13:12:31 INFO - 'MAIL': '/var/mail/cltbld', 13:12:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:12:31 INFO - 'MOZ_NO_REMOTE': '1', 13:12:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:12:31 INFO - 'NO_EM_RESTART': '1', 13:12:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:12:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:12:31 INFO - 'PWD': '/builds/slave/test', 13:12:31 INFO - 'SHELL': '/bin/bash', 13:12:31 INFO - 'SHLVL': '1', 13:12:31 INFO - 'TERM': 'linux', 13:12:31 INFO - 'TMOUT': '86400', 13:12:31 INFO - 'USER': 'cltbld', 13:12:31 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1479329177.668491-1164925588', 13:12:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:12:31 INFO - '_': '/tools/buildbot/bin/python'} 13:12:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:12:31 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 13:12:31 INFO - Cleaning up... 13:12:31 INFO - Return code: 0 13:12:31 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:12:31 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')]} 13:12:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:12:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:12:31 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')]} 13:12:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:12:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:12:31 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 0x7f41b9903f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14e1ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14def60>, '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 0x14dfd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14e01d0>, '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': '232498196343f89f466a4a9a000001c8-1479329177.668491-1164925588', '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 13:12:31 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 13:12:31 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 13:12:31 INFO - Using env: {'DISPLAY': ':0', 13:12:31 INFO - 'HOME': '/home/cltbld', 13:12:31 INFO - 'LANG': 'en_US.UTF-8', 13:12:31 INFO - 'LANGUAGE': 'en_US:en', 13:12:31 INFO - 'LOGNAME': 'cltbld', 13:12:31 INFO - 'MAIL': '/var/mail/cltbld', 13:12:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:12:31 INFO - 'MOZ_NO_REMOTE': '1', 13:12:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:12:31 INFO - 'NO_EM_RESTART': '1', 13:12:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:12:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:12:31 INFO - 'PWD': '/builds/slave/test', 13:12:31 INFO - 'SHELL': '/bin/bash', 13:12:31 INFO - 'SHLVL': '1', 13:12:31 INFO - 'TERM': 'linux', 13:12:31 INFO - 'TMOUT': '86400', 13:12:31 INFO - 'USER': 'cltbld', 13:12:31 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1479329177.668491-1164925588', 13:12:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:12:31 INFO - '_': '/tools/buildbot/bin/python'} 13:12:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:12:31 INFO - Downloading/unpacking psutil>=3.1.1 13:12:31 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 13:12:31 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 13:12:31 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 13:12:31 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 13:12:31 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 13:12:31 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 13:12:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:12:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:12:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:12:33 INFO - Installing collected packages: psutil 13:12:33 INFO - Running setup.py install for psutil 13:12:33 INFO - building 'psutil._psutil_linux' extension 13:12:33 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 13:12: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 13:12:34 INFO - building 'psutil._psutil_posix' extension 13:12: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 13:12: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_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 13:12:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:12:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:12:34 INFO - Successfully installed psutil 13:12:34 INFO - Cleaning up... 13:12:34 INFO - Return code: 0 13:12:34 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:12:34 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')]} 13:12:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:12:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:12:34 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')]} 13:12:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:12:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:12:34 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 0x7f41b9903f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14e1ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14def60>, '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 0x14dfd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14e01d0>, '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': '232498196343f89f466a4a9a000001c8-1479329177.668491-1164925588', '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 13:12:34 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 13:12:34 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 13:12:34 INFO - Using env: {'DISPLAY': ':0', 13:12:34 INFO - 'HOME': '/home/cltbld', 13:12:34 INFO - 'LANG': 'en_US.UTF-8', 13:12:34 INFO - 'LANGUAGE': 'en_US:en', 13:12:34 INFO - 'LOGNAME': 'cltbld', 13:12:34 INFO - 'MAIL': '/var/mail/cltbld', 13:12:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:12:34 INFO - 'MOZ_NO_REMOTE': '1', 13:12:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:12:34 INFO - 'NO_EM_RESTART': '1', 13:12:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:12:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:12:34 INFO - 'PWD': '/builds/slave/test', 13:12:34 INFO - 'SHELL': '/bin/bash', 13:12:34 INFO - 'SHLVL': '1', 13:12:34 INFO - 'TERM': 'linux', 13:12:34 INFO - 'TMOUT': '86400', 13:12:34 INFO - 'USER': 'cltbld', 13:12:34 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1479329177.668491-1164925588', 13:12:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:12:34 INFO - '_': '/tools/buildbot/bin/python'} 13:12:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:12:34 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:12:34 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 13:12:34 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 13:12:34 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 13:12:34 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 13:12:34 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 13:12:34 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 13:12:36 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:12:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:12:36 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:12:36 INFO - Installing collected packages: mozsystemmonitor 13:12:36 INFO - Running setup.py install for mozsystemmonitor 13:12:36 INFO - Successfully installed mozsystemmonitor 13:12:36 INFO - Cleaning up... 13:12:36 INFO - Return code: 0 13:12:36 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:12:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:12:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:12:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:12:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:12:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:12:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:12:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f41b9903f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14e1ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14def60>, '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 0x14dfd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14e01d0>, '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': '232498196343f89f466a4a9a000001c8-1479329177.668491-1164925588', '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 13:12:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 13:12:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 13:12:36 INFO - Using env: {'DISPLAY': ':0', 13:12:36 INFO - 'HOME': '/home/cltbld', 13:12:36 INFO - 'LANG': 'en_US.UTF-8', 13:12:36 INFO - 'LANGUAGE': 'en_US:en', 13:12:36 INFO - 'LOGNAME': 'cltbld', 13:12:36 INFO - 'MAIL': '/var/mail/cltbld', 13:12:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:12:36 INFO - 'MOZ_NO_REMOTE': '1', 13:12:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:12:36 INFO - 'NO_EM_RESTART': '1', 13:12:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:12:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:12:36 INFO - 'PWD': '/builds/slave/test', 13:12:36 INFO - 'SHELL': '/bin/bash', 13:12:36 INFO - 'SHLVL': '1', 13:12:36 INFO - 'TERM': 'linux', 13:12:36 INFO - 'TMOUT': '86400', 13:12:36 INFO - 'USER': 'cltbld', 13:12:36 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1479329177.668491-1164925588', 13:12:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:12:36 INFO - '_': '/tools/buildbot/bin/python'} 13:12:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:12:36 INFO - Downloading/unpacking jsonschema==2.5.1 13:12:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:12:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:12:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:12:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:12:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:12:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:12:38 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:12:38 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:12:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:12:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:12:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:12:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:12:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:12:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:12:39 INFO - Downloading functools32-3.2.3-2.tar.gz 13:12:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:12:39 INFO - warning: no files found matching '*.txt' 13:12:39 INFO - no previously-included directories found matching 'build' 13:12:39 INFO - no previously-included directories found matching 'dist' 13:12:39 INFO - no previously-included directories found matching '.git*' 13:12:39 INFO - Installing collected packages: jsonschema, functools32 13:12:39 INFO - Running setup.py install for functools32 13:12:39 INFO - warning: no files found matching '*.txt' 13:12:39 INFO - no previously-included directories found matching 'build' 13:12:39 INFO - no previously-included directories found matching 'dist' 13:12:39 INFO - no previously-included directories found matching '.git*' 13:12:39 INFO - Successfully installed jsonschema functools32 13:12:39 INFO - Cleaning up... 13:12:39 INFO - Return code: 0 13:12:39 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 13:12:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:12:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:12:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:12:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:12:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:12:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:12:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f41b9903f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14e1ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14def60>, '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 0x14dfd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14e01d0>, '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': '232498196343f89f466a4a9a000001c8-1479329177.668491-1164925588', '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 13:12:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 13:12:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 13:12:39 INFO - Using env: {'DISPLAY': ':0', 13:12:39 INFO - 'HOME': '/home/cltbld', 13:12:39 INFO - 'LANG': 'en_US.UTF-8', 13:12:39 INFO - 'LANGUAGE': 'en_US:en', 13:12:39 INFO - 'LOGNAME': 'cltbld', 13:12:39 INFO - 'MAIL': '/var/mail/cltbld', 13:12:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:12:39 INFO - 'MOZ_NO_REMOTE': '1', 13:12:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:12:39 INFO - 'NO_EM_RESTART': '1', 13:12:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:12:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:12:39 INFO - 'PWD': '/builds/slave/test', 13:12:39 INFO - 'SHELL': '/bin/bash', 13:12:39 INFO - 'SHLVL': '1', 13:12:39 INFO - 'TERM': 'linux', 13:12:39 INFO - 'TMOUT': '86400', 13:12:39 INFO - 'USER': 'cltbld', 13:12:39 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1479329177.668491-1164925588', 13:12:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:12:39 INFO - '_': '/tools/buildbot/bin/python'} 13:12:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:12:39 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 13:12:39 INFO - Cleaning up... 13:12:39 INFO - Return code: 0 13:12:39 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:12:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:12:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:12:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:12:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:12:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:12:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:12:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f41b9903f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14e1ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14def60>, '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 0x14dfd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14e01d0>, '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': '232498196343f89f466a4a9a000001c8-1479329177.668491-1164925588', '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 13:12:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 13:12:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 13:12:39 INFO - Using env: {'DISPLAY': ':0', 13:12:39 INFO - 'HOME': '/home/cltbld', 13:12:39 INFO - 'LANG': 'en_US.UTF-8', 13:12:39 INFO - 'LANGUAGE': 'en_US:en', 13:12:39 INFO - 'LOGNAME': 'cltbld', 13:12:39 INFO - 'MAIL': '/var/mail/cltbld', 13:12:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:12:39 INFO - 'MOZ_NO_REMOTE': '1', 13:12:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:12:39 INFO - 'NO_EM_RESTART': '1', 13:12:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:12:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:12:39 INFO - 'PWD': '/builds/slave/test', 13:12:39 INFO - 'SHELL': '/bin/bash', 13:12:39 INFO - 'SHLVL': '1', 13:12:39 INFO - 'TERM': 'linux', 13:12:39 INFO - 'TMOUT': '86400', 13:12:39 INFO - 'USER': 'cltbld', 13:12:39 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1479329177.668491-1164925588', 13:12:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:12:39 INFO - '_': '/tools/buildbot/bin/python'} 13:12:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:12:39 INFO - Downloading/unpacking blobuploader==1.2.4 13:12: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 13:12: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 13:12: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 13:12: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 13:12: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 13:12: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 13:12:41 INFO - Downloading blobuploader-1.2.4.tar.gz 13:12:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:12:41 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:12:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:12:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:12:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:12:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:12:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:12:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:12:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:12:42 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:12: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 13:12: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 13:12: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 13:12: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 13:12: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 13:12: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 13:12:42 INFO - Downloading docopt-0.6.1.tar.gz 13:12:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:12:42 INFO - Installing collected packages: blobuploader, requests, docopt 13:12:42 INFO - Running setup.py install for blobuploader 13:12:42 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:12:42 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:12:42 INFO - Running setup.py install for requests 13:12:42 INFO - Running setup.py install for docopt 13:12:43 INFO - Successfully installed blobuploader requests docopt 13:12:43 INFO - Cleaning up... 13:12:43 INFO - Return code: 0 13:12:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:12: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')]} 13:12:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:12:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:12: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')]} 13:12:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:12:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:12: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 0x7f41b9903f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14e1ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14def60>, '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 0x14dfd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14e01d0>, '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': '232498196343f89f466a4a9a000001c8-1479329177.668491-1164925588', '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 13:12: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 13:12: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 13:12:43 INFO - Using env: {'DISPLAY': ':0', 13:12:43 INFO - 'HOME': '/home/cltbld', 13:12:43 INFO - 'LANG': 'en_US.UTF-8', 13:12:43 INFO - 'LANGUAGE': 'en_US:en', 13:12:43 INFO - 'LOGNAME': 'cltbld', 13:12:43 INFO - 'MAIL': '/var/mail/cltbld', 13:12:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:12:43 INFO - 'MOZ_NO_REMOTE': '1', 13:12:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:12:43 INFO - 'NO_EM_RESTART': '1', 13:12:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:12:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:12:43 INFO - 'PWD': '/builds/slave/test', 13:12:43 INFO - 'SHELL': '/bin/bash', 13:12:43 INFO - 'SHLVL': '1', 13:12:43 INFO - 'TERM': 'linux', 13:12:43 INFO - 'TMOUT': '86400', 13:12:43 INFO - 'USER': 'cltbld', 13:12:43 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1479329177.668491-1164925588', 13:12:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:12:43 INFO - '_': '/tools/buildbot/bin/python'} 13:12:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:12:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:12:43 INFO - Running setup.py (path:/tmp/pip-1mDokv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:12:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:12:43 INFO - Running setup.py (path:/tmp/pip-SpGsvU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:12:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:12:43 INFO - Running setup.py (path:/tmp/pip-Hm3JNE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:12:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:12:43 INFO - Running setup.py (path:/tmp/pip-dThkWH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:12:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:12:43 INFO - Running setup.py (path:/tmp/pip-I6TQk1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:12:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:12:43 INFO - Running setup.py (path:/tmp/pip-8IkfoG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:12:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:12:43 INFO - Running setup.py (path:/tmp/pip-ZMcYRP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:12:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:12:43 INFO - Running setup.py (path:/tmp/pip-MBIagt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:12:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:12:43 INFO - Running setup.py (path:/tmp/pip-RdupCX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:12:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:12:44 INFO - Running setup.py (path:/tmp/pip-VB6N_x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:12:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:12:44 INFO - Running setup.py (path:/tmp/pip-SqIkQn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:12:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:12:44 INFO - Running setup.py (path:/tmp/pip-iQSvBp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:12:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:12:44 INFO - Running setup.py (path:/tmp/pip-WgOoT6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:12:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:12:44 INFO - Running setup.py (path:/tmp/pip-gTskPQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:12:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:12:44 INFO - Running setup.py (path:/tmp/pip-Nq3L4W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:12:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:12:44 INFO - Running setup.py (path:/tmp/pip-5XWeOo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:12:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:12:44 INFO - Running setup.py (path:/tmp/pip-kxAKke-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:12:44 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:12:44 INFO - Running setup.py install for manifestparser 13:12:44 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:12:44 INFO - Running setup.py install for mozcrash 13:12:44 INFO - Running setup.py install for mozdebug 13:12:44 INFO - Running setup.py install for mozdevice 13:12:44 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:12:44 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:12:45 INFO - Running setup.py install for mozfile 13:12:45 INFO - Running setup.py install for mozhttpd 13:12:45 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:12:45 INFO - Running setup.py install for mozinfo 13:12:45 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:12:45 INFO - Running setup.py install for mozInstall 13:12:45 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:12:45 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:12:45 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:12:45 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:12:45 INFO - Running setup.py install for mozleak 13:12:45 INFO - Running setup.py install for mozlog 13:12:45 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:12:45 INFO - Running setup.py install for moznetwork 13:12:45 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:12:45 INFO - Running setup.py install for mozprocess 13:12:45 INFO - Running setup.py install for mozprofile 13:12:45 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:12:45 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:12:45 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:12:45 INFO - Running setup.py install for mozrunner 13:12:46 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:12:46 INFO - Running setup.py install for mozscreenshot 13:12:46 INFO - Running setup.py install for moztest 13:12:46 INFO - Running setup.py install for mozversion 13:12:46 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:12:46 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:12:46 INFO - Cleaning up... 13:12:46 INFO - Return code: 0 13:12:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:12:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:12:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:12:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:12:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:12:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:12:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:12:46 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 0x7f41b9903f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14e1ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14def60>, '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 0x14dfd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14e01d0>, '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': '232498196343f89f466a4a9a000001c8-1479329177.668491-1164925588', '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 13:12:46 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 13:12:46 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 13:12:46 INFO - Using env: {'DISPLAY': ':0', 13:12:46 INFO - 'HOME': '/home/cltbld', 13:12:46 INFO - 'LANG': 'en_US.UTF-8', 13:12:46 INFO - 'LANGUAGE': 'en_US:en', 13:12:46 INFO - 'LOGNAME': 'cltbld', 13:12:46 INFO - 'MAIL': '/var/mail/cltbld', 13:12:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:12:46 INFO - 'MOZ_NO_REMOTE': '1', 13:12:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:12:46 INFO - 'NO_EM_RESTART': '1', 13:12:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:12:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:12:46 INFO - 'PWD': '/builds/slave/test', 13:12:46 INFO - 'SHELL': '/bin/bash', 13:12:46 INFO - 'SHLVL': '1', 13:12:46 INFO - 'TERM': 'linux', 13:12:46 INFO - 'TMOUT': '86400', 13:12:46 INFO - 'USER': 'cltbld', 13:12:46 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1479329177.668491-1164925588', 13:12:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:12:46 INFO - '_': '/tools/buildbot/bin/python'} 13:12:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:12:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:12:46 INFO - Running setup.py (path:/tmp/pip-97l5xc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:12:46 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)) 13:12:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:12:46 INFO - Running setup.py (path:/tmp/pip-Yg53HV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:12:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:12:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:12:46 INFO - Running setup.py (path:/tmp/pip-BM6utK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:12:46 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)) 13:12:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:12:46 INFO - Running setup.py (path:/tmp/pip-IegFz4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:12:46 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)) 13:12:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:12:46 INFO - Running setup.py (path:/tmp/pip-wTPC6r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:12:46 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)) 13:12:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:12:46 INFO - Running setup.py (path:/tmp/pip-ZqyyOt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:12: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)) 13:12:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:12:47 INFO - Running setup.py (path:/tmp/pip-Jmkgxj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:12: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)) 13:12:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:12:47 INFO - Running setup.py (path:/tmp/pip-lIchjK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:12: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)) 13:12:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:12:47 INFO - Running setup.py (path:/tmp/pip-J1CNI_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:12:47 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)) 13:12:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:12:47 INFO - Running setup.py (path:/tmp/pip-HX4yam-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:12:47 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)) 13:12:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:12:47 INFO - Running setup.py (path:/tmp/pip-F9RnfQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:12:47 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)) 13:12:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:12:47 INFO - Running setup.py (path:/tmp/pip-q9HqAO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:12:47 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)) 13:12:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:12:47 INFO - Running setup.py (path:/tmp/pip-IOuBD1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:12:47 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)) 13:12:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:12:47 INFO - Running setup.py (path:/tmp/pip-NHsNtc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:12:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 13:12:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:12:47 INFO - Running setup.py (path:/tmp/pip-0wmHaB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:12:47 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)) 13:12:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:12:47 INFO - Running setup.py (path:/tmp/pip-3v0YR_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:12:47 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)) 13:12:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:12:47 INFO - Running setup.py (path:/tmp/pip-i0izGs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:12:47 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)) 13:12:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:12:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:12:47 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)) 13:12:47 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)) 13:12:47 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)) 13:12:47 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:12:47 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 13:12:47 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 13:12:47 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 13:12:47 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 13:12:47 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 13:12:47 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 13:12:49 INFO - Downloading blessings-1.6.tar.gz 13:12:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:12:49 INFO - Installing collected packages: blessings 13:12:49 INFO - Running setup.py install for blessings 13:12:49 INFO - Successfully installed blessings 13:12:49 INFO - Cleaning up... 13:12:50 INFO - Return code: 0 13:12:50 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:12:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:12:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:12:50 INFO - Reading from file tmpfile_stdout 13:12:50 INFO - Current package versions: 13:12:50 INFO - argparse == 1.2.1 13:12:50 INFO - blessings == 1.6 13:12:50 INFO - blobuploader == 1.2.4 13:12:50 INFO - docopt == 0.6.1 13:12:50 INFO - functools32 == 3.2.3-2 13:12:50 INFO - jsonschema == 2.5.1 13:12:50 INFO - manifestparser == 1.1 13:12:50 INFO - mozInstall == 1.12 13:12:50 INFO - mozcrash == 1.0 13:12:50 INFO - mozdebug == 0.1 13:12:50 INFO - mozdevice == 0.48 13:12:50 INFO - mozfile == 1.2 13:12:50 INFO - mozhttpd == 0.7 13:12:50 INFO - mozinfo == 0.9 13:12:50 INFO - mozleak == 0.1 13:12:50 INFO - mozlog == 3.4 13:12:50 INFO - moznetwork == 0.27 13:12:50 INFO - mozprocess == 0.23 13:12:50 INFO - mozprofile == 0.28 13:12:50 INFO - mozrunner == 6.13 13:12:50 INFO - mozscreenshot == 0.1 13:12:50 INFO - mozsystemmonitor == 0.3 13:12:50 INFO - moztest == 0.7 13:12:50 INFO - mozversion == 1.4 13:12:50 INFO - psutil == 3.1.1 13:12:50 INFO - requests == 1.2.3 13:12:50 INFO - wsgiref == 0.1.2 13:12:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:12:50 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')]} 13:12:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:12:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:12:50 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')]} 13:12:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:12:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:12:50 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 0x7f41b9903f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14e1ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14def60>, '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 0x14dfd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14e01d0>, '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': '232498196343f89f466a4a9a000001c8-1479329177.668491-1164925588', '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 13:12:50 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 13:12:50 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 13:12:50 INFO - Using env: {'DISPLAY': ':0', 13:12:50 INFO - 'HOME': '/home/cltbld', 13:12:50 INFO - 'LANG': 'en_US.UTF-8', 13:12:50 INFO - 'LANGUAGE': 'en_US:en', 13:12:50 INFO - 'LOGNAME': 'cltbld', 13:12:50 INFO - 'MAIL': '/var/mail/cltbld', 13:12:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:12:50 INFO - 'MOZ_NO_REMOTE': '1', 13:12:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:12:50 INFO - 'NO_EM_RESTART': '1', 13:12:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:12:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:12:50 INFO - 'PWD': '/builds/slave/test', 13:12:50 INFO - 'SHELL': '/bin/bash', 13:12:50 INFO - 'SHLVL': '1', 13:12:50 INFO - 'TERM': 'linux', 13:12:50 INFO - 'TMOUT': '86400', 13:12:50 INFO - 'USER': 'cltbld', 13:12:50 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1479329177.668491-1164925588', 13:12:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:12:50 INFO - '_': '/tools/buildbot/bin/python'} 13:12:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:12:50 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)) 13:12:50 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)) 13:12:50 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)) 13:12:50 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)) 13:12:50 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)) 13:12:50 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)) 13:12:50 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)) 13:12:50 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)) 13:12:50 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)) 13:12:50 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)) 13:12:50 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)) 13:12:50 INFO - Cleaning up... 13:12:50 INFO - Return code: 0 13:12:50 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:12:50 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')]} 13:12:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:12:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:12:50 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')]} 13:12:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:12:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:12:50 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 0x7f41b9903f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14e1ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14def60>, '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 0x14dfd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14e01d0>, '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': '232498196343f89f466a4a9a000001c8-1479329177.668491-1164925588', '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 13:12:50 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 13:12:50 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 13:12:50 INFO - Using env: {'DISPLAY': ':0', 13:12:50 INFO - 'HOME': '/home/cltbld', 13:12:50 INFO - 'LANG': 'en_US.UTF-8', 13:12:50 INFO - 'LANGUAGE': 'en_US:en', 13:12:50 INFO - 'LOGNAME': 'cltbld', 13:12:50 INFO - 'MAIL': '/var/mail/cltbld', 13:12:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:12:50 INFO - 'MOZ_NO_REMOTE': '1', 13:12:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:12:50 INFO - 'NO_EM_RESTART': '1', 13:12:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:12:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:12:50 INFO - 'PWD': '/builds/slave/test', 13:12:50 INFO - 'SHELL': '/bin/bash', 13:12:50 INFO - 'SHLVL': '1', 13:12:50 INFO - 'TERM': 'linux', 13:12:50 INFO - 'TMOUT': '86400', 13:12:50 INFO - 'USER': 'cltbld', 13:12:50 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1479329177.668491-1164925588', 13:12:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:12:50 INFO - '_': '/tools/buildbot/bin/python'} 13:12:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:12:50 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:12:50 INFO - Cleaning up... 13:12:50 INFO - Return code: 0 13:12:50 INFO - Running post-action listener: _resource_record_post_action 13:12:50 INFO - Running post-action listener: _start_resource_monitoring 13:12:50 INFO - Starting resource monitoring. 13:12:50 INFO - [mozharness: 2016-11-16 21:12:50.721022Z] Finished create-virtualenv step (success) 13:12:50 INFO - [mozharness: 2016-11-16 21:12:50.721526Z] Running install step. 13:12:50 INFO - Running pre-action listener: _resource_record_pre_action 13:12:50 INFO - Running main action method: install 13:12:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:12:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:12:50 INFO - Reading from file tmpfile_stdout 13:12:50 INFO - Detecting whether we're running mozinstall >=1.0... 13:12:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:12:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:12:51 INFO - Reading from file tmpfile_stdout 13:12:51 INFO - Output received: 13:12:51 INFO - Usage: mozinstall [options] installer 13:12:51 INFO - Options: 13:12:51 INFO - -h, --help show this help message and exit 13:12:51 INFO - -d DEST, --destination=DEST 13:12:51 INFO - Directory to install application into. [default: 13:12:51 INFO - "/builds/slave/test"] 13:12:51 INFO - --app=APP Application being installed. [default: firefox] 13:12:51 INFO - mkdir: /builds/slave/test/build/application 13:12: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'] 13:12: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 13:13:07 INFO - Reading from file tmpfile_stdout 13:13:07 INFO - Output received: 13:13:07 INFO - /builds/slave/test/build/application/firefox/firefox 13:13:07 INFO - Running post-action listener: _resource_record_post_action 13:13:07 INFO - [mozharness: 2016-11-16 21:13:07.088629Z] Finished install step (success) 13:13:07 INFO - [mozharness: 2016-11-16 21:13:07.088870Z] Running run-tests step. 13:13:07 INFO - Running pre-action listener: _resource_record_pre_action 13:13:07 INFO - Running main action method: run_tests 13:13:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:13:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:13:07 INFO - Python 2.7.3 13:13:07 INFO - Return code: 0 13:13:07 INFO - grabbing minidump binary from tooltool 13:13:07 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')]} 13:13:07 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 0x14def60>, '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 0x14dfd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14e01d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:13:07 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 13:13:07 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 13:13:07 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 13:13:07 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:13:07 INFO - Return code: 0 13:13:07 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:13:07 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:13:07 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:13:07 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:13:07 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:13:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Larch-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/V88YIN3vQT-q01pw9WKF7g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--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 13:13:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Larch-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/V88YIN3vQT-q01pw9WKF7g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-025 --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 13:13:07 INFO - Using env: {'DISPLAY': ':0', 13:13:07 INFO - 'HOME': '/home/cltbld', 13:13:07 INFO - 'LANG': 'en_US.UTF-8', 13:13:07 INFO - 'LANGUAGE': 'en_US:en', 13:13:07 INFO - 'LOGNAME': 'cltbld', 13:13:07 INFO - 'MAIL': '/var/mail/cltbld', 13:13:07 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:13:07 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:13:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:13:07 INFO - 'MOZ_NO_REMOTE': '1', 13:13:07 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:13:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:13:07 INFO - 'NO_EM_RESTART': '1', 13:13:07 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:13:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:13:07 INFO - 'PWD': '/builds/slave/test', 13:13:07 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:13:07 INFO - 'SHELL': '/bin/bash', 13:13:07 INFO - 'SHLVL': '1', 13:13:07 INFO - 'TERM': 'linux', 13:13:07 INFO - 'TMOUT': '86400', 13:13:07 INFO - 'USER': 'cltbld', 13:13:07 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1479329177.668491-1164925588', 13:13:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:13:07 INFO - '_': '/tools/buildbot/bin/python'} 13:13:07 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Larch-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/V88YIN3vQT-q01pw9WKF7g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--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 13:13:07 INFO - mozversion application_buildid: 20161116115308 13:13:07 INFO - mozversion application_changeset: 4de23d5b8758f314a92b3409087d6ba01ddb64dc 13:13:07 INFO - mozversion application_display_name: Nightly 13:13:07 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:13:07 INFO - mozversion application_name: Firefox 13:13:07 INFO - mozversion application_remotingname: firefox 13:13:07 INFO - mozversion application_repository: https://hg.mozilla.org/projects/larch 13:13:07 INFO - mozversion application_vendor: Mozilla 13:13:07 INFO - mozversion application_version: 52.0a1 13:13:07 INFO - mozversion platform_buildid: 20161116115308 13:13:07 INFO - mozversion platform_changeset: 4de23d5b8758f314a92b3409087d6ba01ddb64dc 13:13:07 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/larch 13:13:07 INFO - mozversion platform_version: 52.0a1 13:13:07 INFO - using testdate: 1479330787 13:13:07 INFO - actual date: 1479330787 13:13:07 INFO - starting webserver on 'localhost:37239' 13:13:07 INFO - SUITE-START | Running 2 tests 13:13:07 INFO - TEST-START | dromaeo_css 13:13:07 INFO - operating with platform_type : linux_ 13:13:07 INFO - Initialising browser for dromaeo_css test... 13:13:07 INFO - TEST-INFO | started process 7988 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0DpyVD/profile http://localhost:37239/getInfo.html) 13:13:11 INFO - PROCESS | 7988 | __metrics Screen width/height:1600/1200 13:13:11 INFO - PROCESS | 7988 | colorDepth:24 13:13:11 INFO - PROCESS | 7988 | Browser inner width/height: 1024/697 13:13:11 INFO - PROCESS | 7988 | __metrics 13:13:12 INFO - PROCESS | 7988 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 13:13:12 INFO - PROCESS | 7988 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:13:12 INFO - PROCESS | 7988 | console.error: PushService: 13:13:12 INFO - PROCESS | 7988 | stateChangeProcessEnqueue: Error transitioning state 13:13:12 INFO - PROCESS | 7988 | UnknownError 13:13:13 INFO - TEST-INFO | 7988: exit 0 13:13:13 INFO - Browser initialized. 13:13:13 INFO - Running cycle 1/1 for dromaeo_css test... 13:13:13 INFO - TEST-INFO | started process 8071 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0DpyVD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:13:25 INFO - PROCESS | 8071 | RSS: Main: 176267264 13:13:25 INFO - PROCESS | 8071 | 13:14:17 INFO - PROCESS | 8071 | 1479330857580 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] 13:16:30 INFO - PROCESS | 8071 | Cycle 1(1): loaded http://localhost:37239/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37239/tests/dromaeo/cssquery-ext.html) 13:16:32 INFO - PROCESS | 8071 | RSS: Main: 381054976 13:16:32 INFO - PROCESS | 8071 | 13:19:35 INFO - PROCESS | 8071 | Cycle 1(1): loaded http://localhost:37239/tests/dromaeo/cssquery-ext.html (next: http://localhost:37239/tests/dromaeo/cssquery-jquery.html) 13:19:36 INFO - PROCESS | 8071 | RSS: Main: 282095616 13:19:36 INFO - PROCESS | 8071 | 13:22:38 INFO - PROCESS | 8071 | Cycle 1(1): loaded http://localhost:37239/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37239/tests/dromaeo/cssquery-mootools.html) 13:22:39 INFO - PROCESS | 8071 | RSS: Main: 223219712 13:22:39 INFO - PROCESS | 8071 | 13:25:41 INFO - PROCESS | 8071 | Cycle 1(1): loaded http://localhost:37239/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37239/tests/dromaeo/cssquery-prototype.html) 13:25:42 INFO - PROCESS | 8071 | RSS: Main: 221515776 13:25:42 INFO - PROCESS | 8071 | 13:28:45 INFO - PROCESS | 8071 | Cycle 1(1): loaded http://localhost:37239/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37239/tests/dromaeo/cssquery-yui.html) 13:28:45 INFO - PROCESS | 8071 | RSS: Main: 219672576 13:28:45 INFO - PROCESS | 8071 | 13:31:49 INFO - PROCESS | 8071 | Cycle 1(1): loaded http://localhost:37239/tests/dromaeo/cssquery-yui.html (next: http://localhost:37239/tests/dromaeo/cssquery-dojo.html) 13:31:49 INFO - PROCESS | 8071 | RSS: Main: 315949056 13:31:49 INFO - PROCESS | 8071 | 13:31:49 INFO - PROCESS | 8071 | __start_tp_report 13:31:49 INFO - PROCESS | 8071 | _x_x_mozilla_page_load 13:31:49 INFO - PROCESS | 8071 | _x_x_mozilla_page_load_details 13:31:49 INFO - PROCESS | 8071 | |i|pagename|runs| 13:31:49 INFO - PROCESS | 8071 | |0;dojo.html;2561.782248508877;2581.045013345062;2586.8965241390347;2596.8571728554934;2625.763681268686;4646.558576935195;4734.218853889109;4741.051789642077;4752.002079563295;4763.976180119099;4687.69529980551;4713.528647135285;4758.666893317469;4760.047990401916;4802.927956080653;4293.162833247518;4328.545502722216;4366.585174408426;4369.563043695637;4380.5838445347645;4398.626116780061;4441.4004109445295;4460.66545009124;4474.932876006863;4519.5028546859985;4287.571242875719;4423.270160423526;4443.133588950156;4444.822207111712;4533.637309015271;4306.418633484471;4319.524852266248;4338.501072376685;4366.56334366564;4405.0969551241915;4339.305711086211;4342.218400687875;4347.586979236968;4384.167008268419;4397.758123303217;4712.505186955389;4714.504976977437;4721.881952951169;4731.455882573479;4744.16977029022;4945.208766597327;5003.874903127415;5006.048850718352;5023.773930173151;5066.544011038987;5128.307678463397;5170;5174;5200.063988482072;5218.765155568009;4799.112164249625;4808.3027960945465;4811.326414302001;4814.133455977888;4853.417589889236;5043.52086551777;5097.439281679012;5248.76380562868;5261.921071183935;5267;4932.062908047459;4964.826231081967;4973.35346404965;4980.128477516492;5049.394072711299;5067.5439210470495;5081.339425874613;5081.74591270435;5081.771320290596;5128.820491282861;4978.6763860348965;4981.402231732215;5013.298138260647;5027.421846487628;5032.345795046694;4886.951130488721;4942.728149951715;4944.851654450372;4980.800767969313;4992.550670439605;4313.633341165973;4316.136772645484;4316.482022157361;4319.654427645781;4320.071184695305;3756.6431189037;3791.2986097571484;3794.582595914447;3800.201957588882;3820.7707537547835;4467.754273514923;4467.910641787146;4480.126375356839;4506.143832671782;4508.977455112704;5117.795288188431;5148.150555158357;5151.407588127413;5158.845234642967;5160.92258616121;4280.143971205771;4327.437433133672;4453.710508816916;4457.286834106528;4474.105178964155;4534.546545345505;4556.794944227518;4580.381648477412;4606.608438282784;4662.393888794503;4784.043191361741;4797.712137271775;4800.207965685623;4800.831970881002;4851.296561998561;5094.5669618082875;5122.410922743932;5135.820246291362;5140.3831540215415;5189.221616757516;4671.299305104261;4728.503507131839;4736.052789442057;4781.95218047829;4789.018251258414;5026.070177017264;5036.269740887624;5036.899262014813;5037.974810126073;5040.521150490697;5095.286659867696;5098.1588037973315;5108.897822043613;5115.872103197301;5117.5394214520875;4966.18058020437;4968.105740966661;4968.900621987467;4971.825986090469;4977.178765503651;4889;4924.409070911371;4934.284528743384;4939.975300123477;4940.2342636891335;4843.200871856105;4889.462159162418;4892.143874821821;4895.045466134212;4899.485554016777;4940.209566469348;4950.900981980412;4955.6531042826655;5002.599792016557;5011.373578302712;4908.82819101344;4908.8772780680765;4910.3125562422;4913.533214344631;4945.455999840086 13:31:49 INFO - PROCESS | 8071 | |1;ext.html;536.131467023422;555.2559570175963;558.0485272610198;559.6306437751085;560.3863769172759;26882.86558567207;29230.853845730795;29267.707322926763;29270.26824329393;37773.24453510935;35324.47013294802;39311;39324.60675393245;39353.21293574127;39421.40867886984;7451.776446706594;7581.166071732105;7591.658375373121;7592.848143037136;7595.278448547379;7408.55548667079;7434.479586428952;7504.249575042507;7510.887336689954;7593.24067593239;9449.385789923668;9657.565409556586;9694.22446204302;9908.108270255676;9940.701778946643;9731.56207970643;9787.902120978806;9806.705798826046;9818;9818.214542836557;9628.71113866585;9684.41893486393;9697.321187516876;9698.224142068617;9698.757531061709;36473;36740.44889326662;36863.89408317755;36873;36888.815555922316;2963.199936017263;3005.248687828043;3108.8134711917355;3175.4125486784787;3237.8542965566608;27338.179854604394;27554;27657.308567285778;28107;29146;3373.375925453799;3402.574678165229;3409.730839575203;3413.5391722117442;3463.5843698756057;173801;174838.12580937013;175459.12270438566;175461;175671;26975.730242697715;51260.74369628128;51635.741821290656;51652.22521662178;51657.483425165265;32242.677573224435;32322;32399.51400728991;32419.675803241666;32520.349593008006;13598.796018059737;13720.93139534296;13723.725525489433;13736.793948090786;13747.518836840663;11469.770604587862;11552.6534203974;11570.19008669385;11571.942140289413;11577.3212884133;6950.687219075154;7158.391536719333;7312.634368281565;7500.849983000309;7565.886511702329;2979.9851000745293;2996.5355369917697;3031.8484075796564;3037.2103253154337;3043.7260646541476;823.5923218007125;858.5149390594419;871.4771137317558;885.2873436883242;971.5142428785607;26524.46951060968;27681.584776228374;27751;27759.722402775715;27993.860030700125;894.7763059235191;929.990700093004;936.7236665183788;997.4264797741328;1025.8974102589682;14003.789943150861;14770.483033094006;14773.778393324108;15046.623834404227;15104.848951510345;319713;321792;321811;322118;324427;41750.37374439386;42550.36174457386;47277.527224728;48140.27789583159;48736.26895596569;1123.4270522033657;1124.4153040418937;1137.4426530999751;1146.3236690352733;1153.3541216918552;27207.183784486497;28005.15984520468;28229.153125406272;28919.566206506497;29107;42533.36199957065;42968.570314296456;42975.57024429716;42976;43004.35493467538;542369;559405;561886;562786;563579;36613.633863662086;37005.629943700216;37290.6270937298;37476.43785343276;37718.8114059428;40939;41138.38292425556;41353;42132.57867421286;42177.578224218596;35211.82394088116;35302.117447064025;35371.46942795809;35449.645503544634;35579.82210088933;35069.298614027066;35102.824485877405;35155.824220878734;35419.645803541636;35528.289434211685;34911;35303;35778;35891;36297;30218.395632087675;32063.519047214777;32855.17862053468;32923.34153316968;33209.83395083009;24714.258572242863;24719.876400617883;25047.248582542554;25424.491510170064;25481 13:31:49 INFO - PROCESS | 8071 | |2;jquery.html;312.70164292450494;317.7299295598743;330.5570535482454;331.8373996741596;332.6058620534666;12337.938310308447;15331.693366132671;15816.525504234876;16737.581560460996;16898.83101168988;16404.179791010432;16438.084372907422;16806.747898781497;16938.40715574952;17090.914545427288;4683.789229484672;4731;4905.435874874382;4929.605631549485;4941;4822.7829747661435;4902.117618828609;4908.533689299511;4910.459849416561;4916.729579873106;4843.370361852972;5150.922736158942;5174.508421699932;5223.843284701465;5231.319928409302;5239.161734122541;5261.342332208474;5266.631335806495;5275.815346462875;5278.049951008817;5145.099607568661;5188.429272779991;5188.766505507261;5190.948090519122;5203.817866374697;11060.22578419511;11272.605458808903;11312.377819219939;21232.89383553088;21688.566228675496;1791.1133988675558;1888.2447021191497;2142.710734050914;2187.0923566719794;2562.6027965665353;13814.930925345308;14022.368993395321;14337;14398.352074156688;14561;1737.9826201737947;1814.7005744052215;1819.7816262048507;1858.3681548273653;1875.4186202277338;67866;82393;82615;83879;85971.14028859757;16283;16617.50147495577;16635.83364166367;16814.915925420293;16973;28136.859315703292;28209.43581128366;28230.294242643686;28314.858425708153;28321.035055092303;8142.4300298978505;8698;8842.381033327734;9054.366194366332;9062.275017998545;7342.265773422615;7349.375303099297;7500.474966752384;7567.3189412952;7612.733554325683;7948.6820527179425;8258.215469530385;8268.627911743986;8381.371397145116;8415;2970.985145074304;3024.3346463777934;3059.281068948795;3205.34290470453;3303.7357011439026;762.3367670127025;858.5020688000944;890.5636238243214;920.1626519867023;942.6936245720032;16283.267252973645;16591.751123733153;16679.83320166783;16873.156342183087;17686.115694215237;837.3050368194384;853.1594645210619;863.2058506174335;888.0453512474116;901.1034021148868;8937.09067475289;9231.676891308773;9651.855222171673;9661.951690241503;9665.661701840401;365715;366458.17396390997;368179;370843;373761;44395.11209775786;55797.16304255439;63896.36103638997;76266.23733762592;77925;862.7023676831483;884.823035392924;886.8714036464677;889.5818965086399;890.4657205676542;14605.780913286522;14781.113133212042;14790;14911.403543858125;15460.304286306919;35003.47494787529;35887.46168807522;36084;36230.45654315135;37196;44809;46766.298505521765;50202.748986256294;50256.49743502664;50992.82129216777;7195.784126476214;7457.850842983002;7557.5465472071855;7722.806929826799;8033.5983200838555;11072.944635277094;11284.21010529255;11671.59149429766;12336.81494777561;12476.812847807472;10341.63804266847;10672.519736612026;10699.358038517714;10889.237753357189;11101;10617.362958222531;10639.978404103196;10816.837747433952;10873.238873279111;10888.510017049093;6280.937190628035;10139.442330671884;10728.249022568345;10958.616448424586;11331.546738130382;7295.598742069237;7394.8890766639615;7415.480916335805;7531.246875312425;7598.924010759822;9825;10562.683119506428;10652.307600005975;10741.677749667522;11049.392283424168 13:31:49 INFO - PROCESS | 8071 | |3;mootools.html;1214.5384753793558;1317.8813906748392;1344.7915573086173;1364.6383708317292;1612.467885597753;6056.242969628796;6647.302033286502;6848.178218613761;6852.6231057291825;7063.6115013674225;6911.48163887708;6964.477664175181;6964.582125072499;6973.302669733037;6973.44212463003;2033.2273735980307;2062.742157230346;2072.3782865140474;2076.4186027912133;2078.511549785799;2037.8777273363646;2072.4611600983776;2078.2206672497814;2103.453102193433;2108.7574928883223;2024.6355655981918;2041.0611118885256;2043.867148635334;2045.4681782736448;2047.8873661948587;2006.0571531380228;2024.6355655981918;2025.5138766695961;2026.6858636911302;2029.482481967089;1995.0623207092788;2001.0395010394946;2052.6305265052283;2057.763357213925;2058.9485262868398;6796.35434633709;6817.69320380584;6954.513184077116;6956.130483689539;6970.58176509406;4167.2082304362075;4346.847860324873;4352.412424322739;4354.912901741947;4364.912701745979;2668.49298633261;2885.552739325408;2950.114965510338;2950.247686839842;2950.7491863191653;871.1158174452935;873.1530415496958;880.1682410122437;884.3146561414891;902.0798785239019;9030.232430243437;9082.954585227099;9109.681161159328;9116.5441727914;9116.863247051233;3453.846263813243;3562.71498280137;3619.674229319374;3650.945235821465;3652.397354436488;7315.195328513965;7328.853422931618;7331.523450975669;7333.230010848891;7346.228645992201;4182.435371224846;4192.287311157111;4193.035601811539;4195.958040419557;4198.538160802371;3443.862245510202;3551.5027896094566;3700.1119731264303;3840.2703486337505;3907.257621051991;2881.7838662100426;2918.7664986801005;3013.2015016020773;3024.848757562113;3034.4386288536693;870.2994089757806;876.6931573949067;882.1531329923217;888.8711136885245;896.6996056321075;783.3224261014182;799.6121880887765;804.3886646148969;813.5728742410282;827.6441130313902;4758.500357462417;4797.136515427187;4800.73595952219;4811.182099043171;5137.152369859006;377.9659830615258;379.3210153824678;394.31979834784767;400.80961543267296;878.5299864572423;3016.75865930725;3059.6940305969224;3138.1213260287154;3180.25264062945;3219.436598595283;7721.729739459204;7722.111957125003;7955.880661790078;8016.078151012592;8034.47775894565;7960.283574478325;7978.521288722579;7982.84034319322;7985.041794984639;7987.440879138405;6427.935720642734;6479.838004049842;6532.248791388956;6587.703553340111;6591.670416479157;4452.376667266521;4523.508506465716;4529.411176547028;4599.724016559017;4601;7692.384609231136;7730.265624765639;7741.612919354123;7801.843963120819;7806.024246969129;7610.277023682741;7685.769426917202;7785.182555831782;7786.805329866798;7960.363170946426;5373.919391209213;5966.731497082728;6133.325334213322;6137.232845894263;6138.508919286357;6220.098085777447;6284.120223168668;6538.509611779041;6555.180602424697;6660.467162626881;5886.087656413263;6008.068749343859;6026.819195424145;6092.390760923872;6165.136880836776;5843.678597676999;5902.1441890926435;5913.408659134052;6009.969950150221;6110.114033465212;5549.805756798492;5620.578456615852;5668.1214411764595;5673.461021202979;5679.716014199356;4096.406021126861;4139.77231252284;4177.227212965611;4233.618974292205;4331.45856767904;4144.109016561454;4154.605312495308;4167.97916010418;4193.119444916601;4400.581944715247 13:31:49 INFO - PROCESS | 8071 | |4;prototype.html;275.9130873774761;280.71226992332856;282.14510034595173;283.8694200667693;285.6657710478739;4734.1951868182405;4791.353167322411;4849.9515004849945;4876.9756151219235;4908.705477671342;4752.691075080117;4779.474257831635;4793.352897358855;4793.5446132617435;4804.111239420709;3521.982390088046;3620.1130722972775;3621.674049335559;3755.09877629369;3756.530433695788;3699.981500092496;3704.7221458390595;3710.202306504101;3717.423799311111;3723.832427540767;3676.466912297715;3680.595134535199;3681.723870709694;3683.8894833154914;3711.480392745018;3527.7354198434964;3535.1338921964284;3627.2564124354444;3700.5929347771857;3707.888763337104;3244.4160051190775;3247.993122132123;3255.7232635226032;3262.4127657021727;3263.233140212048;4641.727582054644;4645.279981602857;4667.253239481666;4667.789949452283;4680.461746899116;4129.421880936671;4230.788460576959;4234.17433600448;4238.152369526107;4245.299525578276;4963.553280204799;4979.875503112415;4990.87522811929;5001.224810154432;5003.699778013331;3520.8591656333715;3524.8061356625376;3534.929301413983;3543.5216245806746;3547.2728090741593;5235.842924712265;5238.319018527605;5246.344206974129;5249.947500524984;5253.26454296395;3341.548890899746;3486.4073107571267;3536.5932917714276;3546.414841551167;3629.691476224498;3568;3571.8571257149943;3578.982105089458;3588.8923332300074;3592.1378869071236;4087.9386809197886;4112.362583799516;4132.318167502329;4146.647534959562;4147.149834283965;4787.473377928425;5000.549950504472;5003.574696150868;5014.373203349582;5049.772760225798;1193.4390836307095;1200.4597930931116;1202.687301301668;1213.6055781870928;1213.7390461050916;806.2632036783895;815.4006804998321;823.8558252305943;827.8385714785679;832.24681663095;4285.914281714348;4356.542563030899;4393.714408563497;4399.978000110043;4425.867223983221;5018.222175562793;5167.689938603696;5188.610854185951;5211.687298762086;5212.270282160501;4489.326601009875;4516.322551617283;4516.412866327422;4516.954830451654;4547.636189104864;2605.8436493810054;2667.6932152802674;2679.4641071785722;2690.9865450672623;2696.7999240338254;4740.620750339965;4760.214564596803;4770.427548694179;4773.515333806341;4783.425988881357;5196.804734910992;5204.4535323791215;5206.516142899255;5208.114620514521;5218.399884013311;4529.909401811945;4760.09558183944;4773.451053128934;4794.808207671724;4795.136875362468;5088.847334579968;5109.569320590241;5111.258867464123;5121.411037730709;5144.6109550421925;5012.649114561946;5015.648904576645;5023.447420783637;5039.949600504095;5048.192289233852;4638;4790.904181916412;4811.542903424309;4920.655554111321;4963.776630051729;3727.5154229949935;3728.757630753992;3738.3457894867747;3741.0834345585504;3766.6986641069198;5241.161414173714;5257.89484210306;5267.604929630216;5281.260623512788;5282.445343239058;4885.975570122268;5036.445990941067;5078.898422031612;5108.974455127701;5146.228065790161;5031.609985256973;5035.395752509722;5049.84850454487;5062.835547823947;5077.466865979167;4995.575376093073;4996;4996.525330093636;5022.899542009212;5030.220315851049;4783.760811959319;5043.671177023147;5076.796928122833;5089.338386009795;5094.490550944876;4773.570378665937;4871.853844384674;4884;5017.498250174954;5035.496450354935 13:31:49 INFO - PROCESS | 8071 | |5;yui.html;618.7024051314742;663.6681659170417;678.7556479667322;703.6446594469792;714.8820444626635;11874.28754274743;12989.285589292585;12994.935025324883;13008.609741707764;13019.958403327735;12135.968442682382;12215.51137954483;12217.328046957413;12218.694532636688;12224;605.7062324772481;621.2793159934477;722.5231347310776;739.3493725521533;744.3115118515352;743.788020414182;747.137056699513;750.8310630108236;750.9586972716498;751.2600088912417;796.77690246731;798.4331124901327;798.7084714079377;799.0331698644646;799.3645052183499;631.3875540725489;784.5763287824568;785.0579304834222;786.6499407763519;789.9960500197491;475.0475297029434;552.7098273406453;566.2695123290949;566.3713278261126;567.1209625081108;12017.699557511045;12045.759084818255;12053.0960177987;12063.21589096706;12068.21556598827;11192.720181995515;11253;11490.195686301962;11622.6513204604;12102.791377821708;10741.194410419172;10909.563617455293;10921.726956826144;11034.834477482844;11091.44542772858;3122.9063128106195;3221.291315910496;3351.8156501392414;3388.15296175956;3939.2515422069714;45763.31355029677;47101;47707;50653.49346506488;51464.485355146346;9677.70966870995;9875.456849873326;10115.190784737351;10152.695419137437;10548.47257637115;17401.303947841945;17603.11984400775;17699.20353584092;17737.645247094984;17922.283108675507;6266.561340706106;6308.4007019334;6420.74317027323;6431.839204019937;6450.903236451457;3301.6863397977154;3400.4219282721997;3409.7101746351836;3520.6655367740022;3540;2681.8927242910454;2763.2677340504783;2764.3365592257715;2764.9447011059665;2771.875265613012;476.56156336170807;480.97114173149726;482.312704396234;484.51790468484086;496.238274249026;547.3404547520229;586.6274915428648;609.4182825484747;610.9419605137505;632.4718859752066;7282.745103921337;7430.294122058396;7580.810479738051;7960.641771120314;7962.840743185104;501.92471129330164;517.6247220764915;530.186164237893;547.255732204202;557.8159207461528;3277.2466730299175;3536.8938931832085;3654.8720794772057;3720.7581507201944;3881.4177873318663;39716;40876.59123408787;65441;65557.67221163864;65643;34000.829995850356;34381.312373752386;35876.46185307222;49198.26202606892;57748.422515774306;51643.225351619;51678.48321516812;52088.47911520912;52965.7351713239;53255.73372133115;7241.927580724126;7344.559326440431;7359;7515.098188217449;7584.5070070445245;32480;34483.65516344804;36369.636303636624;37017;37583.43624845575;34263.65736342605;45416.77291613653;45999.08001840011;46267.76866115648;46888.06223875435;10184.949075254577;10292.332212501435;10417.9479102604;10615.256932014685;10663.626773063215;11266.887331126913;11671.708207294885;11690.415479225834;12025.158238923192;12136.878631213927;10888.346699198073;10923.563057477611;10993.560257589927;11560.826587601025;11768.94115529417;10824.67525974222;10830.133589312994;11031.448427578749;11059.944700276446;11578.94210528942;10561.10230630405;10920.56317747313;11067.059299959594;11611.187216894736;11633.011194048262;8554.401191916506;8922.330825188266;8974.19232269099;8981.506017169118;8996.820063598821;8239.546824924686;9242.768930776516;9283.11810378013;9376.451956175071;9445.716628501155 13:31:49 INFO - PROCESS | 8071 | __end_tp_report 13:31:49 INFO - PROCESS | 8071 | __start_cc_report 13:31:49 INFO - PROCESS | 8071 | _x_x_mozilla_cycle_collect,2477 13:31:49 INFO - PROCESS | 8071 | __end_cc_report 13:31:49 INFO - PROCESS | 8071 | __startTimestamp1479331909380__endTimestamp 13:31:49 INFO - PROCESS | 8071 | 13:31:49 INFO - PROCESS | 8071 | ------- Summary: start ------- 13:31:49 INFO - PROCESS | 8071 | Number of tests: 6 13:31:49 INFO - PROCESS | 8071 | 13:31:49 INFO - PROCESS | 8071 | [#0] dojo.html Cycles:165 Average:4702.12 Median:4814.13 stddev:494.82 (10.3%) stddev-sans-first:466.99 13:31:49 INFO - PROCESS | 8071 | Values: 2561.8 2581.0 2586.9 2596.9 2625.8 4646.6 4734.2 4741.1 4752.0 4764.0 4687.7 4713.5 4758.7 4760.0 4802.9 4293.2 4328.5 4366.6 4369.6 4380.6 4398.6 4441.4 4460.7 4474.9 4519.5 4287.6 4423.3 4443.1 4444.8 4533.6 4306.4 4319.5 4338.5 4366.6 4405.1 4339.3 4342.2 4347.6 4384.2 4397.8 4712.5 4714.5 4721.9 4731.5 4744.2 4945.2 5003.9 5006.0 5023.8 5066.5 5128.3 5170.0 5174.0 5200.1 5218.8 4799.1 4808.3 4811.3 4814.1 4853.4 5043.5 5097.4 5248.8 5261.9 5267.0 4932.1 4964.8 4973.4 4980.1 5049.4 5067.5 5081.3 5081.7 5081.8 5128.8 4978.7 4981.4 5013.3 5027.4 5032.3 4887.0 4942.7 4944.9 4980.8 4992.6 4313.6 4316.1 4316.5 4319.7 4320.1 3756.6 3791.3 3794.6 3800.2 3820.8 4467.8 4467.9 4480.1 4506.1 4509.0 5117.8 5148.2 5151.4 5158.8 5160.9 4280.1 4327.4 4453.7 4457.3 4474.1 4534.5 4556.8 4580.4 4606.6 4662.4 4784.0 4797.7 4800.2 4800.8 4851.3 5094.6 5122.4 5135.8 5140.4 5189.2 4671.3 4728.5 4736.1 4782.0 4789.0 5026.1 5036.3 5036.9 5038.0 5040.5 5095.3 5098.2 5108.9 5115.9 5117.5 4966.2 4968.1 4968.9 4971.8 4977.2 4889.0 4924.4 4934.3 4940.0 4940.2 4843.2 4889.5 4892.1 4895.0 4899.5 4940.2 4950.9 4955.7 5002.6 5011.4 4908.8 4908.9 4910.3 4913.5 4945.5 13:31:49 INFO - PROCESS | 8071 | 13:31:49 INFO - PROCESS | 8071 | [#1] ext.html Cycles:180 Average:48866.68 Median:35434.65 stddev:103396.13 (291.8%) stddev-sans-first:103622.51 13:31:49 INFO - PROCESS | 8071 | Values: 536.1 555.3 558.0 559.6 560.4 26882.9 29230.9 29267.7 29270.3 37773.2 35324.5 39311.0 39324.6 39353.2 39421.4 7451.8 7581.2 7591.7 7592.8 7595.3 7408.6 7434.5 7504.2 7510.9 7593.2 9449.4 9657.6 9694.2 9908.1 9940.7 9731.6 9787.9 9806.7 9818.0 9818.2 9628.7 9684.4 9697.3 9698.2 9698.8 36473.0 36740.4 36863.9 36873.0 36888.8 2963.2 3005.2 3108.8 3175.4 3237.9 27338.2 27554.0 27657.3 28107.0 29146.0 3373.4 3402.6 3409.7 3413.5 3463.6 173801.0 174838.1 175459.1 175461.0 175671.0 26975.7 51260.7 51635.7 51652.2 51657.5 32242.7 32322.0 32399.5 32419.7 32520.3 13598.8 13720.9 13723.7 13736.8 13747.5 11469.8 11552.7 11570.2 11571.9 11577.3 6950.7 7158.4 7312.6 7500.8 7565.9 2980.0 2996.5 3031.8 3037.2 3043.7 823.6 858.5 871.5 885.3 971.5 26524.5 27681.6 27751.0 27759.7 27993.9 894.8 930.0 936.7 997.4 1025.9 14003.8 14770.5 14773.8 15046.6 15104.8 319713.0 321792.0 321811.0 322118.0 324427.0 41750.4 42550.4 47277.5 48140.3 48736.3 1123.4 1124.4 1137.4 1146.3 1153.4 27207.2 28005.2 28229.2 28919.6 29107.0 42533.4 42968.6 42975.6 42976.0 43004.4 542369.0 559405.0 561886.0 562786.0 563579.0 36613.6 37005.6 37290.6 37476.4 37718.8 40939.0 41138.4 41353.0 42132.6 42177.6 35211.8 35302.1 35371.5 35449.6 35579.8 35069.3 35102.8 35155.8 35419.6 35528.3 34911.0 35303.0 35778.0 35891.0 36297.0 30218.4 32063.5 32855.2 32923.3 33209.8 24714.3 24719.9 25047.2 25424.5 25481.0 13:31:49 INFO - PROCESS | 8071 | 13:31:49 INFO - PROCESS | 8071 | [#2] jquery.html Cycles:180 Average:24283.61 Median:204019.50 stddev:60961.52 (29.9%) stddev-sans-first:61105.97 13:31:49 INFO - PROCESS | 8071 | Values: 312.7 317.7 330.6 331.8 332.6 12337.9 15331.7 15816.5 16737.6 16898.8 16404.2 16438.1 16806.7 16938.4 17090.9 4683.8 4731.0 4905.4 4929.6 4941.0 4822.8 4902.1 4908.5 4910.5 4916.7 4843.4 5150.9 5174.5 5223.8 5231.3 5239.2 5261.3 5266.6 5275.8 5278.0 5145.1 5188.4 5188.8 5190.9 5203.8 11060.2 11272.6 11312.4 21232.9 21688.6 1791.1 1888.2 2142.7 2187.1 2562.6 13814.9 14022.4 14337.0 14398.4 14561.0 1738.0 1814.7 1819.8 1858.4 1875.4 67866.0 82393.0 82615.0 83879.0 85971.1 16283.0 16617.5 16635.8 16814.9 16973.0 28136.9 28209.4 28230.3 28314.9 28321.0 8142.4 8698.0 8842.4 9054.4 9062.3 7342.3 7349.4 7500.5 7567.3 7612.7 7948.7 8258.2 8268.6 8381.4 8415.0 2971.0 3024.3 3059.3 3205.3 3303.7 762.3 858.5 890.6 920.2 942.7 16283.3 16591.8 16679.8 16873.2 17686.1 837.3 853.2 863.2 888.0 901.1 8937.1 9231.7 9651.9 9662.0 9665.7 365715.0 366458.2 368179.0 370843.0 373761.0 44395.1 55797.2 63896.4 76266.2 77925.0 862.7 884.8 886.9 889.6 890.5 14605.8 14781.1 14790.0 14911.4 15460.3 35003.5 35887.5 36084.0 36230.5 37196.0 44809.0 46766.3 50202.7 50256.5 50992.8 7195.8 7457.9 7557.5 7722.8 8033.6 11072.9 11284.2 11671.6 12336.8 12476.8 10341.6 10672.5 10699.4 10889.2 11101.0 10617.4 10640.0 10816.8 10873.2 10888.5 6280.9 10139.4 10728.2 10958.6 11331.5 7295.6 7394.9 7415.5 7531.2 7598.9 9825.0 10562.7 10652.3 10741.7 11049.4 13:31:49 INFO - PROCESS | 8071 | 13:31:49 INFO - PROCESS | 8071 | [#3] mootools.html Cycles:180 Average:4504.45 Median:5585.19 stddev:2429.70 (43.5%) stddev-sans-first:2423.94 13:31:49 INFO - PROCESS | 8071 | Values: 1214.5 1317.9 1344.8 1364.6 1612.5 6056.2 6647.3 6848.2 6852.6 7063.6 6911.5 6964.5 6964.6 6973.3 6973.4 2033.2 2062.7 2072.4 2076.4 2078.5 2037.9 2072.5 2078.2 2103.5 2108.8 2024.6 2041.1 2043.9 2045.5 2047.9 2006.1 2024.6 2025.5 2026.7 2029.5 1995.1 2001.0 2052.6 2057.8 2058.9 6796.4 6817.7 6954.5 6956.1 6970.6 4167.2 4346.8 4352.4 4354.9 4364.9 2668.5 2885.6 2950.1 2950.2 2950.7 871.1 873.2 880.2 884.3 902.1 9030.2 9083.0 9109.7 9116.5 9116.9 3453.8 3562.7 3619.7 3650.9 3652.4 7315.2 7328.9 7331.5 7333.2 7346.2 4182.4 4192.3 4193.0 4196.0 4198.5 3443.9 3551.5 3700.1 3840.3 3907.3 2881.8 2918.8 3013.2 3024.8 3034.4 870.3 876.7 882.2 888.9 896.7 783.3 799.6 804.4 813.6 827.6 4758.5 4797.1 4800.7 4811.2 5137.2 378.0 379.3 394.3 400.8 878.5 3016.8 3059.7 3138.1 3180.3 3219.4 7721.7 7722.1 7955.9 8016.1 8034.5 7960.3 7978.5 7982.8 7985.0 7987.4 6427.9 6479.8 6532.2 6587.7 6591.7 4452.4 4523.5 4529.4 4599.7 4601.0 7692.4 7730.3 7741.6 7801.8 7806.0 7610.3 7685.8 7785.2 7786.8 7960.4 5373.9 5966.7 6133.3 6137.2 6138.5 6220.1 6284.1 6538.5 6555.2 6660.5 5886.1 6008.1 6026.8 6092.4 6165.1 5843.7 5902.1 5913.4 6010.0 6110.1 5549.8 5620.6 5668.1 5673.5 5679.7 4096.4 4139.8 4177.2 4233.6 4331.5 4144.1 4154.6 4168.0 4193.1 4400.6 13:31:49 INFO - PROCESS | 8071 | 13:31:49 INFO - PROCESS | 8071 | [#4] prototype.html Cycles:180 Average:4142.22 Median:4760.16 stddev:1226.89 (25.8%) stddev-sans-first:1195.51 13:31:49 INFO - PROCESS | 8071 | Values: 275.9 280.7 282.1 283.9 285.7 4734.2 4791.4 4850.0 4877.0 4908.7 4752.7 4779.5 4793.4 4793.5 4804.1 3522.0 3620.1 3621.7 3755.1 3756.5 3700.0 3704.7 3710.2 3717.4 3723.8 3676.5 3680.6 3681.7 3683.9 3711.5 3527.7 3535.1 3627.3 3700.6 3707.9 3244.4 3248.0 3255.7 3262.4 3263.2 4641.7 4645.3 4667.3 4667.8 4680.5 4129.4 4230.8 4234.2 4238.2 4245.3 4963.6 4979.9 4990.9 5001.2 5003.7 3520.9 3524.8 3534.9 3543.5 3547.3 5235.8 5238.3 5246.3 5249.9 5253.3 3341.5 3486.4 3536.6 3546.4 3629.7 3568.0 3571.9 3579.0 3588.9 3592.1 4087.9 4112.4 4132.3 4146.6 4147.1 4787.5 5000.5 5003.6 5014.4 5049.8 1193.4 1200.5 1202.7 1213.6 1213.7 806.3 815.4 823.9 827.8 832.2 4285.9 4356.5 4393.7 4400.0 4425.9 5018.2 5167.7 5188.6 5211.7 5212.3 4489.3 4516.3 4516.4 4517.0 4547.6 2605.8 2667.7 2679.5 2691.0 2696.8 4740.6 4760.2 4770.4 4773.5 4783.4 5196.8 5204.5 5206.5 5208.1 5218.4 4529.9 4760.1 4773.5 4794.8 4795.1 5088.8 5109.6 5111.3 5121.4 5144.6 5012.6 5015.6 5023.4 5039.9 5048.2 4638.0 4790.9 4811.5 4920.7 4963.8 3727.5 3728.8 3738.3 3741.1 3766.7 5241.2 5257.9 5267.6 5281.3 5282.4 4886.0 5036.4 5078.9 5109.0 5146.2 5031.6 5035.4 5049.8 5062.8 5077.5 4995.6 4996.0 4996.5 5022.9 5030.2 4783.8 5043.7 5076.8 5089.3 5094.5 4773.6 4871.9 4884.0 5017.5 5035.5 13:31:49 INFO - PROCESS | 8071 | 13:31:49 INFO - PROCESS | 8071 | [#5] yui.html Cycles:180 Average:13312.64 Median:45881.20 stddev:15978.50 (34.8%) stddev-sans-first:15994.89 13:31:49 INFO - PROCESS | 8071 | Values: 618.7 663.7 678.8 703.6 714.9 11874.3 12989.3 12994.9 13008.6 13020.0 12136.0 12215.5 12217.3 12218.7 12224.0 605.7 621.3 722.5 739.3 744.3 743.8 747.1 750.8 751.0 751.3 796.8 798.4 798.7 799.0 799.4 631.4 784.6 785.1 786.6 790.0 475.0 552.7 566.3 566.4 567.1 12017.7 12045.8 12053.1 12063.2 12068.2 11192.7 11253.0 11490.2 11622.7 12102.8 10741.2 10909.6 10921.7 11034.8 11091.4 3122.9 3221.3 3351.8 3388.2 3939.3 45763.3 47101.0 47707.0 50653.5 51464.5 9677.7 9875.5 10115.2 10152.7 10548.5 17401.3 17603.1 17699.2 17737.6 17922.3 6266.6 6308.4 6420.7 6431.8 6450.9 3301.7 3400.4 3409.7 3520.7 3540.0 2681.9 2763.3 2764.3 2764.9 2771.9 476.6 481.0 482.3 484.5 496.2 547.3 586.6 609.4 610.9 632.5 7282.7 7430.3 7580.8 7960.6 7962.8 501.9 517.6 530.2 547.3 557.8 3277.2 3536.9 3654.9 3720.8 3881.4 39716.0 40876.6 65441.0 65557.7 65643.0 34000.8 34381.3 35876.5 49198.3 57748.4 51643.2 51678.5 52088.5 52965.7 53255.7 7241.9 7344.6 7359.0 7515.1 7584.5 32480.0 34483.7 36369.6 37017.0 37583.4 34263.7 45416.8 45999.1 46267.8 46888.1 10184.9 10292.3 10417.9 10615.3 10663.6 11266.9 11671.7 11690.4 12025.2 12136.9 10888.3 10923.6 10993.6 11560.8 11768.9 10824.7 10830.1 11031.4 11059.9 11578.9 10561.1 10920.6 11067.1 11611.2 11633.0 8554.4 8922.3 8974.2 8981.5 8996.8 8239.5 9242.8 9283.1 9376.5 9445.7 13:31:49 INFO - PROCESS | 8071 | -------- Summary: end -------- 13:31:49 INFO - PROCESS | 8071 | 13:31:50 INFO - TEST-INFO | 8071: exit 0 13:31:50 INFO - TEST-OK | dromaeo_css | took 1123055ms 13:31:50 INFO - TEST-START | kraken 13:31:50 INFO - operating with platform_type : linux_ 13:31:50 INFO - Initialising browser for kraken test... 13:31:50 INFO - TEST-INFO | started process 8381 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqhcY8d/profile http://localhost:37239/getInfo.html) 13:31:54 INFO - PROCESS | 8381 | __metrics Screen width/height:1600/1200 13:31:54 INFO - PROCESS | 8381 | colorDepth:24 13:31:54 INFO - PROCESS | 8381 | Browser inner width/height: 1024/697 13:31:54 INFO - PROCESS | 8381 | __metrics 13:31:55 INFO - PROCESS | 8381 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 13:31:55 INFO - PROCESS | 8381 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:31:55 INFO - PROCESS | 8381 | console.error: PushService: 13:31:55 INFO - PROCESS | 8381 | stateChangeProcessEnqueue: Error transitioning state 13:31:55 INFO - PROCESS | 8381 | UnknownError 13:31:56 INFO - TEST-INFO | 8381: exit 0 13:31:56 INFO - Browser initialized. 13:31:56 INFO - Running cycle 1/1 for kraken test... 13:31:56 INFO - TEST-INFO | started process 8466 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqhcY8d/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:32:08 INFO - PROCESS | 8466 | RSS: Main: 176386048 13:32:08 INFO - PROCESS | 8466 | 13:32:11 INFO - PROCESS | 8466 | Cycle 1(1): loaded http://localhost:37239/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37239/tests/kraken/driver.html?testName=audio-beat-detection) 13:32:12 INFO - PROCESS | 8466 | RSS: Main: 237064192 13:32:12 INFO - PROCESS | 8466 | 13:32:15 INFO - PROCESS | 8466 | Cycle 1(1): loaded http://localhost:37239/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37239/tests/kraken/driver.html?testName=audio-dft) 13:32:16 INFO - PROCESS | 8466 | RSS: Main: 219537408 13:32:16 INFO - PROCESS | 8466 | 13:32:19 INFO - PROCESS | 8466 | Cycle 1(1): loaded http://localhost:37239/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37239/tests/kraken/driver.html?testName=audio-fft) 13:32:19 INFO - PROCESS | 8466 | RSS: Main: 300941312 13:32:19 INFO - PROCESS | 8466 | 13:32:22 INFO - PROCESS | 8466 | Cycle 1(1): loaded http://localhost:37239/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37239/tests/kraken/driver.html?testName=audio-oscillator) 13:32:22 INFO - PROCESS | 8466 | RSS: Main: 211599360 13:32:22 INFO - PROCESS | 8466 | 13:32:24 INFO - PROCESS | 8466 | Cycle 1(1): loaded http://localhost:37239/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37239/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:32:25 INFO - PROCESS | 8466 | RSS: Main: 215117824 13:32:25 INFO - PROCESS | 8466 | 13:32:28 INFO - PROCESS | 8466 | Cycle 1(1): loaded http://localhost:37239/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37239/tests/kraken/driver.html?testName=imaging-darkroom) 13:32:29 INFO - PROCESS | 8466 | RSS: Main: 250970112 13:32:29 INFO - PROCESS | 8466 | 13:32:32 INFO - PROCESS | 8466 | Cycle 1(1): loaded http://localhost:37239/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37239/tests/kraken/driver.html?testName=imaging-desaturate) 13:32:33 INFO - PROCESS | 8466 | RSS: Main: 249081856 13:32:33 INFO - PROCESS | 8466 | 13:32:36 INFO - PROCESS | 8466 | Cycle 1(1): loaded http://localhost:37239/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37239/tests/kraken/driver.html?testName=json-parse-financial) 13:32:36 INFO - PROCESS | 8466 | RSS: Main: 249196544 13:32:36 INFO - PROCESS | 8466 | 13:32:38 INFO - PROCESS | 8466 | Cycle 1(1): loaded http://localhost:37239/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37239/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:32:39 INFO - PROCESS | 8466 | RSS: Main: 212217856 13:32:39 INFO - PROCESS | 8466 | 13:32:40 INFO - PROCESS | 8466 | Cycle 1(1): loaded http://localhost:37239/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37239/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:32:41 INFO - PROCESS | 8466 | RSS: Main: 218939392 13:32:41 INFO - PROCESS | 8466 | 13:32:43 INFO - PROCESS | 8466 | Cycle 1(1): loaded http://localhost:37239/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37239/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:32:44 INFO - PROCESS | 8466 | RSS: Main: 227733504 13:32:44 INFO - PROCESS | 8466 | 13:32:47 INFO - PROCESS | 8466 | Cycle 1(1): loaded http://localhost:37239/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37239/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:32:48 INFO - PROCESS | 8466 | RSS: Main: 236175360 13:32:48 INFO - PROCESS | 8466 | 13:32:51 INFO - PROCESS | 8466 | Cycle 1(1): loaded http://localhost:37239/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37239/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:32:51 INFO - PROCESS | 8466 | RSS: Main: 232837120 13:32:51 INFO - PROCESS | 8466 | 13:32:53 INFO - PROCESS | 8466 | Cycle 1(1): loaded http://localhost:37239/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37239/tests/kraken/driver.html?testName=ai-astar) 13:32:53 INFO - PROCESS | 8466 | RSS: Main: 283447296 13:32:53 INFO - PROCESS | 8466 | 13:32:53 INFO - PROCESS | 8466 | __start_tp_report 13:32:53 INFO - PROCESS | 8466 | _x_x_mozilla_page_load 13:32:53 INFO - PROCESS | 8466 | _x_x_mozilla_page_load_details 13:32:53 INFO - PROCESS | 8466 | |i|pagename|runs| 13:32:53 INFO - PROCESS | 8466 | |0;ai-astar;107;116;116;118;115;117;118;118;116;115 13:32:53 INFO - PROCESS | 8466 | |1;audio-beat-detection;163;128;132;164;133;134;135;128;163;129 13:32:53 INFO - PROCESS | 8466 | |2;audio-dft;162;162;162;162;162;160;161;163;160;161 13:32:53 INFO - PROCESS | 8466 | |3;audio-fft;76;76;76;102;78;78;77;77;106;78 13:32:53 INFO - PROCESS | 8466 | |4;audio-oscillator;84;83;134;84;85;83;111;85;84;113 13:32:53 INFO - PROCESS | 8466 | |5;imaging-gaussian-blur;117;118;117;117;117;117;117;117;117;117 13:32:53 INFO - PROCESS | 8466 | |6;imaging-darkroom;147;147;146;147;147;147;147;146;147;146 13:32:53 INFO - PROCESS | 8466 | |7;imaging-desaturate;85;85;84;85;84;84;84;84;85;85 13:32:53 INFO - PROCESS | 8466 | |8;json-parse-financial;64;64;63;63;64;65;65;65;63;65 13:32:53 INFO - PROCESS | 8466 | |9;json-stringify-tinderbox;66;65;65;67;66;65;67;65;65;68 13:32:53 INFO - PROCESS | 8466 | |10;stanford-crypto-aes;86;85;85;93;88;92;84;85;84;86 13:32:53 INFO - PROCESS | 8466 | |11;stanford-crypto-ccm;158;141;146;156;147;152;141;140;190;144 13:32:53 INFO - PROCESS | 8466 | |12;stanford-crypto-pbkdf2;179;179;180;181;182;180;182;179;181;176 13:32:53 INFO - PROCESS | 8466 | |13;stanford-crypto-sha256-iterative;73;70;69;69;72;69;69;68;68;68 13:32:53 INFO - PROCESS | 8466 | __end_tp_report 13:32:53 INFO - PROCESS | 8466 | __start_cc_report 13:32:53 INFO - PROCESS | 8466 | _x_x_mozilla_cycle_collect,2000 13:32:53 INFO - PROCESS | 8466 | __end_cc_report 13:32:53 INFO - PROCESS | 8466 | __startTimestamp1479331973784__endTimestamp 13:32:53 INFO - PROCESS | 8466 | 13:32:53 INFO - PROCESS | 8466 | ------- Summary: start ------- 13:32:53 INFO - PROCESS | 8466 | Number of tests: 14 13:32:53 INFO - PROCESS | 8466 | 13:32:53 INFO - PROCESS | 8466 | [#0] ai-astar Cycles:10 Average:115.60 Median:116.50 stddev:3.24 (2.8%) stddev-sans-first:1.24 13:32:53 INFO - PROCESS | 8466 | Values: 107.0 116.0 116.0 118.0 115.0 117.0 118.0 118.0 116.0 115.0 13:32:53 INFO - PROCESS | 8466 | 13:32:53 INFO - PROCESS | 8466 | [#1] audio-beat-detection Cycles:10 Average:140.90 Median:134.50 stddev:15.67 (11.6%) stddev-sans-first:14.43 13:32:53 INFO - PROCESS | 8466 | Values: 163.0 128.0 132.0 164.0 133.0 134.0 135.0 128.0 163.0 129.0 13:32:53 INFO - PROCESS | 8466 | 13:32:53 INFO - PROCESS | 8466 | [#2] audio-dft Cycles:10 Average:161.50 Median:162.00 stddev:0.97 (0.6%) stddev-sans-first:1.01 13:32:53 INFO - PROCESS | 8466 | Values: 162.0 162.0 162.0 162.0 162.0 160.0 161.0 163.0 160.0 161.0 13:32:53 INFO - PROCESS | 8466 | 13:32:53 INFO - PROCESS | 8466 | [#3] audio-fft Cycles:10 Average:82.40 Median:77.00 stddev:11.45 (14.9%) stddev-sans-first:11.91 13:32:53 INFO - PROCESS | 8466 | Values: 76.0 76.0 76.0 102.0 78.0 78.0 77.0 77.0 106.0 78.0 13:32:53 INFO - PROCESS | 8466 | 13:32:53 INFO - PROCESS | 8466 | [#4] audio-oscillator Cycles:10 Average:94.60 Median:84.00 stddev:18.11 (21.6%) stddev-sans-first:18.79 13:32:53 INFO - PROCESS | 8466 | Values: 84.0 83.0 134.0 84.0 85.0 83.0 111.0 85.0 84.0 113.0 13:32:53 INFO - PROCESS | 8466 | 13:32:53 INFO - PROCESS | 8466 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 13:32:53 INFO - PROCESS | 8466 | Values: 117.0 118.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 13:32:53 INFO - PROCESS | 8466 | 13:32:53 INFO - PROCESS | 8466 | [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 13:32:53 INFO - PROCESS | 8466 | Values: 147.0 147.0 146.0 147.0 147.0 147.0 147.0 146.0 147.0 146.0 13:32:53 INFO - PROCESS | 8466 | 13:32:53 INFO - PROCESS | 8466 | [#7] imaging-desaturate Cycles:10 Average:84.50 Median:85.00 stddev:0.53 (0.6%) stddev-sans-first:0.53 13:32:53 INFO - PROCESS | 8466 | Values: 85.0 85.0 84.0 85.0 84.0 84.0 84.0 84.0 85.0 85.0 13:32:53 INFO - PROCESS | 8466 | 13:32:53 INFO - PROCESS | 8466 | [#8] json-parse-financial Cycles:10 Average:64.10 Median:64.50 stddev:0.88 (1.4%) stddev-sans-first:0.93 13:32:53 INFO - PROCESS | 8466 | Values: 64.0 64.0 63.0 63.0 64.0 65.0 65.0 65.0 63.0 65.0 13:32:53 INFO - PROCESS | 8466 | 13:32:53 INFO - PROCESS | 8466 | [#9] json-stringify-tinderbox Cycles:10 Average:65.90 Median:66.00 stddev:1.10 (1.7%) stddev-sans-first:1.17 13:32:53 INFO - PROCESS | 8466 | Values: 66.0 65.0 65.0 67.0 66.0 65.0 67.0 65.0 65.0 68.0 13:32:53 INFO - PROCESS | 8466 | 13:32:53 INFO - PROCESS | 8466 | [#10] stanford-crypto-aes Cycles:10 Average:86.80 Median:86.00 stddev:3.22 (3.7%) stddev-sans-first:3.41 13:32:53 INFO - PROCESS | 8466 | Values: 86.0 85.0 85.0 93.0 88.0 92.0 84.0 85.0 84.0 86.0 13:32:53 INFO - PROCESS | 8466 | 13:32:53 INFO - PROCESS | 8466 | [#11] stanford-crypto-ccm Cycles:10 Average:151.50 Median:149.50 stddev:14.92 (10.0%) stddev-sans-first:15.64 13:32:53 INFO - PROCESS | 8466 | Values: 158.0 141.0 146.0 156.0 147.0 152.0 141.0 140.0 190.0 144.0 13:32:53 INFO - PROCESS | 8466 | 13:32:53 INFO - PROCESS | 8466 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:179.90 Median:180.50 stddev:1.79 (1.0%) stddev-sans-first:1.87 13:32:53 INFO - PROCESS | 8466 | Values: 179.0 179.0 180.0 181.0 182.0 180.0 182.0 179.0 181.0 176.0 13:32:53 INFO - PROCESS | 8466 | 13:32:53 INFO - PROCESS | 8466 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.50 Median:69.00 stddev:1.72 (2.5%) stddev-sans-first:1.27 13:32:53 INFO - PROCESS | 8466 | Values: 73.0 70.0 69.0 69.0 72.0 69.0 69.0 68.0 68.0 68.0 13:32:53 INFO - PROCESS | 8466 | -------- Summary: end -------- 13:32:53 INFO - PROCESS | 8466 | 13:32:55 INFO - TEST-INFO | 8466: exit 0 13:32:55 INFO - TEST-OK | kraken | took 64813ms 13:32:55 INFO - SUITE-END | took 1187s 13:32:55 INFO - Completed test suite (00:19:48) 13:32:55 INFO - javascript benchmark 13:32:55 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2561.782248508877, 2581.045013345062, 2586.8965241390347, 2596.8571728554934, 2625.763681268686, 4646.558576935195, 4734.218853889109, 4741.051789642077, 4752.002079563295, 4763.976180119099, 4687.69529980551, 4713.528647135285, 4758.666893317469, 4760.047990401916, 4802.927956080653, 4293.162833247518, 4328.545502722216, 4366.585174408426, 4369.563043695637, 4380.5838445347645, 4398.626116780061, 4441.4004109445295, 4460.66545009124, 4474.932876006863, 4519.5028546859985, 4287.571242875719, 4423.270160423526, 4443.133588950156, 4444.822207111712, 4533.637309015271, 4306.418633484471, 4319.524852266248, 4338.501072376685, 4366.56334366564, 4405.0969551241915, 4339.305711086211, 4342.218400687875, 4347.586979236968, 4384.167008268419, 4397.758123303217, 4712.505186955389, 4714.504976977437, 4721.881952951169, 4731.455882573479, 4744.16977029022, 4945.208766597327, 5003.874903127415, 5006.048850718352, 5023.773930173151, 5066.544011038987, 5128.307678463397, 5170.0, 5174.0, 5200.063988482072, 5218.765155568009, 4799.112164249625, 4808.3027960945465, 4811.326414302001, 4814.133455977888, 4853.417589889236, 5043.52086551777, 5097.439281679012, 5248.76380562868, 5261.921071183935, 5267.0, 4932.062908047459, 4964.826231081967, 4973.35346404965, 4980.128477516492, 5049.394072711299, 5067.5439210470495, 5081.339425874613, 5081.74591270435, 5081.771320290596, 5128.820491282861, 4978.6763860348965, 4981.402231732215, 5013.298138260647, 5027.421846487628, 5032.345795046694, 4886.951130488721, 4942.728149951715, 4944.851654450372, 4980.800767969313, 4992.550670439605, 4313.633341165973, 4316.136772645484, 4316.482022157361, 4319.654427645781, 4320.071184695305, 3756.6431189037, 3791.2986097571484, 3794.582595914447, 3800.201957588882, 3820.7707537547835, 4467.754273514923, 4467.910641787146, 4480.126375356839, 4506.143832671782, 4508.977455112704, 5117.795288188431, 5148.150555158357, 5151.407588127413, 5158.845234642967, 5160.92258616121, 4280.143971205771, 4327.437433133672, 4453.710508816916, 4457.286834106528, 4474.105178964155, 4534.546545345505, 4556.794944227518, 4580.381648477412, 4606.608438282784, 4662.393888794503, 4784.043191361741, 4797.712137271775, 4800.207965685623, 4800.831970881002, 4851.296561998561, 5094.5669618082875, 5122.410922743932, 5135.820246291362, 5140.3831540215415, 5189.221616757516, 4671.299305104261, 4728.503507131839, 4736.052789442057, 4781.95218047829, 4789.018251258414, 5026.070177017264, 5036.269740887624, 5036.899262014813, 5037.974810126073, 5040.521150490697, 5095.286659867696, 5098.1588037973315, 5108.897822043613, 5115.872103197301, 5117.5394214520875, 4966.18058020437, 4968.105740966661, 4968.900621987467, 4971.825986090469, 4977.178765503651, 4889.0, 4924.409070911371, 4934.284528743384, 4939.975300123477, 4940.2342636891335, 4843.200871856105, 4889.462159162418, 4892.143874821821, 4895.045466134212, 4899.485554016777, 4940.209566469348, 4950.900981980412, 4955.6531042826655, 5002.599792016557, 5011.373578302712, 4908.82819101344, 4908.8772780680765, 4910.3125562422, 4913.533214344631, 4945.455999840086], "value": 4669.690797491718, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [536.131467023422, 555.2559570175963, 558.0485272610198, 559.6306437751085, 560.3863769172759, 26882.86558567207, 29230.853845730795, 29267.707322926763, 29270.26824329393, 37773.24453510935, 35324.47013294802, 39311.0, 39324.60675393245, 39353.21293574127, 39421.40867886984, 7451.776446706594, 7581.166071732105, 7591.658375373121, 7592.848143037136, 7595.278448547379, 7408.55548667079, 7434.479586428952, 7504.249575042507, 7510.887336689954, 7593.24067593239, 9449.385789923668, 9657.565409556586, 9694.22446204302, 9908.108270255676, 9940.701778946643, 9731.56207970643, 9787.902120978806, 9806.705798826046, 9818.0, 9818.214542836557, 9628.71113866585, 9684.41893486393, 9697.321187516876, 9698.224142068617, 9698.757531061709, 36473.0, 36740.44889326662, 36863.89408317755, 36873.0, 36888.815555922316, 2963.199936017263, 3005.248687828043, 3108.8134711917355, 3175.4125486784787, 3237.8542965566608, 27338.179854604394, 27554.0, 27657.308567285778, 28107.0, 29146.0, 3373.375925453799, 3402.574678165229, 3409.730839575203, 3413.5391722117442, 3463.5843698756057, 173801.0, 174838.12580937013, 175459.12270438566, 175461.0, 175671.0, 26975.730242697715, 51260.74369628128, 51635.741821290656, 51652.22521662178, 51657.483425165265, 32242.677573224435, 32322.0, 32399.51400728991, 32419.675803241666, 32520.349593008006, 13598.796018059737, 13720.93139534296, 13723.725525489433, 13736.793948090786, 13747.518836840663, 11469.770604587862, 11552.6534203974, 11570.19008669385, 11571.942140289413, 11577.3212884133, 6950.687219075154, 7158.391536719333, 7312.634368281565, 7500.849983000309, 7565.886511702329, 2979.9851000745293, 2996.5355369917697, 3031.8484075796564, 3037.2103253154337, 3043.7260646541476, 823.5923218007125, 858.5149390594419, 871.4771137317558, 885.2873436883242, 971.5142428785607, 26524.46951060968, 27681.584776228374, 27751.0, 27759.722402775715, 27993.860030700125, 894.7763059235191, 929.990700093004, 936.7236665183788, 997.4264797741328, 1025.8974102589682, 14003.789943150861, 14770.483033094006, 14773.778393324108, 15046.623834404227, 15104.848951510345, 319713.0, 321792.0, 321811.0, 322118.0, 324427.0, 41750.37374439386, 42550.36174457386, 47277.527224728, 48140.27789583159, 48736.26895596569, 1123.4270522033657, 1124.4153040418937, 1137.4426530999751, 1146.3236690352733, 1153.3541216918552, 27207.183784486497, 28005.15984520468, 28229.153125406272, 28919.566206506497, 29107.0, 42533.36199957065, 42968.570314296456, 42975.57024429716, 42976.0, 43004.35493467538, 542369.0, 559405.0, 561886.0, 562786.0, 563579.0, 36613.633863662086, 37005.629943700216, 37290.6270937298, 37476.43785343276, 37718.8114059428, 40939.0, 41138.38292425556, 41353.0, 42132.57867421286, 42177.578224218596, 35211.82394088116, 35302.117447064025, 35371.46942795809, 35449.645503544634, 35579.82210088933, 35069.298614027066, 35102.824485877405, 35155.824220878734, 35419.645803541636, 35528.289434211685, 34911.0, 35303.0, 35778.0, 35891.0, 36297.0, 30218.395632087675, 32063.519047214777, 32855.17862053468, 32923.34153316968, 33209.83395083009, 24714.258572242863, 24719.876400617883, 25047.248582542554, 25424.491510170064, 25481.0], "value": 16541.384006225366, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [312.70164292450494, 317.7299295598743, 330.5570535482454, 331.8373996741596, 332.6058620534666, 12337.938310308447, 15331.693366132671, 15816.525504234876, 16737.581560460996, 16898.83101168988, 16404.179791010432, 16438.084372907422, 16806.747898781497, 16938.40715574952, 17090.914545427288, 4683.789229484672, 4731.0, 4905.435874874382, 4929.605631549485, 4941.0, 4822.7829747661435, 4902.117618828609, 4908.533689299511, 4910.459849416561, 4916.729579873106, 4843.370361852972, 5150.922736158942, 5174.508421699932, 5223.843284701465, 5231.319928409302, 5239.161734122541, 5261.342332208474, 5266.631335806495, 5275.815346462875, 5278.049951008817, 5145.099607568661, 5188.429272779991, 5188.766505507261, 5190.948090519122, 5203.817866374697, 11060.22578419511, 11272.605458808903, 11312.377819219939, 21232.89383553088, 21688.566228675496, 1791.1133988675558, 1888.2447021191497, 2142.710734050914, 2187.0923566719794, 2562.6027965665353, 13814.930925345308, 14022.368993395321, 14337.0, 14398.352074156688, 14561.0, 1737.9826201737947, 1814.7005744052215, 1819.7816262048507, 1858.3681548273653, 1875.4186202277338, 67866.0, 82393.0, 82615.0, 83879.0, 85971.14028859757, 16283.0, 16617.50147495577, 16635.83364166367, 16814.915925420293, 16973.0, 28136.859315703292, 28209.43581128366, 28230.294242643686, 28314.858425708153, 28321.035055092303, 8142.4300298978505, 8698.0, 8842.381033327734, 9054.366194366332, 9062.275017998545, 7342.265773422615, 7349.375303099297, 7500.474966752384, 7567.3189412952, 7612.733554325683, 7948.6820527179425, 8258.215469530385, 8268.627911743986, 8381.371397145116, 8415.0, 2970.985145074304, 3024.3346463777934, 3059.281068948795, 3205.34290470453, 3303.7357011439026, 762.3367670127025, 858.5020688000944, 890.5636238243214, 920.1626519867023, 942.6936245720032, 16283.267252973645, 16591.751123733153, 16679.83320166783, 16873.156342183087, 17686.115694215237, 837.3050368194384, 853.1594645210619, 863.2058506174335, 888.0453512474116, 901.1034021148868, 8937.09067475289, 9231.676891308773, 9651.855222171673, 9661.951690241503, 9665.661701840401, 365715.0, 366458.17396390997, 368179.0, 370843.0, 373761.0, 44395.11209775786, 55797.16304255439, 63896.36103638997, 76266.23733762592, 77925.0, 862.7023676831483, 884.823035392924, 886.8714036464677, 889.5818965086399, 890.4657205676542, 14605.780913286522, 14781.113133212042, 14790.0, 14911.403543858125, 15460.304286306919, 35003.47494787529, 35887.46168807522, 36084.0, 36230.45654315135, 37196.0, 44809.0, 46766.298505521765, 50202.748986256294, 50256.49743502664, 50992.82129216777, 7195.784126476214, 7457.850842983002, 7557.5465472071855, 7722.806929826799, 8033.5983200838555, 11072.944635277094, 11284.21010529255, 11671.59149429766, 12336.81494777561, 12476.812847807472, 10341.63804266847, 10672.519736612026, 10699.358038517714, 10889.237753357189, 11101.0, 10617.362958222531, 10639.978404103196, 10816.837747433952, 10873.238873279111, 10888.510017049093, 6280.937190628035, 10139.442330671884, 10728.249022568345, 10958.616448424586, 11331.546738130382, 7295.598742069237, 7394.8890766639615, 7415.480916335805, 7531.246875312425, 7598.924010759822, 9825.0, 10562.683119506428, 10652.307600005975, 10741.677749667522, 11049.392283424168], "value": 8740.589355173606, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1214.5384753793558, 1317.8813906748392, 1344.7915573086173, 1364.6383708317292, 1612.467885597753, 6056.242969628796, 6647.302033286502, 6848.178218613761, 6852.6231057291825, 7063.6115013674225, 6911.48163887708, 6964.477664175181, 6964.582125072499, 6973.302669733037, 6973.44212463003, 2033.2273735980307, 2062.742157230346, 2072.3782865140474, 2076.4186027912133, 2078.511549785799, 2037.8777273363646, 2072.4611600983776, 2078.2206672497814, 2103.453102193433, 2108.7574928883223, 2024.6355655981918, 2041.0611118885256, 2043.867148635334, 2045.4681782736448, 2047.8873661948587, 2006.0571531380228, 2024.6355655981918, 2025.5138766695961, 2026.6858636911302, 2029.482481967089, 1995.0623207092788, 2001.0395010394946, 2052.6305265052283, 2057.763357213925, 2058.9485262868398, 6796.35434633709, 6817.69320380584, 6954.513184077116, 6956.130483689539, 6970.58176509406, 4167.2082304362075, 4346.847860324873, 4352.412424322739, 4354.912901741947, 4364.912701745979, 2668.49298633261, 2885.552739325408, 2950.114965510338, 2950.247686839842, 2950.7491863191653, 871.1158174452935, 873.1530415496958, 880.1682410122437, 884.3146561414891, 902.0798785239019, 9030.232430243437, 9082.954585227099, 9109.681161159328, 9116.5441727914, 9116.863247051233, 3453.846263813243, 3562.71498280137, 3619.674229319374, 3650.945235821465, 3652.397354436488, 7315.195328513965, 7328.853422931618, 7331.523450975669, 7333.230010848891, 7346.228645992201, 4182.435371224846, 4192.287311157111, 4193.035601811539, 4195.958040419557, 4198.538160802371, 3443.862245510202, 3551.5027896094566, 3700.1119731264303, 3840.2703486337505, 3907.257621051991, 2881.7838662100426, 2918.7664986801005, 3013.2015016020773, 3024.848757562113, 3034.4386288536693, 870.2994089757806, 876.6931573949067, 882.1531329923217, 888.8711136885245, 896.6996056321075, 783.3224261014182, 799.6121880887765, 804.3886646148969, 813.5728742410282, 827.6441130313902, 4758.500357462417, 4797.136515427187, 4800.73595952219, 4811.182099043171, 5137.152369859006, 377.9659830615258, 379.3210153824678, 394.31979834784767, 400.80961543267296, 878.5299864572423, 3016.75865930725, 3059.6940305969224, 3138.1213260287154, 3180.25264062945, 3219.436598595283, 7721.729739459204, 7722.111957125003, 7955.880661790078, 8016.078151012592, 8034.47775894565, 7960.283574478325, 7978.521288722579, 7982.84034319322, 7985.041794984639, 7987.440879138405, 6427.935720642734, 6479.838004049842, 6532.248791388956, 6587.703553340111, 6591.670416479157, 4452.376667266521, 4523.508506465716, 4529.411176547028, 4599.724016559017, 4601.0, 7692.384609231136, 7730.265624765639, 7741.612919354123, 7801.843963120819, 7806.024246969129, 7610.277023682741, 7685.769426917202, 7785.182555831782, 7786.805329866798, 7960.363170946426, 5373.919391209213, 5966.731497082728, 6133.325334213322, 6137.232845894263, 6138.508919286357, 6220.098085777447, 6284.120223168668, 6538.509611779041, 6555.180602424697, 6660.467162626881, 5886.087656413263, 6008.068749343859, 6026.819195424145, 6092.390760923872, 6165.136880836776, 5843.678597676999, 5902.1441890926435, 5913.408659134052, 6009.969950150221, 6110.114033465212, 5549.805756798492, 5620.578456615852, 5668.1214411764595, 5673.461021202979, 5679.716014199356, 4096.406021126861, 4139.77231252284, 4177.227212965611, 4233.618974292205, 4331.45856767904, 4144.109016561454, 4154.605312495308, 4167.97916010418, 4193.119444916601, 4400.581944715247], "value": 3638.4430491407584, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [275.9130873774761, 280.71226992332856, 282.14510034595173, 283.8694200667693, 285.6657710478739, 4734.1951868182405, 4791.353167322411, 4849.9515004849945, 4876.9756151219235, 4908.705477671342, 4752.691075080117, 4779.474257831635, 4793.352897358855, 4793.5446132617435, 4804.111239420709, 3521.982390088046, 3620.1130722972775, 3621.674049335559, 3755.09877629369, 3756.530433695788, 3699.981500092496, 3704.7221458390595, 3710.202306504101, 3717.423799311111, 3723.832427540767, 3676.466912297715, 3680.595134535199, 3681.723870709694, 3683.8894833154914, 3711.480392745018, 3527.7354198434964, 3535.1338921964284, 3627.2564124354444, 3700.5929347771857, 3707.888763337104, 3244.4160051190775, 3247.993122132123, 3255.7232635226032, 3262.4127657021727, 3263.233140212048, 4641.727582054644, 4645.279981602857, 4667.253239481666, 4667.789949452283, 4680.461746899116, 4129.421880936671, 4230.788460576959, 4234.17433600448, 4238.152369526107, 4245.299525578276, 4963.553280204799, 4979.875503112415, 4990.87522811929, 5001.224810154432, 5003.699778013331, 3520.8591656333715, 3524.8061356625376, 3534.929301413983, 3543.5216245806746, 3547.2728090741593, 5235.842924712265, 5238.319018527605, 5246.344206974129, 5249.947500524984, 5253.26454296395, 3341.548890899746, 3486.4073107571267, 3536.5932917714276, 3546.414841551167, 3629.691476224498, 3568.0, 3571.8571257149943, 3578.982105089458, 3588.8923332300074, 3592.1378869071236, 4087.9386809197886, 4112.362583799516, 4132.318167502329, 4146.647534959562, 4147.149834283965, 4787.473377928425, 5000.549950504472, 5003.574696150868, 5014.373203349582, 5049.772760225798, 1193.4390836307095, 1200.4597930931116, 1202.687301301668, 1213.6055781870928, 1213.7390461050916, 806.2632036783895, 815.4006804998321, 823.8558252305943, 827.8385714785679, 832.24681663095, 4285.914281714348, 4356.542563030899, 4393.714408563497, 4399.978000110043, 4425.867223983221, 5018.222175562793, 5167.689938603696, 5188.610854185951, 5211.687298762086, 5212.270282160501, 4489.326601009875, 4516.322551617283, 4516.412866327422, 4516.954830451654, 4547.636189104864, 2605.8436493810054, 2667.6932152802674, 2679.4641071785722, 2690.9865450672623, 2696.7999240338254, 4740.620750339965, 4760.214564596803, 4770.427548694179, 4773.515333806341, 4783.425988881357, 5196.804734910992, 5204.4535323791215, 5206.516142899255, 5208.114620514521, 5218.399884013311, 4529.909401811945, 4760.09558183944, 4773.451053128934, 4794.808207671724, 4795.136875362468, 5088.847334579968, 5109.569320590241, 5111.258867464123, 5121.411037730709, 5144.6109550421925, 5012.649114561946, 5015.648904576645, 5023.447420783637, 5039.949600504095, 5048.192289233852, 4638.0, 4790.904181916412, 4811.542903424309, 4920.655554111321, 4963.776630051729, 3727.5154229949935, 3728.757630753992, 3738.3457894867747, 3741.0834345585504, 3766.6986641069198, 5241.161414173714, 5257.89484210306, 5267.604929630216, 5281.260623512788, 5282.445343239058, 4885.975570122268, 5036.445990941067, 5078.898422031612, 5108.974455127701, 5146.228065790161, 5031.609985256973, 5035.395752509722, 5049.84850454487, 5062.835547823947, 5077.466865979167, 4995.575376093073, 4996.0, 4996.525330093636, 5022.899542009212, 5030.220315851049, 4783.760811959319, 5043.671177023147, 5076.796928122833, 5089.338386009795, 5094.490550944876, 4773.570378665937, 4871.853844384674, 4884.0, 5017.498250174954, 5035.496450354935], "value": 3744.418749421162, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [618.7024051314742, 663.6681659170417, 678.7556479667322, 703.6446594469792, 714.8820444626635, 11874.28754274743, 12989.285589292585, 12994.935025324883, 13008.609741707764, 13019.958403327735, 12135.968442682382, 12215.51137954483, 12217.328046957413, 12218.694532636688, 12224.0, 605.7062324772481, 621.2793159934477, 722.5231347310776, 739.3493725521533, 744.3115118515352, 743.788020414182, 747.137056699513, 750.8310630108236, 750.9586972716498, 751.2600088912417, 796.77690246731, 798.4331124901327, 798.7084714079377, 799.0331698644646, 799.3645052183499, 631.3875540725489, 784.5763287824568, 785.0579304834222, 786.6499407763519, 789.9960500197491, 475.0475297029434, 552.7098273406453, 566.2695123290949, 566.3713278261126, 567.1209625081108, 12017.699557511045, 12045.759084818255, 12053.0960177987, 12063.21589096706, 12068.21556598827, 11192.720181995515, 11253.0, 11490.195686301962, 11622.6513204604, 12102.791377821708, 10741.194410419172, 10909.563617455293, 10921.726956826144, 11034.834477482844, 11091.44542772858, 3122.9063128106195, 3221.291315910496, 3351.8156501392414, 3388.15296175956, 3939.2515422069714, 45763.31355029677, 47101.0, 47707.0, 50653.49346506488, 51464.485355146346, 9677.70966870995, 9875.456849873326, 10115.190784737351, 10152.695419137437, 10548.47257637115, 17401.303947841945, 17603.11984400775, 17699.20353584092, 17737.645247094984, 17922.283108675507, 6266.561340706106, 6308.4007019334, 6420.74317027323, 6431.839204019937, 6450.903236451457, 3301.6863397977154, 3400.4219282721997, 3409.7101746351836, 3520.6655367740022, 3540.0, 2681.8927242910454, 2763.2677340504783, 2764.3365592257715, 2764.9447011059665, 2771.875265613012, 476.56156336170807, 480.97114173149726, 482.312704396234, 484.51790468484086, 496.238274249026, 547.3404547520229, 586.6274915428648, 609.4182825484747, 610.9419605137505, 632.4718859752066, 7282.745103921337, 7430.294122058396, 7580.810479738051, 7960.641771120314, 7962.840743185104, 501.92471129330164, 517.6247220764915, 530.186164237893, 547.255732204202, 557.8159207461528, 3277.2466730299175, 3536.8938931832085, 3654.8720794772057, 3720.7581507201944, 3881.4177873318663, 39716.0, 40876.59123408787, 65441.0, 65557.67221163864, 65643.0, 34000.829995850356, 34381.312373752386, 35876.46185307222, 49198.26202606892, 57748.422515774306, 51643.225351619, 51678.48321516812, 52088.47911520912, 52965.7351713239, 53255.73372133115, 7241.927580724126, 7344.559326440431, 7359.0, 7515.098188217449, 7584.5070070445245, 32480.0, 34483.65516344804, 36369.636303636624, 37017.0, 37583.43624845575, 34263.65736342605, 45416.77291613653, 45999.08001840011, 46267.76866115648, 46888.06223875435, 10184.949075254577, 10292.332212501435, 10417.9479102604, 10615.256932014685, 10663.626773063215, 11266.887331126913, 11671.708207294885, 11690.415479225834, 12025.158238923192, 12136.878631213927, 10888.346699198073, 10923.563057477611, 10993.560257589927, 11560.826587601025, 11768.94115529417, 10824.67525974222, 10830.133589312994, 11031.448427578749, 11059.944700276446, 11578.94210528942, 10561.10230630405, 10920.56317747313, 11067.059299959594, 11611.187216894736, 11633.011194048262, 8554.401191916506, 8922.330825188266, 8974.19232269099, 8981.506017169118, 8996.820063598821, 8239.546824924686, 9242.768930776516, 9283.11810378013, 9376.451956175071, 9445.716628501155], "value": 5844.72473626906, "unit": "score"}], "name": "dromaeo_css", "value": 6143.556581649953, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 116.0, 116.0, 118.0, 115.0, 117.0, 118.0, 118.0, 116.0, 115.0], "value": 115.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 128.0, 132.0, 164.0, 133.0, 134.0, 135.0, 128.0, 163.0, 129.0], "value": 140.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 162.0, 162.0, 162.0, 160.0, 161.0, 163.0, 160.0, 161.0], "value": 161.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 102.0, 78.0, 78.0, 77.0, 77.0, 106.0, 78.0], "value": 82.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 134.0, 84.0, 85.0, 83.0, 111.0, 85.0, 84.0, 113.0], "value": 94.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 146.0, 147.0, 147.0, 147.0, 147.0, 146.0, 147.0, 146.0], "value": 146.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 84.0, 85.0, 84.0, 84.0, 84.0, 84.0, 85.0, 85.0], "value": 84.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 63.0, 63.0, 64.0, 65.0, 65.0, 65.0, 63.0, 65.0], "value": 64.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 65.0, 67.0, 66.0, 65.0, 67.0, 65.0, 65.0, 68.0], "value": 65.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 85.0, 93.0, 88.0, 92.0, 84.0, 85.0, 84.0, 86.0], "value": 86.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 141.0, 146.0, 156.0, 147.0, 152.0, 141.0, 140.0, 190.0, 144.0], "value": 151.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [179.0, 179.0, 180.0, 181.0, 182.0, 180.0, 182.0, 179.0, 181.0, 176.0], "value": 179.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 70.0, 69.0, 69.0, 72.0, 69.0, 69.0, 68.0, 68.0, 68.0], "value": 69.5, "unit": "score"}], "name": "kraken", "value": 1561.0, "alertThreshold": 2.0}]} 13:32:55 INFO - Return code: 0 13:32:55 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:32:55 INFO - # TBPL SUCCESS # 13:32:55 INFO - Running post-action listener: _resource_record_post_action 13:32:55 INFO - [mozharness: 2016-11-16 21:32:55.591045Z] Finished run-tests step (success) 13:32:55 INFO - Running post-run listener: _resource_record_post_run 13:32:55 INFO - Total resource usage - Wall time: 1204s; CPU: 13.0%; Read bytes: 4096; Write bytes: 406888448; Read time: 8; Write time: 226836 13:32:55 INFO - TinderboxPrint: CPU usage
13.1% 13:32:55 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 13:32:55 INFO - TinderboxPrint: I/O write bytes / time
406,888,448 / 226,836 13:32:55 INFO - TinderboxPrint: CPU idle
8,348.6 (86.9%) 13:32:55 INFO - TinderboxPrint: CPU user
1,208.2 (12.6%) 13:32:55 INFO - TinderboxPrint: Swap in / out
0 / 0 13:32:55 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 115847168; Read time: 0; Write time: 58284 13:32:55 INFO - run-tests - Wall time: 1189s; CPU: 13.0%; Read bytes: 0; Write bytes: 290148352; Read time: 0; Write time: 168528 13:32:56 INFO - Running post-run listener: _upload_blobber_files 13:32:56 INFO - Blob upload gear active. 13:32:56 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:32:56 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 13:32:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Larch-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 13:32:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Larch-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 13:32:56 INFO - (blobuploader) - INFO - Open directory for files ... 13:32:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 13:32:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:32:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:32:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 13:32:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:32:57 INFO - (blobuploader) - INFO - Done attempting. 13:32:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:32:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:32:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:33:00 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:33:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:33:00 INFO - (blobuploader) - INFO - Done attempting. 13:33:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 13:33:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:33:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:33:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 13:33:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:33:01 INFO - (blobuploader) - INFO - Done attempting. 13:33:01 INFO - (blobuploader) - INFO - Iteration through files over. 13:33:01 INFO - Return code: 0 13:33:01 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:33:01 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:33:01 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/e1c726b46c36e124d74c508425f930507b1e40f8a7776efbfba4ecf9211185f4ca91a32ac589cadad3276e28af2c8d5b2f392628f1552dac0a9880645bddbd26", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/15e9f6b8c764cbb671b6f1b75301289eebb4424722f3a9724359dd694ea43186f73205733d694ee4c8eb84e841399b8375626055edbcb7ce811203cb4b4a2c8a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/039627144ebb12765e62f59d4c1e9eabf4d4b823dbca200f50e9f4f06e708daf7cba2bbff4f0f13070861f0617234eb3fe3ff20e90266bb84e34b2b930e9b78d"} 13:33:01 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:33:01 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:33:01 INFO - Contents: 13:33:01 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/e1c726b46c36e124d74c508425f930507b1e40f8a7776efbfba4ecf9211185f4ca91a32ac589cadad3276e28af2c8d5b2f392628f1552dac0a9880645bddbd26", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/15e9f6b8c764cbb671b6f1b75301289eebb4424722f3a9724359dd694ea43186f73205733d694ee4c8eb84e841399b8375626055edbcb7ce811203cb4b4a2c8a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/039627144ebb12765e62f59d4c1e9eabf4d4b823dbca200f50e9f4f06e708daf7cba2bbff4f0f13070861f0617234eb3fe3ff20e90266bb84e34b2b930e9b78d"} 13:33:01 INFO - Running post-run listener: copy_logs_to_upload_dir 13:33:01 INFO - Copying logs to upload dir... 13:33:01 INFO - mkdir: /builds/slave/test/build/upload/logs 13:33:01 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.451189 ========= master_lag: 0.25 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-11-16 13:33:00.960953) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-16 13:33:00.967760) ========= 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=232498196343f89f466a4a9a000001c8-1479329177.668491-1164925588 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/e1c726b46c36e124d74c508425f930507b1e40f8a7776efbfba4ecf9211185f4ca91a32ac589cadad3276e28af2c8d5b2f392628f1552dac0a9880645bddbd26", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/15e9f6b8c764cbb671b6f1b75301289eebb4424722f3a9724359dd694ea43186f73205733d694ee4c8eb84e841399b8375626055edbcb7ce811203cb4b4a2c8a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/039627144ebb12765e62f59d4c1e9eabf4d4b823dbca200f50e9f4f06e708daf7cba2bbff4f0f13070861f0617234eb3fe3ff20e90266bb84e34b2b930e9b78d"} build_url:https://queue.taskcluster.net/v1/task/V88YIN3vQT-q01pw9WKF7g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011615 build_url: 'https://queue.taskcluster.net/v1/task/V88YIN3vQT-q01pw9WKF7g/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/Larch-Non-PGO/sha512/e1c726b46c36e124d74c508425f930507b1e40f8a7776efbfba4ecf9211185f4ca91a32ac589cadad3276e28af2c8d5b2f392628f1552dac0a9880645bddbd26", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/15e9f6b8c764cbb671b6f1b75301289eebb4424722f3a9724359dd694ea43186f73205733d694ee4c8eb84e841399b8375626055edbcb7ce811203cb4b4a2c8a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/039627144ebb12765e62f59d4c1e9eabf4d4b823dbca200f50e9f4f06e708daf7cba2bbff4f0f13070861f0617234eb3fe3ff20e90266bb84e34b2b930e9b78d"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-16 13:33:00.995950) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-16 13:33:00.996301) ========= 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=232498196343f89f466a4a9a000001c8-1479329177.668491-1164925588 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004606 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-16 13:33:01.045313) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-16 13:33:01.046242) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-16 13:33:01.046560) ========= ========= Total master_lag: 0.45 =========