builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-039 starttime: 1476156838.83 results: success (0) buildid: 20161010190246 builduid: 7f33addd608340a5a58202a0880d13b1 revision: a38df6f51b67ca3cd2de921dcfbb8cc8d5208973 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-10 20:33:58.831590) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-10 20:33:58.832285) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-10 20:33:58.832630) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-10 20:33:58.923789) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-10 20:33:58.924082) ========= 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=5bd038846534b2fdfa68eeae000001e2-1476156406.407747-1304478935 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-10 20:33:58-- 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% 77.2M=0s 2016-10-10 20:33:59 (77.2 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.171701 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-10 20:33:59.110852) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-10 20:33:59.111208) ========= 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=5bd038846534b2fdfa68eeae000001e2-1476156406.407747-1304478935 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.086951 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-10 20:33:59.212014) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-10 20:33:59.212441) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev a38df6f51b67ca3cd2de921dcfbb8cc8d5208973 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev a38df6f51b67ca3cd2de921dcfbb8cc8d5208973 --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=5bd038846534b2fdfa68eeae000001e2-1476156406.407747-1304478935 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-10 20:33:59,272 truncating revision to first 12 chars 2016-10-10 20:33:59,272 Setting DEBUG logging. 2016-10-10 20:33:59,272 attempt 1/10 2016-10-10 20:33:59,272 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/a38df6f51b67?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-10 20:33:59,637 unpacking tar archive at: mozilla-central-a38df6f51b67/testing/mozharness/ program finished with exit code 0 elapsedTime=0.723307 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-10 20:33:59.950157) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-10 20:33:59.950509) ========= script_repo_revision: a38df6f51b67ca3cd2de921dcfbb8cc8d5208973 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-10 20:33:59.950956) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-10 20:33:59.951297) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-10 20:33:59.962286) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2016-10-10 20:33:59.962651) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5bd038846534b2fdfa68eeae000001e2-1476156406.407747-1304478935 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:34:00 INFO - MultiFileLogger online at 20161010 20:34:00 in /builds/slave/test 20:34:00 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 20:34:00 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:34:00 INFO - {'append_to_log': False, 20:34:00 INFO - 'base_work_dir': '/builds/slave/test', 20:34:00 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 20:34:00 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:34:00 INFO - 'branch': 'Firefox-Non-PGO', 20:34:00 INFO - 'buildbot_json_path': 'buildprops.json', 20:34:00 INFO - 'config_files': ('talos/linux_config.py',), 20:34:00 INFO - 'default_actions': ('clobber', 20:34:00 INFO - 'read-buildbot-config', 20:34:00 INFO - 'download-and-extract', 20:34:00 INFO - 'populate-webroot', 20:34:00 INFO - 'create-virtualenv', 20:34:00 INFO - 'install', 20:34:00 INFO - 'run-tests'), 20:34:00 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:34:00 INFO - 'download_minidump_stackwalk': True, 20:34:00 INFO - 'download_symbols': 'ondemand', 20:34:00 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:34:00 INFO - 'tooltool.py': '/tools/tooltool.py', 20:34:00 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:34:00 INFO - '/tools/misc-python/virtualenv.py')}, 20:34:00 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:34:00 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:34:00 INFO - 'installer_path': 'installer.exe', 20:34:00 INFO - 'log_level': 'info', 20:34:00 INFO - 'log_name': 'talos', 20:34:00 INFO - 'log_to_console': True, 20:34:00 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:34:00 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:34:00 INFO - 'opt_config_files': (), 20:34:00 INFO - 'pip_index': False, 20:34:00 INFO - 'sps_profile': False, 20:34:00 INFO - 'sps_profile_interval': 0, 20:34:00 INFO - 'suite': 'dromaeojs', 20:34:00 INFO - 'system_bits': '32', 20:34:00 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:34:00 INFO - 'title': 'talos-linux64-ix-039', 20:34:00 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:34:00 INFO - 'use_talos_json': True, 20:34:00 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:34:00 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:34:00 INFO - 'work_dir': 'build'} 20:34:00 INFO - [mozharness: 2016-10-11 03:34:00.217194Z] Running clobber step. 20:34:00 INFO - Running pre-action listener: _resource_record_pre_action 20:34:00 INFO - Running main action method: clobber 20:34:00 INFO - rmtree: /builds/slave/test/build 20:34:00 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:34:04 INFO - Running post-action listener: _resource_record_post_action 20:34:04 INFO - [mozharness: 2016-10-11 03:34:04.843188Z] Finished clobber step (success) 20:34:04 INFO - [mozharness: 2016-10-11 03:34:04.843334Z] Running read-buildbot-config step. 20:34:04 INFO - Running pre-action listener: _resource_record_pre_action 20:34:04 INFO - Running main action method: read_buildbot_config 20:34:04 INFO - Using buildbot properties: 20:34:04 INFO - { 20:34:04 INFO - "project": "", 20:34:04 INFO - "product": "firefox", 20:34:04 INFO - "script_repo_revision": "production", 20:34:04 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 20:34:04 INFO - "repository": "", 20:34:04 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 20:34:04 INFO - "buildid": "20161010190246", 20:34:04 INFO - "pgo_build": "False", 20:34:04 INFO - "basedir": "/builds/slave/test", 20:34:04 INFO - "buildnumber": 241, 20:34:04 INFO - "slavename": "talos-linux64-ix-039", 20:34:04 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 20:34:04 INFO - "platform": "ubuntu64_hw", 20:34:04 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 20:34:04 INFO - "branch": "mozilla-central", 20:34:04 INFO - "repo_path": "mozilla-central", 20:34:04 INFO - "revision": "a38df6f51b67ca3cd2de921dcfbb8cc8d5208973", 20:34:04 INFO - "stage_platform": "linux64", 20:34:04 INFO - "builduid": "7f33addd608340a5a58202a0880d13b1", 20:34:04 INFO - "slavebuilddir": "test" 20:34:04 INFO - } 20:34:04 INFO - Found installer url https://queue.taskcluster.net/v1/task/QZspG1aPQOW9z4FOXHJNBA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 20:34:04 INFO - Running post-action listener: _resource_record_post_action 20:34:04 INFO - [mozharness: 2016-10-11 03:34:04.846384Z] Finished read-buildbot-config step (success) 20:34:04 INFO - [mozharness: 2016-10-11 03:34:04.846495Z] Running download-and-extract step. 20:34:04 INFO - Running pre-action listener: _resource_record_pre_action 20:34:04 INFO - Running main action method: download_and_extract 20:34:04 INFO - mkdir: /builds/slave/test/build/tests 20:34:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:34:04 INFO - trying https://queue.taskcluster.net/v1/task/QZspG1aPQOW9z4FOXHJNBA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 20:34:04 INFO - Downloading https://queue.taskcluster.net/v1/task/QZspG1aPQOW9z4FOXHJNBA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 20:34:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QZspG1aPQOW9z4FOXHJNBA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 20:34:05 INFO - Downloaded 1361 bytes. 20:34:05 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 20:34:05 INFO - Using the following test package requirements: 20:34:05 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 20:34:05 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 20:34:05 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 20:34:05 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 20:34:05 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 20:34:05 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 20:34:05 INFO - u'jsshell-linux-x86_64.zip'], 20:34:05 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 20:34:05 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 20:34:05 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 20:34:05 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 20:34:05 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 20:34:05 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 20:34:05 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 20:34:05 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 20:34:05 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 20:34:05 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 20:34:05 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 20:34:05 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 20:34:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QZspG1aPQOW9z4FOXHJNBA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 20:34:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QZspG1aPQOW9z4FOXHJNBA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 20:34:05 INFO - Fetch https://queue.taskcluster.net/v1/task/QZspG1aPQOW9z4FOXHJNBA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 20:34:06 INFO - Http code: 200 20:34:06 INFO - via: 1.1 d897b81191cbfd68a1b6fc44f98c52b0.cloudfront.net (CloudFront) 20:34:06 INFO - x-amz-cf-id: gQob0c3Ow7fM3IpsKuxiTHNVVhtNgK4Rc4DRPMSNqH4AfGTASbqskg== 20:34:06 INFO - x-amz-version-id: akU9kTged6aHAhHxbrJbYPpWAdzBm1TN 20:34:06 INFO - Expected file size: 20517119 20:34:06 INFO - Obtained file size: 20517119 20:34:10 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 20:34:10 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QZspG1aPQOW9z4FOXHJNBA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 20:34:10 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QZspG1aPQOW9z4FOXHJNBA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 20:34:10 INFO - Fetch https://queue.taskcluster.net/v1/task/QZspG1aPQOW9z4FOXHJNBA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 20:34:10 INFO - Http code: 200 20:34:10 INFO - via: 1.1 41b2ee7cbe95749816a7586d9ab4629d.cloudfront.net (CloudFront) 20:34:10 INFO - x-amz-cf-id: RpciDUfrt6Ofdpm3S7ryDVRkLmNl16E5e9sTMMGNWFtT8_yKj4LcAg== 20:34:10 INFO - x-amz-version-id: akU9kTged6aHAhHxbrJbYPpWAdzBm1TN 20:34:11 INFO - Expected file size: 20517119 20:34:11 INFO - Obtained file size: 20517119 20:34:15 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QZspG1aPQOW9z4FOXHJNBA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 20:34:15 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QZspG1aPQOW9z4FOXHJNBA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 20:34:15 INFO - Fetch https://queue.taskcluster.net/v1/task/QZspG1aPQOW9z4FOXHJNBA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 20:34:16 INFO - Http code: 200 20:34:16 INFO - via: 1.1 20f1c35f343f4b271ae8dcacfd7ea0e9.cloudfront.net (CloudFront) 20:34:16 INFO - x-amz-cf-id: djYh2X2BomXW9Ovx9jr_TZL6z-lH76_FCxf0VWTkYfZocpPXucuKPQ== 20:34:16 INFO - x-amz-version-id: InFgbNqElXu96e1aJeJZVF0bO5A62HNX 20:34:16 INFO - Expected file size: 14409006 20:34:16 INFO - Obtained file size: 14409006 20:34:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:34:16 INFO - trying https://queue.taskcluster.net/v1/task/QZspG1aPQOW9z4FOXHJNBA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 20:34:16 INFO - Downloading https://queue.taskcluster.net/v1/task/QZspG1aPQOW9z4FOXHJNBA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 20:34:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QZspG1aPQOW9z4FOXHJNBA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 20:34:17 INFO - Downloaded 55859133 bytes. 20:34:17 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/QZspG1aPQOW9z4FOXHJNBA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 20:34:17 INFO - mkdir: /builds/slave/test/properties 20:34:17 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:34:17 INFO - Writing to file /builds/slave/test/properties/build_url 20:34:17 INFO - Contents: 20:34:17 INFO - build_url:https://queue.taskcluster.net/v1/task/QZspG1aPQOW9z4FOXHJNBA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 20:34:21 INFO - Running post-action listener: _resource_record_post_action 20:34:21 INFO - Running post-action listener: set_extra_try_arguments 20:34:21 INFO - [mozharness: 2016-10-11 03:34:21.398024Z] Finished download-and-extract step (success) 20:34:21 INFO - [mozharness: 2016-10-11 03:34:21.398249Z] Running populate-webroot step. 20:34:21 INFO - Running pre-action listener: _resource_record_pre_action 20:34:21 INFO - Running main action method: populate_webroot 20:34:21 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:34:21 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:34:21 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:34:21 INFO - '--tppagecycles', 20:34:21 INFO - '7'], 20:34:21 INFO - 'tests': ['tsvgm']}}, 20:34:21 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:34:21 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:34:21 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:34:21 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:34:21 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:34:21 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:34:21 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:34:21 INFO - 'talos_options': ['--disable-e10s'], 20:34:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:34:21 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:34:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:34:21 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:34:21 INFO - 'talos_options': ['--disable-e10s'], 20:34:21 INFO - 'tests': ['damp', 'tps']}, 20:34:21 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:34:21 INFO - 'tests': ['damp', 'tps']}, 20:34:21 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:34:21 INFO - 'tests': ['dromaeo_dom']}, 20:34:21 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:34:21 INFO - 'g4': {'talos_options': ['--disable-e10s'], 20:34:21 INFO - 'tests': ['basic_compositor_video']}, 20:34:21 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 20:34:21 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:34:21 INFO - 'tests': ['a11yr', 20:34:21 INFO - 'ts_paint', 20:34:21 INFO - 'tpaint', 20:34:21 INFO - 'sessionrestore', 20:34:21 INFO - 'sessionrestore_no_auto_restore', 20:34:21 INFO - 'tabpaint']}, 20:34:21 INFO - 'other-e10s': {'tests': ['a11yr', 20:34:21 INFO - 'ts_paint', 20:34:21 INFO - 'tpaint', 20:34:21 INFO - 'sessionrestore', 20:34:21 INFO - 'sessionrestore_no_auto_restore', 20:34:21 INFO - 'tabpaint']}, 20:34:21 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:34:21 INFO - 'ts_paint', 20:34:21 INFO - 'tpaint', 20:34:21 INFO - 'sessionrestore', 20:34:21 INFO - 'sessionrestore_no_auto_restore', 20:34:21 INFO - 'tabpaint']}, 20:34:21 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:34:21 INFO - 'ts_paint', 20:34:21 INFO - 'tpaint', 20:34:21 INFO - 'sessionrestore', 20:34:21 INFO - 'sessionrestore_no_auto_restore', 20:34:21 INFO - 'tabpaint']}, 20:34:21 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:34:21 INFO - 'tests': ['a11yr', 20:34:21 INFO - 'ts_paint', 20:34:21 INFO - 'tpaint', 20:34:21 INFO - 'sessionrestore', 20:34:21 INFO - 'sessionrestore_no_auto_restore', 20:34:21 INFO - 'tabpaint']}, 20:34:21 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:34:21 INFO - 'tests': ['a11yr', 20:34:21 INFO - 'ts_paint', 20:34:21 INFO - 'tpaint', 20:34:21 INFO - 'sessionrestore', 20:34:21 INFO - 'sessionrestore_no_auto_restore', 20:34:21 INFO - 'tabpaint']}, 20:34:21 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:34:21 INFO - 'tests': ['tsvgx', 20:34:21 INFO - 'tsvgr_opacity', 20:34:21 INFO - 'tart', 20:34:21 INFO - 'tscrollx', 20:34:21 INFO - 'cart']}, 20:34:21 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:34:21 INFO - 'tsvgr_opacity', 20:34:21 INFO - 'tart', 20:34:21 INFO - 'tscrollx', 20:34:21 INFO - 'cart']}, 20:34:21 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:34:21 INFO - 'talos_options': ['--disable-e10s'], 20:34:21 INFO - 'tests': ['tp5o']}, 20:34:21 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:34:21 INFO - 'tests': ['tp5o']}, 20:34:21 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:34:21 INFO - 'talos_options': ['--disable-e10s', 20:34:21 INFO - '--xperf_path', 20:34:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:34:21 INFO - 'tests': ['tp5n']}, 20:34:21 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:34:21 INFO - 'talos_options': ['--xperf_path', 20:34:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:34:21 INFO - 'tests': ['tp5n']}}, 20:34:21 INFO - 'talos.zip': {'path': '', 20:34:21 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:34:21 INFO - Running post-action listener: _resource_record_post_action 20:34:21 INFO - [mozharness: 2016-10-11 03:34:21.414642Z] Finished populate-webroot step (success) 20:34:21 INFO - [mozharness: 2016-10-11 03:34:21.414729Z] Running create-virtualenv step. 20:34:21 INFO - Running pre-action listener: _resource_record_pre_action 20:34:21 INFO - Running main action method: create_virtualenv 20:34:21 INFO - Creating virtualenv /builds/slave/test/build/venv 20:34:21 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 20:34:21 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:34:21 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:34:21 INFO - Using real prefix '/usr' 20:34:21 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:34:22 INFO - Installing distribute.............................................................................................................................................................................................done. 20:34:24 INFO - Installing pip.................done. 20:34:24 INFO - Return code: 0 20:34:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 20:34:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 20:34:24 INFO - Reading from file tmpfile_stdout 20:34:25 INFO - Output received: 20:34:25 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 20:34:25 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:34:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:34:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:34:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:34:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:34:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:34:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:34:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f927f03ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x162c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16f9ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16f6f60>, '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 0x16f7d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16f81d0>, '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': '5bd038846534b2fdfa68eeae000001e2-1476156406.407747-1304478935', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:34:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 20:34:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 20:34:25 INFO - Using env: {'DISPLAY': ':0', 20:34:25 INFO - 'HOME': '/home/cltbld', 20:34:25 INFO - 'LANG': 'en_US.UTF-8', 20:34:25 INFO - 'LANGUAGE': 'en_US:en', 20:34:25 INFO - 'LOGNAME': 'cltbld', 20:34:25 INFO - 'MAIL': '/var/mail/cltbld', 20:34:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:34:25 INFO - 'MOZ_NO_REMOTE': '1', 20:34:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:34:25 INFO - 'NO_EM_RESTART': '1', 20:34:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:34:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:34:25 INFO - 'PWD': '/builds/slave/test', 20:34:25 INFO - 'SHELL': '/bin/bash', 20:34:25 INFO - 'SHLVL': '1', 20:34:25 INFO - 'TERM': 'linux', 20:34:25 INFO - 'TMOUT': '86400', 20:34:25 INFO - 'USER': 'cltbld', 20:34:25 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1476156406.407747-1304478935', 20:34:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:34:25 INFO - '_': '/tools/buildbot/bin/python'} 20:34:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:34:25 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 20:34:25 INFO - Cleaning up... 20:34:25 INFO - Return code: 0 20:34:25 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 20:34:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:34:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:34:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:34:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:34:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:34:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:34:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f927f03ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x162c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16f9ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16f6f60>, '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 0x16f7d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16f81d0>, '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': '5bd038846534b2fdfa68eeae000001e2-1476156406.407747-1304478935', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:34:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 20:34:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 20:34:25 INFO - Using env: {'DISPLAY': ':0', 20:34:25 INFO - 'HOME': '/home/cltbld', 20:34:25 INFO - 'LANG': 'en_US.UTF-8', 20:34:25 INFO - 'LANGUAGE': 'en_US:en', 20:34:25 INFO - 'LOGNAME': 'cltbld', 20:34:25 INFO - 'MAIL': '/var/mail/cltbld', 20:34:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:34:25 INFO - 'MOZ_NO_REMOTE': '1', 20:34:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:34:25 INFO - 'NO_EM_RESTART': '1', 20:34:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:34:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:34:25 INFO - 'PWD': '/builds/slave/test', 20:34:25 INFO - 'SHELL': '/bin/bash', 20:34:25 INFO - 'SHLVL': '1', 20:34:25 INFO - 'TERM': 'linux', 20:34:25 INFO - 'TMOUT': '86400', 20:34:25 INFO - 'USER': 'cltbld', 20:34:25 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1476156406.407747-1304478935', 20:34:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:34:25 INFO - '_': '/tools/buildbot/bin/python'} 20:34:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:34:25 INFO - Downloading/unpacking psutil>=3.1.1 20:34:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:34:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:34:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:34:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:34:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:34:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:34:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:34:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:34:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:34:27 INFO - Installing collected packages: psutil 20:34:27 INFO - Running setup.py install for psutil 20:34:27 INFO - building 'psutil._psutil_linux' extension 20:34:27 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 20:34:28 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 20:34:28 INFO - building 'psutil._psutil_posix' extension 20:34:28 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 20:34:28 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 20:34:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:34:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:34:28 INFO - Successfully installed psutil 20:34:28 INFO - Cleaning up... 20:34:28 INFO - Return code: 0 20:34:28 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 20:34:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:34:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:34:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:34:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:34:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:34:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:34:28 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 0x7f927f03ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x162c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16f9ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16f6f60>, '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 0x16f7d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16f81d0>, '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': '5bd038846534b2fdfa68eeae000001e2-1476156406.407747-1304478935', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:34:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 20:34:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 20:34:28 INFO - Using env: {'DISPLAY': ':0', 20:34:28 INFO - 'HOME': '/home/cltbld', 20:34:28 INFO - 'LANG': 'en_US.UTF-8', 20:34:28 INFO - 'LANGUAGE': 'en_US:en', 20:34:28 INFO - 'LOGNAME': 'cltbld', 20:34:28 INFO - 'MAIL': '/var/mail/cltbld', 20:34:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:34:28 INFO - 'MOZ_NO_REMOTE': '1', 20:34:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:34:28 INFO - 'NO_EM_RESTART': '1', 20:34:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:34:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:34:28 INFO - 'PWD': '/builds/slave/test', 20:34:28 INFO - 'SHELL': '/bin/bash', 20:34:28 INFO - 'SHLVL': '1', 20:34:28 INFO - 'TERM': 'linux', 20:34:28 INFO - 'TMOUT': '86400', 20:34:28 INFO - 'USER': 'cltbld', 20:34:28 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1476156406.407747-1304478935', 20:34:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:34:28 INFO - '_': '/tools/buildbot/bin/python'} 20:34:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:34:29 INFO - Downloading/unpacking mozsystemmonitor==0.3 20:34:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:34:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:34:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:34:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:34:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:34:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:34:31 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:34:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:34:31 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 20:34:31 INFO - Installing collected packages: mozsystemmonitor 20:34:31 INFO - Running setup.py install for mozsystemmonitor 20:34:31 INFO - Successfully installed mozsystemmonitor 20:34:31 INFO - Cleaning up... 20:34:31 INFO - Return code: 0 20:34:31 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 20:34: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')]} 20:34:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:34:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:34: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')]} 20:34:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:34:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:34: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', '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 0x7f927f03ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x162c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16f9ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16f6f60>, '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 0x16f7d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16f81d0>, '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': '5bd038846534b2fdfa68eeae000001e2-1476156406.407747-1304478935', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:34: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 20:34: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 jsonschema==2.5.1 20:34:31 INFO - Using env: {'DISPLAY': ':0', 20:34:31 INFO - 'HOME': '/home/cltbld', 20:34:31 INFO - 'LANG': 'en_US.UTF-8', 20:34:31 INFO - 'LANGUAGE': 'en_US:en', 20:34:31 INFO - 'LOGNAME': 'cltbld', 20:34:31 INFO - 'MAIL': '/var/mail/cltbld', 20:34:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:34:31 INFO - 'MOZ_NO_REMOTE': '1', 20:34:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:34:31 INFO - 'NO_EM_RESTART': '1', 20:34:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:34:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:34:31 INFO - 'PWD': '/builds/slave/test', 20:34:31 INFO - 'SHELL': '/bin/bash', 20:34:31 INFO - 'SHLVL': '1', 20:34:31 INFO - 'TERM': 'linux', 20:34:31 INFO - 'TMOUT': '86400', 20:34:31 INFO - 'USER': 'cltbld', 20:34:31 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1476156406.407747-1304478935', 20:34:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:34:31 INFO - '_': '/tools/buildbot/bin/python'} 20:34:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:34:31 INFO - Downloading/unpacking jsonschema==2.5.1 20:34: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 20:34: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 20:34: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 20:34: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 20:34: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 20:34: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 20:34:33 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:34:33 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 20:34:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:34:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:34:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:34:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:34:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:34:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:34:33 INFO - Downloading functools32-3.2.3-2.tar.gz 20:34:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:34:33 INFO - warning: no files found matching '*.txt' 20:34:33 INFO - no previously-included directories found matching 'build' 20:34:33 INFO - no previously-included directories found matching 'dist' 20:34:33 INFO - no previously-included directories found matching '.git*' 20:34:33 INFO - Installing collected packages: jsonschema, functools32 20:34:33 INFO - Running setup.py install for functools32 20:34:33 INFO - warning: no files found matching '*.txt' 20:34:33 INFO - no previously-included directories found matching 'build' 20:34:33 INFO - no previously-included directories found matching 'dist' 20:34:33 INFO - no previously-included directories found matching '.git*' 20:34:33 INFO - Successfully installed jsonschema functools32 20:34:33 INFO - Cleaning up... 20:34:33 INFO - Return code: 0 20:34:33 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 20:34:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:34:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:34:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:34:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:34:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:34:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:34:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f927f03ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x162c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16f9ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16f6f60>, '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 0x16f7d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16f81d0>, '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': '5bd038846534b2fdfa68eeae000001e2-1476156406.407747-1304478935', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:34:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 20:34:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 20:34:33 INFO - Using env: {'DISPLAY': ':0', 20:34:33 INFO - 'HOME': '/home/cltbld', 20:34:33 INFO - 'LANG': 'en_US.UTF-8', 20:34:33 INFO - 'LANGUAGE': 'en_US:en', 20:34:33 INFO - 'LOGNAME': 'cltbld', 20:34:33 INFO - 'MAIL': '/var/mail/cltbld', 20:34:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:34:33 INFO - 'MOZ_NO_REMOTE': '1', 20:34:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:34:33 INFO - 'NO_EM_RESTART': '1', 20:34:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:34:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:34:33 INFO - 'PWD': '/builds/slave/test', 20:34:33 INFO - 'SHELL': '/bin/bash', 20:34:33 INFO - 'SHLVL': '1', 20:34:33 INFO - 'TERM': 'linux', 20:34:33 INFO - 'TMOUT': '86400', 20:34:33 INFO - 'USER': 'cltbld', 20:34:33 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1476156406.407747-1304478935', 20:34:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:34:33 INFO - '_': '/tools/buildbot/bin/python'} 20:34:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:34:34 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 20:34:34 INFO - Cleaning up... 20:34:34 INFO - Return code: 0 20:34:34 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:34: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')]} 20:34:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:34:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:34: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')]} 20:34:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:34:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:34: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', '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 0x7f927f03ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x162c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16f9ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16f6f60>, '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 0x16f7d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16f81d0>, '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': '5bd038846534b2fdfa68eeae000001e2-1476156406.407747-1304478935', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:34: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 20:34: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 blobuploader==1.2.4 20:34:34 INFO - Using env: {'DISPLAY': ':0', 20:34:34 INFO - 'HOME': '/home/cltbld', 20:34:34 INFO - 'LANG': 'en_US.UTF-8', 20:34:34 INFO - 'LANGUAGE': 'en_US:en', 20:34:34 INFO - 'LOGNAME': 'cltbld', 20:34:34 INFO - 'MAIL': '/var/mail/cltbld', 20:34:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:34:34 INFO - 'MOZ_NO_REMOTE': '1', 20:34:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:34:34 INFO - 'NO_EM_RESTART': '1', 20:34:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:34:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:34:34 INFO - 'PWD': '/builds/slave/test', 20:34:34 INFO - 'SHELL': '/bin/bash', 20:34:34 INFO - 'SHLVL': '1', 20:34:34 INFO - 'TERM': 'linux', 20:34:34 INFO - 'TMOUT': '86400', 20:34:34 INFO - 'USER': 'cltbld', 20:34:34 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1476156406.407747-1304478935', 20:34:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:34:34 INFO - '_': '/tools/buildbot/bin/python'} 20:34:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:34:34 INFO - Downloading/unpacking blobuploader==1.2.4 20:34: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 20:34: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 20:34: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 20:34: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 20:34: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 20:34: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 20:34:36 INFO - Downloading blobuploader-1.2.4.tar.gz 20:34:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:34:36 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:34:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:34:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:34:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:34:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:34:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:34:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:34:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:34:36 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:34:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:34:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:34:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:34:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:34:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:34:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:34:37 INFO - Downloading docopt-0.6.1.tar.gz 20:34:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:34:37 INFO - Installing collected packages: blobuploader, requests, docopt 20:34:37 INFO - Running setup.py install for blobuploader 20:34:37 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:34:37 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:34:37 INFO - Running setup.py install for requests 20:34:37 INFO - Running setup.py install for docopt 20:34:37 INFO - Successfully installed blobuploader requests docopt 20:34:37 INFO - Cleaning up... 20:34:37 INFO - Return code: 0 20:34:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:34:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:34:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:34:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:34:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:34:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:34:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:34:37 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 0x7f927f03ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x162c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16f9ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16f6f60>, '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 0x16f7d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16f81d0>, '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': '5bd038846534b2fdfa68eeae000001e2-1476156406.407747-1304478935', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:34:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 20:34:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 20:34:37 INFO - Using env: {'DISPLAY': ':0', 20:34:37 INFO - 'HOME': '/home/cltbld', 20:34:37 INFO - 'LANG': 'en_US.UTF-8', 20:34:37 INFO - 'LANGUAGE': 'en_US:en', 20:34:37 INFO - 'LOGNAME': 'cltbld', 20:34:37 INFO - 'MAIL': '/var/mail/cltbld', 20:34:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:34:37 INFO - 'MOZ_NO_REMOTE': '1', 20:34:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:34:37 INFO - 'NO_EM_RESTART': '1', 20:34:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:34:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:34:37 INFO - 'PWD': '/builds/slave/test', 20:34:37 INFO - 'SHELL': '/bin/bash', 20:34:37 INFO - 'SHLVL': '1', 20:34:37 INFO - 'TERM': 'linux', 20:34:37 INFO - 'TMOUT': '86400', 20:34:37 INFO - 'USER': 'cltbld', 20:34:37 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1476156406.407747-1304478935', 20:34:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:34:37 INFO - '_': '/tools/buildbot/bin/python'} 20:34:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:34:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:34:37 INFO - Running setup.py (path:/tmp/pip-nbiMyh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:34:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:34:38 INFO - Running setup.py (path:/tmp/pip-2Gh_F3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:34:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:34:38 INFO - Running setup.py (path:/tmp/pip-TP08R8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:34:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:34:38 INFO - Running setup.py (path:/tmp/pip-TgSael-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:34:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:34:38 INFO - Running setup.py (path:/tmp/pip-ye7y42-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:34:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:34:38 INFO - Running setup.py (path:/tmp/pip-2nWgzR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:34:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:34:38 INFO - Running setup.py (path:/tmp/pip-63Gmq8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:34:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:34:38 INFO - Running setup.py (path:/tmp/pip-_5XE2A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:34:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:34:38 INFO - Running setup.py (path:/tmp/pip-IF4atj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:34:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:34:38 INFO - Running setup.py (path:/tmp/pip-pXFWg6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:34:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:34:38 INFO - Running setup.py (path:/tmp/pip-SiYCl0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:34:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:34:38 INFO - Running setup.py (path:/tmp/pip-TtlAsD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:34:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:34:38 INFO - Running setup.py (path:/tmp/pip-gnnIY6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:34:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:34:38 INFO - Running setup.py (path:/tmp/pip-zT1Bkp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:34:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:34:38 INFO - Running setup.py (path:/tmp/pip-X3UDfg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:34:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:34:39 INFO - Running setup.py (path:/tmp/pip-MClPwX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:34:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:34:39 INFO - Running setup.py (path:/tmp/pip-C7xUWo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:34:39 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:34:39 INFO - Running setup.py install for manifestparser 20:34:39 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:34:39 INFO - Running setup.py install for mozcrash 20:34:39 INFO - Running setup.py install for mozdebug 20:34:39 INFO - Running setup.py install for mozdevice 20:34:39 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:34:39 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:34:39 INFO - Running setup.py install for mozfile 20:34:39 INFO - Running setup.py install for mozhttpd 20:34:39 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:34:39 INFO - Running setup.py install for mozinfo 20:34:39 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:34:39 INFO - Running setup.py install for mozInstall 20:34:39 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:34:39 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:34:39 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:34:39 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:34:39 INFO - Running setup.py install for mozleak 20:34:40 INFO - Running setup.py install for mozlog 20:34:40 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:34:40 INFO - Running setup.py install for moznetwork 20:34:40 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:34:40 INFO - Running setup.py install for mozprocess 20:34:40 INFO - Running setup.py install for mozprofile 20:34:40 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:34:40 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:34:40 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:34:40 INFO - Running setup.py install for mozrunner 20:34:40 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:34:40 INFO - Running setup.py install for mozscreenshot 20:34:40 INFO - Running setup.py install for moztest 20:34:40 INFO - Running setup.py install for mozversion 20:34:40 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:34:40 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:34:40 INFO - Cleaning up... 20:34:40 INFO - Return code: 0 20:34:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:34:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:34:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:34:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:34:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:34:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:34:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:34:40 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 0x7f927f03ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x162c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16f9ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16f6f60>, '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 0x16f7d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16f81d0>, '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': '5bd038846534b2fdfa68eeae000001e2-1476156406.407747-1304478935', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:34:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 20:34:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 20:34:40 INFO - Using env: {'DISPLAY': ':0', 20:34:40 INFO - 'HOME': '/home/cltbld', 20:34:40 INFO - 'LANG': 'en_US.UTF-8', 20:34:40 INFO - 'LANGUAGE': 'en_US:en', 20:34:40 INFO - 'LOGNAME': 'cltbld', 20:34:40 INFO - 'MAIL': '/var/mail/cltbld', 20:34:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:34:40 INFO - 'MOZ_NO_REMOTE': '1', 20:34:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:34:40 INFO - 'NO_EM_RESTART': '1', 20:34:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:34:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:34:40 INFO - 'PWD': '/builds/slave/test', 20:34:40 INFO - 'SHELL': '/bin/bash', 20:34:40 INFO - 'SHLVL': '1', 20:34:40 INFO - 'TERM': 'linux', 20:34:40 INFO - 'TMOUT': '86400', 20:34:40 INFO - 'USER': 'cltbld', 20:34:40 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1476156406.407747-1304478935', 20:34:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:34:40 INFO - '_': '/tools/buildbot/bin/python'} 20:34:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:34:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:34:41 INFO - Running setup.py (path:/tmp/pip-KrW5_W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:34:41 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 20:34:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:34:41 INFO - Running setup.py (path:/tmp/pip-Apoor1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:34:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 20:34:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:34:41 INFO - Running setup.py (path:/tmp/pip-NEAwkZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:34:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 20:34:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:34:41 INFO - Running setup.py (path:/tmp/pip-hEwycX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:34:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 20:34:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:34:41 INFO - Running setup.py (path:/tmp/pip-bqUuG3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:34:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 20:34:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:34:41 INFO - Running setup.py (path:/tmp/pip-duBjK1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:34:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 20:34:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:34:41 INFO - Running setup.py (path:/tmp/pip-dC3NOR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:34:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 20:34:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:34:41 INFO - Running setup.py (path:/tmp/pip-beyhZ9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:34:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 20:34:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:34:41 INFO - Running setup.py (path:/tmp/pip-K0YpjM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:34:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 20:34:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:34:41 INFO - Running setup.py (path:/tmp/pip-HDAlfR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:34:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:34:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:34:41 INFO - Running setup.py (path:/tmp/pip-4InTuT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:34:41 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 20:34:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:34:41 INFO - Running setup.py (path:/tmp/pip-a60Txz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:34:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 20:34:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:34:42 INFO - Running setup.py (path:/tmp/pip-_d6orh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:34:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 20:34:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:34:42 INFO - Running setup.py (path:/tmp/pip-_MlmMg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:34:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 20:34:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:34:42 INFO - Running setup.py (path:/tmp/pip-6b_pva-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:34:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 20:34:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:34:42 INFO - Running setup.py (path:/tmp/pip-NxnFyi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:34:42 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 20:34:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:34:42 INFO - Running setup.py (path:/tmp/pip-xfWV1L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:34:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 20:34:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 20:34:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 20:34:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 20:34:42 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 20:34:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 20:34:42 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:34: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 20:34: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 20:34: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 20:34: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 20:34: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 20:34: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 20:34:44 INFO - Downloading blessings-1.6.tar.gz 20:34:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:34:44 INFO - Installing collected packages: blessings 20:34:44 INFO - Running setup.py install for blessings 20:34:44 INFO - Successfully installed blessings 20:34:44 INFO - Cleaning up... 20:34:44 INFO - Return code: 0 20:34:44 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:34:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:34:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:34:44 INFO - Reading from file tmpfile_stdout 20:34:44 INFO - Current package versions: 20:34:44 INFO - argparse == 1.2.1 20:34:44 INFO - blessings == 1.6 20:34:44 INFO - blobuploader == 1.2.4 20:34:44 INFO - docopt == 0.6.1 20:34:44 INFO - functools32 == 3.2.3-2 20:34:44 INFO - jsonschema == 2.5.1 20:34:44 INFO - manifestparser == 1.1 20:34:44 INFO - mozInstall == 1.12 20:34:44 INFO - mozcrash == 0.17 20:34:44 INFO - mozdebug == 0.1 20:34:44 INFO - mozdevice == 0.48 20:34:44 INFO - mozfile == 1.2 20:34:44 INFO - mozhttpd == 0.7 20:34:44 INFO - mozinfo == 0.9 20:34:44 INFO - mozleak == 0.1 20:34:44 INFO - mozlog == 3.4 20:34:44 INFO - moznetwork == 0.27 20:34:44 INFO - mozprocess == 0.23 20:34:44 INFO - mozprofile == 0.28 20:34:44 INFO - mozrunner == 6.12 20:34:44 INFO - mozscreenshot == 0.1 20:34:44 INFO - mozsystemmonitor == 0.3 20:34:44 INFO - moztest == 0.7 20:34:44 INFO - mozversion == 1.4 20:34:44 INFO - psutil == 3.1.1 20:34:44 INFO - requests == 1.2.3 20:34:44 INFO - wsgiref == 0.1.2 20:34:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:34:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:34:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:34:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:34:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:34:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:34:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:34:44 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 0x7f927f03ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x162c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16f9ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16f6f60>, '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 0x16f7d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16f81d0>, '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': '5bd038846534b2fdfa68eeae000001e2-1476156406.407747-1304478935', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:34:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 20:34:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 20:34:44 INFO - Using env: {'DISPLAY': ':0', 20:34:44 INFO - 'HOME': '/home/cltbld', 20:34:44 INFO - 'LANG': 'en_US.UTF-8', 20:34:44 INFO - 'LANGUAGE': 'en_US:en', 20:34:44 INFO - 'LOGNAME': 'cltbld', 20:34:44 INFO - 'MAIL': '/var/mail/cltbld', 20:34:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:34:44 INFO - 'MOZ_NO_REMOTE': '1', 20:34:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:34:44 INFO - 'NO_EM_RESTART': '1', 20:34:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:34:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:34:44 INFO - 'PWD': '/builds/slave/test', 20:34:44 INFO - 'SHELL': '/bin/bash', 20:34:44 INFO - 'SHLVL': '1', 20:34:44 INFO - 'TERM': 'linux', 20:34:44 INFO - 'TMOUT': '86400', 20:34:44 INFO - 'USER': 'cltbld', 20:34:44 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1476156406.407747-1304478935', 20:34:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:34:44 INFO - '_': '/tools/buildbot/bin/python'} 20:34:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:34:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 20:34:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 20:34:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 20:34:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 20:34:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 20:34:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 20:34:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 20:34:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 20:34:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 20:34:45 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 20:34:45 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 20:34:45 INFO - Cleaning up... 20:34:45 INFO - Return code: 0 20:34:45 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:34:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:34:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:34:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:34:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:34:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:34:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:34:45 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 0x7f927f03ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x162c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16f9ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16f6f60>, '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 0x16f7d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16f81d0>, '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': '5bd038846534b2fdfa68eeae000001e2-1476156406.407747-1304478935', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:34:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 20:34:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 20:34:45 INFO - Using env: {'DISPLAY': ':0', 20:34:45 INFO - 'HOME': '/home/cltbld', 20:34:45 INFO - 'LANG': 'en_US.UTF-8', 20:34:45 INFO - 'LANGUAGE': 'en_US:en', 20:34:45 INFO - 'LOGNAME': 'cltbld', 20:34:45 INFO - 'MAIL': '/var/mail/cltbld', 20:34:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:34:45 INFO - 'MOZ_NO_REMOTE': '1', 20:34:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:34:45 INFO - 'NO_EM_RESTART': '1', 20:34:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:34:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:34:45 INFO - 'PWD': '/builds/slave/test', 20:34:45 INFO - 'SHELL': '/bin/bash', 20:34:45 INFO - 'SHLVL': '1', 20:34:45 INFO - 'TERM': 'linux', 20:34:45 INFO - 'TMOUT': '86400', 20:34:45 INFO - 'USER': 'cltbld', 20:34:45 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1476156406.407747-1304478935', 20:34:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:34:45 INFO - '_': '/tools/buildbot/bin/python'} 20:34:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:34:45 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 20:34:45 INFO - Cleaning up... 20:34:45 INFO - Return code: 0 20:34:45 INFO - Running post-action listener: _resource_record_post_action 20:34:45 INFO - Running post-action listener: _start_resource_monitoring 20:34:45 INFO - Starting resource monitoring. 20:34:45 INFO - [mozharness: 2016-10-11 03:34:45.347200Z] Finished create-virtualenv step (success) 20:34:45 INFO - [mozharness: 2016-10-11 03:34:45.348279Z] Running install step. 20:34:45 INFO - Running pre-action listener: _resource_record_pre_action 20:34:45 INFO - Running main action method: install 20:34:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:34:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:34:45 INFO - Reading from file tmpfile_stdout 20:34:45 INFO - Detecting whether we're running mozinstall >=1.0... 20:34:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:34:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:34:45 INFO - Reading from file tmpfile_stdout 20:34:45 INFO - Output received: 20:34:45 INFO - Usage: mozinstall [options] installer 20:34:45 INFO - Options: 20:34:45 INFO - -h, --help show this help message and exit 20:34:45 INFO - -d DEST, --destination=DEST 20:34:45 INFO - Directory to install application into. [default: 20:34:45 INFO - "/builds/slave/test"] 20:34:45 INFO - --app=APP Application being installed. [default: firefox] 20:34:45 INFO - mkdir: /builds/slave/test/build/application 20:34:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 20:34:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 20:35:01 INFO - Reading from file tmpfile_stdout 20:35:01 INFO - Output received: 20:35:01 INFO - /builds/slave/test/build/application/firefox/firefox 20:35:01 INFO - Running post-action listener: _resource_record_post_action 20:35:01 INFO - [mozharness: 2016-10-11 03:35:01.811013Z] Finished install step (success) 20:35:01 INFO - [mozharness: 2016-10-11 03:35:01.811258Z] Running run-tests step. 20:35:01 INFO - Running pre-action listener: _resource_record_pre_action 20:35:01 INFO - Running main action method: run_tests 20:35:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:35:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:35:01 INFO - Python 2.7.3 20:35:01 INFO - Return code: 0 20:35:01 INFO - grabbing minidump binary from tooltool 20:35:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:35:01 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 0x16f6f60>, '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 0x16f7d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16f81d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:35:01 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 20:35:01 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 20:35:01 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 20:35:01 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:35:01 INFO - Return code: 0 20:35:01 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 20:35:01 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:35:01 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:35:01 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 20:35:01 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:35:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QZspG1aPQOW9z4FOXHJNBA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-039', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 20:35:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/QZspG1aPQOW9z4FOXHJNBA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-039 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 20:35:01 INFO - Using env: {'DISPLAY': ':0', 20:35:01 INFO - 'HOME': '/home/cltbld', 20:35:01 INFO - 'LANG': 'en_US.UTF-8', 20:35:01 INFO - 'LANGUAGE': 'en_US:en', 20:35:01 INFO - 'LOGNAME': 'cltbld', 20:35:01 INFO - 'MAIL': '/var/mail/cltbld', 20:35:01 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:35:01 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 20:35:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:35:01 INFO - 'MOZ_NO_REMOTE': '1', 20:35:01 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:35:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:35:01 INFO - 'NO_EM_RESTART': '1', 20:35:01 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:35:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:35:01 INFO - 'PWD': '/builds/slave/test', 20:35:01 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:35:01 INFO - 'SHELL': '/bin/bash', 20:35:01 INFO - 'SHLVL': '1', 20:35:01 INFO - 'TERM': 'linux', 20:35:01 INFO - 'TMOUT': '86400', 20:35:01 INFO - 'USER': 'cltbld', 20:35:01 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1476156406.407747-1304478935', 20:35:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:35:01 INFO - '_': '/tools/buildbot/bin/python'} 20:35:01 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QZspG1aPQOW9z4FOXHJNBA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-039', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 20:35:02 INFO - mozversion application_buildid: 20161010190246 20:35:02 INFO - mozversion application_changeset: a38df6f51b67ca3cd2de921dcfbb8cc8d5208973 20:35:02 INFO - mozversion application_display_name: Nightly 20:35:02 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:35:02 INFO - mozversion application_name: Firefox 20:35:02 INFO - mozversion application_remotingname: firefox 20:35:02 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 20:35:02 INFO - mozversion application_vendor: Mozilla 20:35:02 INFO - mozversion application_version: 52.0a1 20:35:02 INFO - mozversion platform_buildid: 20161010190246 20:35:02 INFO - mozversion platform_changeset: a38df6f51b67ca3cd2de921dcfbb8cc8d5208973 20:35:02 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 20:35:02 INFO - mozversion platform_version: 52.0a1 20:35:02 INFO - using testdate: 1476156902 20:35:02 INFO - actual date: 1476156902 20:35:02 INFO - starting webserver on 'localhost:41711' 20:35:02 INFO - SUITE-START | Running 2 tests 20:35:02 INFO - TEST-START | dromaeo_css 20:35:02 INFO - operating with platform_type : linux_ 20:35:02 INFO - Initialising browser for dromaeo_css test... 20:35:02 INFO - TEST-INFO | started process 3340 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8fiTyy/profile http://localhost:41711/getInfo.html) 20:35:08 INFO - PROCESS | 3340 | __metrics Screen width/height:1600/1200 20:35:08 INFO - PROCESS | 3340 | colorDepth:24 20:35:08 INFO - PROCESS | 3340 | Browser inner width/height: 1024/697 20:35:08 INFO - PROCESS | 3340 | __metrics 20:35:08 INFO - PROCESS | 3340 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 20:35:08 INFO - PROCESS | 3340 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:35:09 INFO - PROCESS | 3340 | console.error: PushService: 20:35:09 INFO - PROCESS | 3340 | stateChangeProcessEnqueue: Error transitioning state 20:35:09 INFO - PROCESS | 3340 | UnknownError 20:35:10 INFO - TEST-INFO | 3340: exit 0 20:35:10 INFO - Browser initialized. 20:35:10 INFO - Running cycle 1/1 for dromaeo_css test... 20:35:10 INFO - TEST-INFO | started process 3422 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8fiTyy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:35:22 INFO - PROCESS | 3422 | RSS: Main: 174530560 20:35:22 INFO - PROCESS | 3422 | 20:36:13 INFO - PROCESS | 3422 | 1476156973783 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 20:38:27 INFO - PROCESS | 3422 | Cycle 1(1): loaded http://localhost:41711/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41711/tests/dromaeo/cssquery-ext.html) 20:38:28 INFO - PROCESS | 3422 | RSS: Main: 291184640 20:38:28 INFO - PROCESS | 3422 | 20:41:31 INFO - PROCESS | 3422 | Cycle 1(1): loaded http://localhost:41711/tests/dromaeo/cssquery-ext.html (next: http://localhost:41711/tests/dromaeo/cssquery-jquery.html) 20:41:32 INFO - PROCESS | 3422 | RSS: Main: 271654912 20:41:32 INFO - PROCESS | 3422 | 20:44:34 INFO - PROCESS | 3422 | Cycle 1(1): loaded http://localhost:41711/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41711/tests/dromaeo/cssquery-mootools.html) 20:44:35 INFO - PROCESS | 3422 | RSS: Main: 251224064 20:44:35 INFO - PROCESS | 3422 | 20:47:37 INFO - PROCESS | 3422 | Cycle 1(1): loaded http://localhost:41711/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41711/tests/dromaeo/cssquery-prototype.html) 20:47:38 INFO - PROCESS | 3422 | RSS: Main: 244871168 20:47:38 INFO - PROCESS | 3422 | 20:50:41 INFO - PROCESS | 3422 | Cycle 1(1): loaded http://localhost:41711/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41711/tests/dromaeo/cssquery-yui.html) 20:50:41 INFO - PROCESS | 3422 | RSS: Main: 219643904 20:50:41 INFO - PROCESS | 3422 | 20:53:44 INFO - PROCESS | 3422 | Cycle 1(1): loaded http://localhost:41711/tests/dromaeo/cssquery-yui.html (next: http://localhost:41711/tests/dromaeo/cssquery-dojo.html) 20:53:45 INFO - PROCESS | 3422 | RSS: Main: 313290752 20:53:45 INFO - PROCESS | 3422 | 20:53:45 INFO - PROCESS | 3422 | __start_tp_report 20:53:45 INFO - PROCESS | 3422 | _x_x_mozilla_page_load 20:53:45 INFO - PROCESS | 3422 | _x_x_mozilla_page_load_details 20:53:45 INFO - PROCESS | 3422 | |i|pagename|runs| 20:53:45 INFO - PROCESS | 3422 | |0;dojo.html;2533.835300705454;2561.103613735194;2603.557395242809;2609.360706626877;2610.4518051209243;4368.082702632451;4418.072204836988;4448.132614140244;4475.910481790366;4511.323301504772;4462.821487140511;4513.232750432426;4536.27419612862;4546.931796023054;4623.8381656642105;4178.56125106864;4232.724872883253;4245.490541135068;4247.83008679654;4262.019735460846;4186.706930514865;4205.7897105144775;4224.514180869209;4237.957620423803;4272.703384746566;4290.313549832027;4304.935425968613;4347.260965635834;4360.106178233455;4364.912701745963;4080.0819815541267;4097.09863829957;4119.732217405859;4202.012527056139;4228.873133805991;4142.668586513072;4146.108586653853;4196.664266858644;4246.532881383046;4247.447831781879;4493.146302202571;4498.662600304958;4503.301988191835;4505.662075344329;4571.748553829538;4797.808087676489;4857.465678775332;4858.46556878743;4861.8784530386665;4915.877103072416;4580.839670611546;4590.931136032962;4754.786034628415;4786.066716990188;4799.2801079837955;4488;4491.73049617024;4498.977505112453;4543.023250001233;4544.818207271738;4880.95119048805;4884.902301953941;4890.144224760724;4891;4948.331975183376;4606.216943119678;4654.534546545318;4700.764961751899;4712.458067322234;4720.669553131248;4809.591184749335;4819.638527110411;4819.759012049453;4871.707697538088;4883.877903052452;4772.475027746945;4777.187878060738;4780.856574302707;4834.468208497063;4843.346148270009;4606.101810146989;4650.720956742606;4651.720896746206;4731.077439899255;4746.762661866962;3971.543272523697;3991.960080399159;4034.9394759078637;4035.1727895781883;4085.325921222965;3585.175409655794;3609.2601016791496;3615.240799432149;3647.708183345379;3659.341318562631;4106.3840423936645;4194.874153775391;4197.895052623709;4198.328267477189;4243.787810609457;4722.325477659599;4790.257510085942;4832.637552183601;4839.782209800567;4914.950850491521;4192.496900371914;4217.093324935154;4220.451341325608;4222.19778242133;4276.18752437036;4180.6446452051305;4324.740515569013;4326.437563116775;4328.350747387854;4363.650907927358;4547.613452856544;4652.3719297895705;4681.742504162304;4688.484266730588;4756.881077973078;4827.348307978378;4849.563539281482;4859.222524396079;4861.222204447272;4920.015996800583;4680.391549098732;4688.2733176357715;4691.648126390466;4695.154872122914;4753.334533165291;4619.538046195354;4663.790129444251;4753.524647535219;4788.066327066189;4796.640251981045;4868.878278043077;4871.464138944784;4886.657933944732;4911.607071434348;4940.184869496637;4721.291806229093;4724.881877952941;4728.787204575733;4729.054189162112;4784.856454306377;4573.268277075652;4619.14545809013;4693.788779504862;4716.29255611661;4731.29030645406;4653.208954477679;4667.393238878924;4670.416197975253;4714.15145273854;4733.597644200144;4746.572808447257;4760.262159365304;4761.666683332133;4762.714237145782;4801.087793319258;4472.888177795581;4510.729356238636;4512.6615503838;4628.35203071577;4705.364775755229 20:53:45 INFO - PROCESS | 3422 | |1;ext.html;548.5858177076308;549.146077848945;550.3643291997744;566.0377358490567;569.1974316214137;26292.342691432725;26939.057133000348;38231.808840955826;39096.413553796716;39136.60863391365;38733.612663873355;39094.609053909524;39168.02079947996;39196.41205381914;39231.803840980756;7542.283483069114;7702.42231832612;7704.499207551519;7705.845883082335;7706.229377062305;7646.044244469442;7723.845523089535;7733.45865789395;7733.53598784072;7736.149023607427;7722.691092356299;7765.767026989171;7767.495112817649;7781;7781.649825757854;7703.4222433317445;7718.498297610638;7745.380369570477;7747.418943579198;7752.26353496417;7610.695572177106;7701.807454813618;7708.383329333696;7708.884366734504;7708.884366734504;36863.262734745425;37166.25667486662;37226.627733722584;37246.441303380474;37264;2843.118633223707;2974.677586369206;3068.186930463429;3235.6279027911855;3285.983570082158;27753.583696244572;28045;28410.71589284122;29132.70867291321;29538.409231815243;3489.476578513243;3558.4128618777872;3610.7472476926628;3612.259486805199;3743.101655602663;173937;175268;175311;175719;175841;31032;51251.48748512542;51605.22592161121;51668.48331516637;51730.48269517332;31613.84193079066;31746;31795.682043179735;31822;31825;13172.934135329453;13258.73482530344;13286.3356832158;13291.734165316639;13298.66753331155;11184.720381990515;11211.887881121247;11236.94381528087;11307;11309.547618095348;7329.486935914435;7358.1170259568125;7420;7470.178280389153;7472.17806041335;3075.2158199658943;3083.260017595806;3102.255458689943;3119.4696901526795;3122.859471323796;858.3948316436897;893.4326702543801;903.7288813356098;928.7538802217417;998.256299057207;27082.72917270802;27706;27744;28087.157385278475;28179.859100704365;923.3997901364168;949.990500095004;950.4392408479031;974.4202199691173;984.3109823123699;13835.79246311306;14267.143971361751;14359.92820035893;14493.855061449462;14526.927365363317;333162;335103;335163;335235;335411;47603;47714.52285477101;48049.27926081111;48056.5194348059;48057.75971120192;1085.8208395614636;1138.5218208352512;1169.216624861345;1192.3799624195544;1213.7511810079088;27358.863205683843;28646.140615781558;28844.84620615152;29350.559741603465;29529.409411811215;40893;46139.538604613525;47227.29159062548;47521.762391187825;53004.20493692675;314332;317890;318193;318207;318248;31801;32752.50871236981;38062.80968595139;38854.805725971186;39773.40339894846;38232;42385.5761442394;42901.78549107359;42974.785126074166;43308.78345608252;33178.66821331756;36416.635833641325;36544.26911461809;37116.628833711315;37322.813385932895;36347.27305453929;36453;36544;36565.45151822671;37528;36096.27807443889;36630.26739465249;37102;37391;37420.43869342017;31810.204744881565;33482;33628.663713362555;33836.492452612736;33843;25171.87414062918;25176.24471265865;25636.23091307264;25823.798968200874;26215.082472113383 20:53:45 INFO - PROCESS | 3422 | |2;jquery.html;328.70580830157024;361.11166530335373;368.28552607940594;369.63036963036956;384.50590990577115;12169.878301216986;12632.11575189737;12737.872621273784;14090.859091409096;16391.91804040981;15314.617134571641;16256.75614865775;16280.83719162808;16436.424725134624;16585.83414165858;4958.0579689858905;5020.673656212334;5118.667286626376;5124.231365295198;5158.458361872005;3603.9279214415697;5059.266406371093;5151.5106064923775;5153.330067091291;5158.896822063556;3723.3484140275477;5613.607047506676;5861.443162899518;5873.119032145191;5949.167116603679;5164;5429.131338985783;5950.851228719273;5959.344472108065;5963.045912653998;5354.625176237665;5363.865903352408;5370.516653501165;5370.570354371641;5373.570114390839;12099.213551119237;15024.323905424282;19071.332503362453;19331.51671208217;19472.513187170433;1939.6702560564738;1954.4625228062255;2045.7136000959877;2084.551821358415;2219.556088782234;8202.507849529047;8708.477491350539;8789.472631642058;9410.058994100604;11741.356210130589;1600.8319126491667;1620.9351625934949;1648.826873178323;1697.5925777813236;1790.444962061765;63510;67655;68002.9999999995;68998.3100169002;69839;9614.71155865325;9642.469664168539;9844.170442619614;9882.604695812088;9901.653442129635;13497.055206135672;13518.662033449045;13527.12073715225;13579.932100339434;13619.18284902909;7129.435553473253;7227.168875579376;7279.495192786156;7405.8889116663295;7431.662300785911;6921.48088893335;7043.68303426347;7212.459065570103;7238.6018768968215;7264.673089710976;4133.855315063958;4255.616994470451;4288.849890253826;4329.9134017319475;4367.235733746582;1726.9309227630754;1805.2147315917355;1811.5111213024556;1831.423101722953;1852.935147269839;824.7072289337319;830.8006078541107;832.9083800781909;870.2124577257592;885.406777459091;15830.366785328688;16141.838581614034;16554.751678724828;16887.493375198763;16935.237914293888;831.8086840026828;853.0871966995379;864.8789169516273;875.6541166239427;894.6242578117207;8891.155340242667;8968.327375446868;9412.435253884789;9513.143817056498;9653.082957119062;272875;277440;338855;340099;342515;46501;46932;55897;80588;81277;881.8941726992801;936.1574582875467;937.8968313485648;939.7180845746385;943.8772959515219;14795.556133316019;15028.849711502746;15039.924800376366;15091.622709432351;15774;35028.47457288194;35139.82430087833;35442.8227858859;35684.46473302851;35983;46627.53372466368;47239.29141062818;47719.28421073617;49062;54812.17781733357;6704.66476676174;6892.827679308058;7046.612436315847;7052;7377.594232317059;9646.951765241129;11268.436578170895;11275.436228188722;11339.206255562032;11649.301041937511;9258.166764991183;9355.204807591159;9522.428654280766;9711.27165462579;10310.32982856112;9390.436573805593;9561.235101191749;9757.60969561238;9826.75433114178;9889.802203955736;8806;9345.579448924951;9421.104995025462;9802.803943921224;9921.55353009102;6490.935090649222;6604.240512341143;6797.388235058868;6905.89641155373;6959.234484206834;7045.365917067488;8749.737507874774;9441.433513989183;9448.385854919408;9542.952285238529 20:53:45 INFO - PROCESS | 3422 | |3;mootools.html;1187.6971372300063;1332.5069724202044;1375.6148278482026;1432.9785053224198;1642.6878893010335;6566.3433656634315;7214.819629509265;7422.517536360133;7450.10598728152;7710.228977102287;7489.588072656002;7518.81202969926;7520.924790752105;7522.586257755821;7523.4357423193205;2068.731064961553;2092.0899408757164;2095.5075557244036;2095.6646936490165;2098.1397626972944;2065.948351291222;2087.9478013049643;2092.9790702093014;2100.348891843526;2127.7765834587376;2091.184438069147;2099.1813192854797;2104.389726979174;2111.6304646686767;2117.7246957895454;2013.8993050347424;2020.454477291138;2021.1511165310606;2023.4840115770533;2023.9999999999927;1995.8303544198761;2026.1490174126902;2048.95902081959;2063.7523497180287;2081.771005189428;7456.3289303962365;7495.66269517873;7540.321371076575;7541.509801862861;7558.979537762387;4247.702660813744;4390.385346051556;4399;4450.26570615848;4482.282834746457;2695.5417579011614;2840.332521857362;2851.6720577133688;2871.9425611487864;2882.884684612613;948.9620415183384;957.6696039866235;977.3402953006763;979.9412035277835;993.64228877604;10072.546735396925;10129;10169.338992965433;10172.542235599416;10173.643922462677;3633.4368172933237;3735.589085200626;3746.8875933722034;3810.923781524354;3885.8445662173194;7923.762287131395;8006.15935326794;8012.0786109596975;8018.599070046591;8028.919710802934;4360.585744354281;4396.49440314368;4399.362092496634;4418.182636212311;4419.845305414295;3682.5580930288;3795.2599243147874;4003.199360127986;4128.60778226068;4136.627703506699;3072.109088364349;3074.6771588983283;3194.121616555466;3218.2598002459567;3241.8054916705073;939.3940908114365;940.948247846375;949.2548349545574;952.3524003677427;954.4178051388648;700.7351730127169;822.2394285286206;833.4207725630749;864.2783275964514;884.9955750221208;5039.82360617384;5053.67151135175;5258.421573626898;5357.812476563302;5425.728713564306;369.49932841000594;390.6113417149954;391.07510737107106;392.2742925587697;395.30821063139507;3529.266302331938;3559.8026880754387;3816.7709937403843;3817.351050321452;3839.4816699745734;8804;9237.12247336502;9281.95359023214;9285.953570232241;9293.256539476826;9207.447553146832;9208.355415120877;9218.81562368749;9220.03189665089;9248.445093294424;6674.799756007231;7024.5434046786795;7043.436525077981;7093.929060709327;7101.786946391617;4887.511248875227;5008.899822003613;5125.308083408692;5229.13719236337;5251.921221181609;8107.4324797263625;8107.554084525408;8180.46826956246;8207.302379297827;8208.138145494875;8060.355171586376;8487.702930397407;8526.403151779565;8532.104129066358;8539.615717292612;5872.0898260769645;6534.8366290843105;6730.6634668265415;6766.5263431559315;6786.69459874297;6665.533412661067;6908.689108990007;6925.134358205224;6926.896096558657;6994.160700715946;6399.296077431386;6453.741850325934;6485.578437401554;6612.041254018044;6639.136912201383;6408.519361047846;6460.063290822898;6482.189726284215;6495.935040649533;6509.349065093453;5688.772449102155;5799;5805.622634528742;5805.767769289181;5805.854853628524;4405.801738921692;4411.933820992752;4432.756198409118;4449.13241917823;4543.840965566189;4543.341215523797;4560.863174104782;4562.087582483583;4578.313253012075;4765.380500534909 20:53:45 INFO - PROCESS | 3422 | |4;prototype.html;282.9207821809894;285.66434439533543;291.14693946736065;292.1119795820705;295.4637333240168;4458.375827384169;4626.861194164172;4669.743164125972;4674.252119660855;4699.506551812062;4456.442944631921;4551.317302404633;4567.200739870526;4596.655250856191;4601.4248218972625;3681.5029970953847;3683.2081102562943;3689.760165589228;3700;3707.443883417482;3442.845071971767;3601.8019008954498;3644.16184277615;3658.926821463569;3695.2794205130012;3560.5045880730027;3622.619624939383;3653.8855649027037;3658.963410365889;3659.5425571803526;3644.5079914211638;3647.7993710345922;3652.3060618482405;3652.6347365263528;3663.1867225723304;3257.218267615779;3261.8858339958224;3269.673032696735;3269.9509507357407;3280.2778541266025;4280.807363668611;4496.460424749051;4519.615832654228;4522.773861306921;4545.659075569345;4170.395292682574;4171.707980441371;4181.937270940938;4186.81159347827;4194.182134483777;4840.709557426566;4841.298011788306;4855.150348688965;4855.8057677693205;4859.854204373874;3375.206826395795;3554.0937061049267;3556.5020897074432;3557.2174121693447;3567.982160089183;4971.37857767779;5001.774920128603;5012.849614511534;5012.874678133039;5052.368453943257;3605.3690604144695;3633.709303255786;3635.9636403635627;3636.1818590817384;3653.6163702811355;3682.5028621135802;3687.575928768172;3693.169036966661;3695.2978934002454;3703.7592556484283;3954.248692748426;4149.481314835645;4171.853985110507;4194;4199.181159673895;4829.444613869379;4837.153498137812;4849.80600775965;4853.684510506876;4860.538248866352;1208.1482554798845;1232.6363722701824;1233.4881024374963;1271.1546821363875;1286.6204469681466;880.1770344727572;886.7517095213351;895.7536677413633;899.595182168027;899.7615631857562;4266.850660226877;4267.997020700133;4283.136835476515;4284.507281662586;4288.592583704543;4902.2646603009125;4912.361393018885;4922.433920099163;4924.778384972685;4926.679765815211;4287.914241715211;4291.849785257501;4294.549072347421;4295.183915056129;4307.741535507879;2304.9539009220057;2486.539990101837;2615.790736741056;2624.1471521755507;2631.2895518209975;4795.856124316276;4798.424189097261;4810.374651295379;4813.15769740294;4819.542143496362;5052.387542906766;5060.898782024413;5084.720340381241;5090.160123579568;5099.419180054195;4669.673122881366;4766.285057241442;4807.71633474104;4818.156822556039;4818.518148185293;4946.851594452172;4950.4059512858685;4951.653384263067;4952.752362381794;4964.851054468371;4885.825807515622;4897.8285759998225;4901.436334821541;4905;4909.729964851825;4594.862154135381;4728.62171026324;4808.735519546459;4812.422509298766;4829.7585120743115;3484.3728128937037;3486.302739452069;3488.1977145256224;3491.4937334085907;3506.054139952351;4736.73947932867;4889.3888263967;4921.975390123026;4924.778384972757;4940.6788558743565;4526.456825181;4741.454732705783;4800.759962001816;4804.255340422101;4858.3441235432765;4818;4821.7589120544535;4837.782299796588;4846.95153048465;4848.903021939471;4561.315802629632;4757.3577567028005;4772.308015337687;4778.808847646055;4787.952120478751;4849.80600775965;4870.634702397264;4870.634702397405;4874.2444921037295;4881.926771098508;4766.833160839354;4771.902462433591;4773.809047638056;4788.832390866303;4790.329353890528 20:53:45 INFO - PROCESS | 3422 | |5;yui.html;639.8912184928558;663.8871391863382;699.9615021173837;708.8546847896182;741.9406447484201;12430.564930227443;13096.279704616254;13766.242856642893;14307.284635768196;14348.641283967907;14118.223497707622;14281.571552853406;14296;14299.142051476918;14304.070235434716;621.5462712220082;761.2273542354528;783.4437549339975;788.538704857659;788.763370988704;637.8788030274256;648.1573953859963;648.6464876642218;649.0621052579025;755.9508631938934;801.2708435323857;825.051191130202;828.494618282847;829.867221244601;830.6428235858579;823.074041703084;823.3824631526385;824.11819353292;824.2005254902734;824.2046425199682;486.4964761471895;489.5593965431105;605.446016894541;606.4451027310006;606.7118118893491;12121.757564848655;12549.184303020274;12598.68503287416;12861.485540578366;12862;12027.21823081497;12677.348275621389;12948.676283092904;13039;13139.27733974631;10502.68491945243;10552.630657927013;10595.894041059568;10730.731731706692;10813.405262710548;3281.2453135778906;3295.3574053059665;3314.419976504126;3316.2041110133637;3323.850426730803;60753.69623151856;61379.693101534656;61402;61457.385426145614;62343.68828155875;8986.505742184243;9104.81790364189;9172.954135229415;9223.861642075375;9453.669121580711;17222.483325500256;17354.479365618798;17357.3057077718;17642.38251661186;19201.231950722093;6324.841878952971;6414.166158399472;6436.967815160894;6549.377809108127;6815.625140617214;3509.7543171978227;3590.5870824854956;3621.855125794939;3684.5210122684416;3704.592494825567;2882.769378449719;3003.504421770427;3043.8630261638277;3171.6035495563056;3172.508920807217;538.265267909301;540.367769709441;541.7697478571591;543.7987944460575;554.0636324611394;571.1718008887048;591.3377017740073;599.6641880546907;604.9697515124226;633.4583930739244;8062.274395304451;8204.097549269576;8571.95714021426;8643.882248849071;8650.913490865136;588.4380416702124;589.2192844480994;611.2329027070997;612.9478994285536;614.9385061493815;3908;4147.440095587057;4240.448741663626;4255.255599086031;4356.978215108904;64264.678676606316;89499.73501854939;95031.52484237673;99228;102114.48942755238;83503.58248208721;86219.5689021551;86499;87944.56027719949;89948;73048.63475682694;74033;74207.25792742112;74412.25587744053;74585.25414745892;8057.677692892219;8249.79375515593;8328.791780205302;8377.95811020941;8388.832223355377;45909.77045114753;46604.7669761649;47126;47545.52454475549;47577.762111190605;36903.26193476169;48655;50248.74875625598;51390.22914656358;59699.40300596938;11022.50398732075;11062.944685276521;11166.720831979266;11684.240524365889;11911.344876031555;12379.257244565355;12459.317992070954;12866.163699359511;13095.083344165816;13345.532906348231;11070.39112848801;11945.631299221362;12321.210154514438;12372.505099795908;12472.563460278847;11394.856730314687;11789.292642441482;11845.822312665488;12385.752284954431;12395.93802030984;11089.223754337441;11817.350045747566;12401.565945191875;12406.62780116598;12408.131430799758;9163.633454661738;9385.249180065442;9577.616895324387;9716.951415242878;9978.151857092229;8772.473651580925;9208.55752747322;9487.241020718464;9594.18449431806;9788.314817962675 20:53:45 INFO - PROCESS | 3422 | __end_tp_report 20:53:45 INFO - PROCESS | 3422 | __start_cc_report 20:53:45 INFO - PROCESS | 3422 | _x_x_mozilla_cycle_collect,1115 20:53:45 INFO - PROCESS | 3422 | __end_cc_report 20:53:45 INFO - PROCESS | 3422 | __startTimestamp1476158025131__endTimestamp 20:53:45 INFO - PROCESS | 3422 | 20:53:45 INFO - PROCESS | 3422 | ------- Summary: start ------- 20:53:45 INFO - PROCESS | 3422 | Number of tests: 6 20:53:45 INFO - PROCESS | 3422 | 20:53:45 INFO - PROCESS | 3422 | [#0] dojo.html Cycles:165 Average:4474.12 Median:4606.22 stddev:449.55 (9.8%) stddev-sans-first:424.38 20:53:45 INFO - PROCESS | 3422 | Values: 2533.8 2561.1 2603.6 2609.4 2610.5 4368.1 4418.1 4448.1 4475.9 4511.3 4462.8 4513.2 4536.3 4546.9 4623.8 4178.6 4232.7 4245.5 4247.8 4262.0 4186.7 4205.8 4224.5 4238.0 4272.7 4290.3 4304.9 4347.3 4360.1 4364.9 4080.1 4097.1 4119.7 4202.0 4228.9 4142.7 4146.1 4196.7 4246.5 4247.4 4493.1 4498.7 4503.3 4505.7 4571.7 4797.8 4857.5 4858.5 4861.9 4915.9 4580.8 4590.9 4754.8 4786.1 4799.3 4488.0 4491.7 4499.0 4543.0 4544.8 4881.0 4884.9 4890.1 4891.0 4948.3 4606.2 4654.5 4700.8 4712.5 4720.7 4809.6 4819.6 4819.8 4871.7 4883.9 4772.5 4777.2 4780.9 4834.5 4843.3 4606.1 4650.7 4651.7 4731.1 4746.8 3971.5 3992.0 4034.9 4035.2 4085.3 3585.2 3609.3 3615.2 3647.7 3659.3 4106.4 4194.9 4197.9 4198.3 4243.8 4722.3 4790.3 4832.6 4839.8 4915.0 4192.5 4217.1 4220.5 4222.2 4276.2 4180.6 4324.7 4326.4 4328.4 4363.7 4547.6 4652.4 4681.7 4688.5 4756.9 4827.3 4849.6 4859.2 4861.2 4920.0 4680.4 4688.3 4691.6 4695.2 4753.3 4619.5 4663.8 4753.5 4788.1 4796.6 4868.9 4871.5 4886.7 4911.6 4940.2 4721.3 4724.9 4728.8 4729.1 4784.9 4573.3 4619.1 4693.8 4716.3 4731.3 4653.2 4667.4 4670.4 4714.2 4733.6 4746.6 4760.3 4761.7 4762.7 4801.1 4472.9 4510.7 4512.7 4628.4 4705.4 20:53:45 INFO - PROCESS | 3422 | 20:53:45 INFO - PROCESS | 3422 | [#1] ext.html Cycles:180 Average:42826.81 Median:36554.86 stddev:75046.06 (205.3%) stddev-sans-first:75189.45 20:53:45 INFO - PROCESS | 3422 | Values: 548.6 549.1 550.4 566.0 569.2 26292.3 26939.1 38231.8 39096.4 39136.6 38733.6 39094.6 39168.0 39196.4 39231.8 7542.3 7702.4 7704.5 7705.8 7706.2 7646.0 7723.8 7733.5 7733.5 7736.1 7722.7 7765.8 7767.5 7781.0 7781.6 7703.4 7718.5 7745.4 7747.4 7752.3 7610.7 7701.8 7708.4 7708.9 7708.9 36863.3 37166.3 37226.6 37246.4 37264.0 2843.1 2974.7 3068.2 3235.6 3286.0 27753.6 28045.0 28410.7 29132.7 29538.4 3489.5 3558.4 3610.7 3612.3 3743.1 173937.0 175268.0 175311.0 175719.0 175841.0 31032.0 51251.5 51605.2 51668.5 51730.5 31613.8 31746.0 31795.7 31822.0 31825.0 13172.9 13258.7 13286.3 13291.7 13298.7 11184.7 11211.9 11236.9 11307.0 11309.5 7329.5 7358.1 7420.0 7470.2 7472.2 3075.2 3083.3 3102.3 3119.5 3122.9 858.4 893.4 903.7 928.8 998.3 27082.7 27706.0 27744.0 28087.2 28179.9 923.4 950.0 950.4 974.4 984.3 13835.8 14267.1 14359.9 14493.9 14526.9 333162.0 335103.0 335163.0 335235.0 335411.0 47603.0 47714.5 48049.3 48056.5 48057.8 1085.8 1138.5 1169.2 1192.4 1213.8 27358.9 28646.1 28844.8 29350.6 29529.4 40893.0 46139.5 47227.3 47521.8 53004.2 314332.0 317890.0 318193.0 318207.0 318248.0 31801.0 32752.5 38062.8 38854.8 39773.4 38232.0 42385.6 42901.8 42974.8 43308.8 33178.7 36416.6 36544.3 37116.6 37322.8 36347.3 36453.0 36544.0 36565.5 37528.0 36096.3 36630.3 37102.0 37391.0 37420.4 31810.2 33482.0 33628.7 33836.5 33843.0 25171.9 25176.2 25636.2 25823.8 26215.1 20:53:45 INFO - PROCESS | 3422 | 20:53:45 INFO - PROCESS | 3422 | [#2] jquery.html Cycles:180 Average:21254.11 Median:5367.19 stddev:52455.25 (977.3%) stddev-sans-first:52578.87 20:53:45 INFO - PROCESS | 3422 | Values: 328.7 361.1 368.3 369.6 384.5 12169.9 12632.1 12737.9 14090.9 16391.9 15314.6 16256.8 16280.8 16436.4 16585.8 4958.1 5020.7 5118.7 5124.2 5158.5 3603.9 5059.3 5151.5 5153.3 5158.9 3723.3 5613.6 5861.4 5873.1 5949.2 5164.0 5429.1 5950.9 5959.3 5963.0 5354.6 5363.9 5370.5 5370.6 5373.6 12099.2 15024.3 19071.3 19331.5 19472.5 1939.7 1954.5 2045.7 2084.6 2219.6 8202.5 8708.5 8789.5 9410.1 11741.4 1600.8 1620.9 1648.8 1697.6 1790.4 63510.0 67655.0 68003.0 68998.3 69839.0 9614.7 9642.5 9844.2 9882.6 9901.7 13497.1 13518.7 13527.1 13579.9 13619.2 7129.4 7227.2 7279.5 7405.9 7431.7 6921.5 7043.7 7212.5 7238.6 7264.7 4133.9 4255.6 4288.8 4329.9 4367.2 1726.9 1805.2 1811.5 1831.4 1852.9 824.7 830.8 832.9 870.2 885.4 15830.4 16141.8 16554.8 16887.5 16935.2 831.8 853.1 864.9 875.7 894.6 8891.2 8968.3 9412.4 9513.1 9653.1 272875.0 277440.0 338855.0 340099.0 342515.0 46501.0 46932.0 55897.0 80588.0 81277.0 881.9 936.2 937.9 939.7 943.9 14795.6 15028.8 15039.9 15091.6 15774.0 35028.5 35139.8 35442.8 35684.5 35983.0 46627.5 47239.3 47719.3 49062.0 54812.2 6704.7 6892.8 7046.6 7052.0 7377.6 9647.0 11268.4 11275.4 11339.2 11649.3 9258.2 9355.2 9522.4 9711.3 10310.3 9390.4 9561.2 9757.6 9826.8 9889.8 8806.0 9345.6 9421.1 9802.8 9921.6 6490.9 6604.2 6797.4 6905.9 6959.2 7045.4 8749.7 9441.4 9448.4 9543.0 20:53:45 INFO - PROCESS | 3422 | 20:53:45 INFO - PROCESS | 3422 | [#3] mootools.html Cycles:180 Average:4863.34 Median:5240.53 stddev:2726.32 (52.0%) stddev-sans-first:2719.97 20:53:45 INFO - PROCESS | 3422 | Values: 1187.7 1332.5 1375.6 1433.0 1642.7 6566.3 7214.8 7422.5 7450.1 7710.2 7489.6 7518.8 7520.9 7522.6 7523.4 2068.7 2092.1 2095.5 2095.7 2098.1 2065.9 2087.9 2093.0 2100.3 2127.8 2091.2 2099.2 2104.4 2111.6 2117.7 2013.9 2020.5 2021.2 2023.5 2024.0 1995.8 2026.1 2049.0 2063.8 2081.8 7456.3 7495.7 7540.3 7541.5 7559.0 4247.7 4390.4 4399.0 4450.3 4482.3 2695.5 2840.3 2851.7 2871.9 2882.9 949.0 957.7 977.3 979.9 993.6 10072.5 10129.0 10169.3 10172.5 10173.6 3633.4 3735.6 3746.9 3810.9 3885.8 7923.8 8006.2 8012.1 8018.6 8028.9 4360.6 4396.5 4399.4 4418.2 4419.8 3682.6 3795.3 4003.2 4128.6 4136.6 3072.1 3074.7 3194.1 3218.3 3241.8 939.4 940.9 949.3 952.4 954.4 700.7 822.2 833.4 864.3 885.0 5039.8 5053.7 5258.4 5357.8 5425.7 369.5 390.6 391.1 392.3 395.3 3529.3 3559.8 3816.8 3817.4 3839.5 8804.0 9237.1 9282.0 9286.0 9293.3 9207.4 9208.4 9218.8 9220.0 9248.4 6674.8 7024.5 7043.4 7093.9 7101.8 4887.5 5008.9 5125.3 5229.1 5251.9 8107.4 8107.6 8180.5 8207.3 8208.1 8060.4 8487.7 8526.4 8532.1 8539.6 5872.1 6534.8 6730.7 6766.5 6786.7 6665.5 6908.7 6925.1 6926.9 6994.2 6399.3 6453.7 6485.6 6612.0 6639.1 6408.5 6460.1 6482.2 6495.9 6509.3 5688.8 5799.0 5805.6 5805.8 5805.9 4405.8 4411.9 4432.8 4449.1 4543.8 4543.3 4560.9 4562.1 4578.3 4765.4 20:53:45 INFO - PROCESS | 3422 | 20:53:45 INFO - PROCESS | 3422 | [#4] prototype.html Cycles:180 Average:4039.73 Median:4581.03 stddev:1158.34 (25.3%) stddev-sans-first:1126.75 20:53:45 INFO - PROCESS | 3422 | Values: 282.9 285.7 291.1 292.1 295.5 4458.4 4626.9 4669.7 4674.3 4699.5 4456.4 4551.3 4567.2 4596.7 4601.4 3681.5 3683.2 3689.8 3700.0 3707.4 3442.8 3601.8 3644.2 3658.9 3695.3 3560.5 3622.6 3653.9 3659.0 3659.5 3644.5 3647.8 3652.3 3652.6 3663.2 3257.2 3261.9 3269.7 3270.0 3280.3 4280.8 4496.5 4519.6 4522.8 4545.7 4170.4 4171.7 4181.9 4186.8 4194.2 4840.7 4841.3 4855.2 4855.8 4859.9 3375.2 3554.1 3556.5 3557.2 3568.0 4971.4 5001.8 5012.8 5012.9 5052.4 3605.4 3633.7 3636.0 3636.2 3653.6 3682.5 3687.6 3693.2 3695.3 3703.8 3954.2 4149.5 4171.9 4194.0 4199.2 4829.4 4837.2 4849.8 4853.7 4860.5 1208.1 1232.6 1233.5 1271.2 1286.6 880.2 886.8 895.8 899.6 899.8 4266.9 4268.0 4283.1 4284.5 4288.6 4902.3 4912.4 4922.4 4924.8 4926.7 4287.9 4291.8 4294.5 4295.2 4307.7 2305.0 2486.5 2615.8 2624.1 2631.3 4795.9 4798.4 4810.4 4813.2 4819.5 5052.4 5060.9 5084.7 5090.2 5099.4 4669.7 4766.3 4807.7 4818.2 4818.5 4946.9 4950.4 4951.7 4952.8 4964.9 4885.8 4897.8 4901.4 4905.0 4909.7 4594.9 4728.6 4808.7 4812.4 4829.8 3484.4 3486.3 3488.2 3491.5 3506.1 4736.7 4889.4 4922.0 4924.8 4940.7 4526.5 4741.5 4800.8 4804.3 4858.3 4818.0 4821.8 4837.8 4847.0 4848.9 4561.3 4757.4 4772.3 4778.8 4788.0 4849.8 4870.6 4870.6 4874.2 4881.9 4766.8 4771.9 4773.8 4788.8 4790.3 20:53:45 INFO - PROCESS | 3422 | 20:53:45 INFO - PROCESS | 3422 | [#5] yui.html Cycles:180 Average:17280.62 Median:548.93 stddev:24454.57 (4454.9%) stddev-sans-first:24491.25 20:53:45 INFO - PROCESS | 3422 | Values: 639.9 663.9 700.0 708.9 741.9 12430.6 13096.3 13766.2 14307.3 14348.6 14118.2 14281.6 14296.0 14299.1 14304.1 621.5 761.2 783.4 788.5 788.8 637.9 648.2 648.6 649.1 756.0 801.3 825.1 828.5 829.9 830.6 823.1 823.4 824.1 824.2 824.2 486.5 489.6 605.4 606.4 606.7 12121.8 12549.2 12598.7 12861.5 12862.0 12027.2 12677.3 12948.7 13039.0 13139.3 10502.7 10552.6 10595.9 10730.7 10813.4 3281.2 3295.4 3314.4 3316.2 3323.9 60753.7 61379.7 61402.0 61457.4 62343.7 8986.5 9104.8 9173.0 9223.9 9453.7 17222.5 17354.5 17357.3 17642.4 19201.2 6324.8 6414.2 6437.0 6549.4 6815.6 3509.8 3590.6 3621.9 3684.5 3704.6 2882.8 3003.5 3043.9 3171.6 3172.5 538.3 540.4 541.8 543.8 554.1 571.2 591.3 599.7 605.0 633.5 8062.3 8204.1 8572.0 8643.9 8650.9 588.4 589.2 611.2 612.9 614.9 3908.0 4147.4 4240.4 4255.3 4357.0 64264.7 89499.7 95031.5 99228.0 102114.5 83503.6 86219.6 86499.0 87944.6 89948.0 73048.6 74033.0 74207.3 74412.3 74585.3 8057.7 8249.8 8328.8 8378.0 8388.8 45909.8 46604.8 47126.0 47545.5 47577.8 36903.3 48655.0 50248.7 51390.2 59699.4 11022.5 11062.9 11166.7 11684.2 11911.3 12379.3 12459.3 12866.2 13095.1 13345.5 11070.4 11945.6 12321.2 12372.5 12472.6 11394.9 11789.3 11845.8 12385.8 12395.9 11089.2 11817.4 12401.6 12406.6 12408.1 9163.6 9385.2 9577.6 9717.0 9978.2 8772.5 9208.6 9487.2 9594.2 9788.3 20:53:45 INFO - PROCESS | 3422 | -------- Summary: end -------- 20:53:45 INFO - PROCESS | 3422 | 20:53:46 INFO - TEST-INFO | 3422: exit 0 20:53:46 INFO - TEST-OK | dromaeo_css | took 1123998ms 20:53:46 INFO - TEST-START | kraken 20:53:46 INFO - operating with platform_type : linux_ 20:53:46 INFO - Initialising browser for kraken test... 20:53:46 INFO - TEST-INFO | started process 3728 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_NiKD8/profile http://localhost:41711/getInfo.html) 20:53:51 INFO - PROCESS | 3728 | __metrics Screen width/height:1600/1200 20:53:51 INFO - PROCESS | 3728 | colorDepth:24 20:53:51 INFO - PROCESS | 3728 | Browser inner width/height: 1024/697 20:53:51 INFO - PROCESS | 3728 | __metrics 20:53:52 INFO - PROCESS | 3728 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 20:53:52 INFO - PROCESS | 3728 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:53:52 INFO - PROCESS | 3728 | console.error: PushService: 20:53:52 INFO - PROCESS | 3728 | stateChangeProcessEnqueue: Error transitioning state 20:53:52 INFO - PROCESS | 3728 | UnknownError 20:53:53 INFO - TEST-INFO | 3728: exit 0 20:53:53 INFO - Browser initialized. 20:53:53 INFO - Running cycle 1/1 for kraken test... 20:53:53 INFO - TEST-INFO | started process 3814 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_NiKD8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:54:05 INFO - PROCESS | 3814 | RSS: Main: 174604288 20:54:05 INFO - PROCESS | 3814 | 20:54:08 INFO - PROCESS | 3814 | Cycle 1(1): loaded http://localhost:41711/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41711/tests/kraken/driver.html?testName=audio-beat-detection) 20:54:09 INFO - PROCESS | 3814 | RSS: Main: 241385472 20:54:09 INFO - PROCESS | 3814 | 20:54:12 INFO - PROCESS | 3814 | Cycle 1(1): loaded http://localhost:41711/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41711/tests/kraken/driver.html?testName=audio-dft) 20:54:12 INFO - PROCESS | 3814 | RSS: Main: 217370624 20:54:12 INFO - PROCESS | 3814 | 20:54:16 INFO - PROCESS | 3814 | Cycle 1(1): loaded http://localhost:41711/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41711/tests/kraken/driver.html?testName=audio-fft) 20:54:16 INFO - PROCESS | 3814 | RSS: Main: 299642880 20:54:16 INFO - PROCESS | 3814 | 20:54:19 INFO - PROCESS | 3814 | Cycle 1(1): loaded http://localhost:41711/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41711/tests/kraken/driver.html?testName=audio-oscillator) 20:54:19 INFO - PROCESS | 3814 | RSS: Main: 211156992 20:54:19 INFO - PROCESS | 3814 | 20:54:21 INFO - PROCESS | 3814 | Cycle 1(1): loaded http://localhost:41711/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41711/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:54:22 INFO - PROCESS | 3814 | RSS: Main: 213757952 20:54:22 INFO - PROCESS | 3814 | 20:54:25 INFO - PROCESS | 3814 | Cycle 1(1): loaded http://localhost:41711/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41711/tests/kraken/driver.html?testName=imaging-darkroom) 20:54:26 INFO - PROCESS | 3814 | RSS: Main: 249806848 20:54:26 INFO - PROCESS | 3814 | 20:54:29 INFO - PROCESS | 3814 | Cycle 1(1): loaded http://localhost:41711/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41711/tests/kraken/driver.html?testName=imaging-desaturate) 20:54:30 INFO - PROCESS | 3814 | RSS: Main: 243093504 20:54:30 INFO - PROCESS | 3814 | 20:54:33 INFO - PROCESS | 3814 | Cycle 1(1): loaded http://localhost:41711/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41711/tests/kraken/driver.html?testName=json-parse-financial) 20:54:33 INFO - PROCESS | 3814 | RSS: Main: 246730752 20:54:33 INFO - PROCESS | 3814 | 20:54:35 INFO - PROCESS | 3814 | Cycle 1(1): loaded http://localhost:41711/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41711/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:54:36 INFO - PROCESS | 3814 | RSS: Main: 209891328 20:54:36 INFO - PROCESS | 3814 | 20:54:38 INFO - PROCESS | 3814 | Cycle 1(1): loaded http://localhost:41711/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41711/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:54:38 INFO - PROCESS | 3814 | RSS: Main: 217743360 20:54:38 INFO - PROCESS | 3814 | 20:54:42 INFO - PROCESS | 3814 | Cycle 1(1): loaded http://localhost:41711/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41711/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:54:42 INFO - PROCESS | 3814 | RSS: Main: 226676736 20:54:42 INFO - PROCESS | 3814 | 20:54:44 INFO - PROCESS | 3814 | Cycle 1(1): loaded http://localhost:41711/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41711/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:54:45 INFO - PROCESS | 3814 | RSS: Main: 235442176 20:54:45 INFO - PROCESS | 3814 | 20:54:48 INFO - PROCESS | 3814 | Cycle 1(1): loaded http://localhost:41711/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41711/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:54:48 INFO - PROCESS | 3814 | RSS: Main: 232501248 20:54:48 INFO - PROCESS | 3814 | 20:54:50 INFO - PROCESS | 3814 | Cycle 1(1): loaded http://localhost:41711/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41711/tests/kraken/driver.html?testName=ai-astar) 20:54:50 INFO - PROCESS | 3814 | RSS: Main: 282255360 20:54:50 INFO - PROCESS | 3814 | 20:54:50 INFO - PROCESS | 3814 | __start_tp_report 20:54:50 INFO - PROCESS | 3814 | _x_x_mozilla_page_load 20:54:50 INFO - PROCESS | 3814 | _x_x_mozilla_page_load_details 20:54:50 INFO - PROCESS | 3814 | |i|pagename|runs| 20:54:50 INFO - PROCESS | 3814 | |0;ai-astar;113;115;115;115;115;114;114;116;116;115 20:54:50 INFO - PROCESS | 3814 | |1;audio-beat-detection;160;127;131;163;127;131;129;125;181;125 20:54:50 INFO - PROCESS | 3814 | |2;audio-dft;164;162;161;161;161;162;162;161;160;161 20:54:50 INFO - PROCESS | 3814 | |3;audio-fft;76;76;76;112;76;77;76;77;98;75 20:54:50 INFO - PROCESS | 3814 | |4;audio-oscillator;83;83;120;83;84;83;105;84;83;113 20:54:50 INFO - PROCESS | 3814 | |5;imaging-gaussian-blur;117;117;117;117;117;116;116;118;117;117 20:54:50 INFO - PROCESS | 3814 | |6;imaging-darkroom;148;147;146;147;147;147;146;147;146;147 20:54:50 INFO - PROCESS | 3814 | |7;imaging-desaturate;95;95;95;95;95;95;95;95;95;95 20:54:50 INFO - PROCESS | 3814 | |8;json-parse-financial;64;64;72;64;65;65;65;65;63;64 20:54:50 INFO - PROCESS | 3814 | |9;json-stringify-tinderbox;66;66;66;66;66;65;65;65;66;65 20:54:50 INFO - PROCESS | 3814 | |10;stanford-crypto-aes;83;82;94;84;84;92;83;93;82;82 20:54:50 INFO - PROCESS | 3814 | |11;stanford-crypto-ccm;143;146;137;137;141;140;138;146;175;137 20:54:50 INFO - PROCESS | 3814 | |12;stanford-crypto-pbkdf2;176;180;177;176;182;179;181;182;176;175 20:54:50 INFO - PROCESS | 3814 | |13;stanford-crypto-sha256-iterative;69;71;72;71;70;70;71;69;69;70 20:54:50 INFO - PROCESS | 3814 | __end_tp_report 20:54:50 INFO - PROCESS | 3814 | __start_cc_report 20:54:50 INFO - PROCESS | 3814 | _x_x_mozilla_cycle_collect,1933 20:54:50 INFO - PROCESS | 3814 | __end_cc_report 20:54:50 INFO - PROCESS | 3814 | __startTimestamp1476158090791__endTimestamp 20:54:50 INFO - PROCESS | 3814 | 20:54:50 INFO - PROCESS | 3814 | ------- Summary: start ------- 20:54:50 INFO - PROCESS | 3814 | Number of tests: 14 20:54:50 INFO - PROCESS | 3814 | 20:54:50 INFO - PROCESS | 3814 | [#0] ai-astar Cycles:10 Average:114.80 Median:115.00 stddev:0.92 (0.8%) stddev-sans-first:0.71 20:54:50 INFO - PROCESS | 3814 | Values: 113.0 115.0 115.0 115.0 115.0 114.0 114.0 116.0 116.0 115.0 20:54:50 INFO - PROCESS | 3814 | 20:54:50 INFO - PROCESS | 3814 | [#1] audio-beat-detection Cycles:10 Average:139.90 Median:131.00 stddev:20.22 (15.4%) stddev-sans-first:20.10 20:54:50 INFO - PROCESS | 3814 | Values: 160.0 127.0 131.0 163.0 127.0 131.0 129.0 125.0 181.0 125.0 20:54:50 INFO - PROCESS | 3814 | 20:54:50 INFO - PROCESS | 3814 | [#2] audio-dft Cycles:10 Average:161.50 Median:161.50 stddev:1.08 (0.7%) stddev-sans-first:0.67 20:54:50 INFO - PROCESS | 3814 | Values: 164.0 162.0 161.0 161.0 161.0 162.0 162.0 161.0 160.0 161.0 20:54:50 INFO - PROCESS | 3814 | 20:54:50 INFO - PROCESS | 3814 | [#3] audio-fft Cycles:10 Average:81.90 Median:76.00 stddev:12.63 (16.6%) stddev-sans-first:13.21 20:54:50 INFO - PROCESS | 3814 | Values: 76.0 76.0 76.0 112.0 76.0 77.0 76.0 77.0 98.0 75.0 20:54:50 INFO - PROCESS | 3814 | 20:54:50 INFO - PROCESS | 3814 | [#4] audio-oscillator Cycles:10 Average:92.10 Median:83.00 stddev:14.63 (17.6%) stddev-sans-first:15.14 20:54:50 INFO - PROCESS | 3814 | Values: 83.0 83.0 120.0 83.0 84.0 83.0 105.0 84.0 83.0 113.0 20:54:50 INFO - PROCESS | 3814 | 20:54:50 INFO - PROCESS | 3814 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 20:54:50 INFO - PROCESS | 3814 | Values: 117.0 117.0 117.0 117.0 117.0 116.0 116.0 118.0 117.0 117.0 20:54:50 INFO - PROCESS | 3814 | 20:54:50 INFO - PROCESS | 3814 | [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:0.63 (0.4%) stddev-sans-first:0.50 20:54:50 INFO - PROCESS | 3814 | Values: 148.0 147.0 146.0 147.0 147.0 147.0 146.0 147.0 146.0 147.0 20:54:50 INFO - PROCESS | 3814 | 20:54:50 INFO - PROCESS | 3814 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 20:54:50 INFO - PROCESS | 3814 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 20:54:50 INFO - PROCESS | 3814 | 20:54:50 INFO - PROCESS | 3814 | [#8] json-parse-financial Cycles:10 Average:65.10 Median:65.00 stddev:2.51 (3.9%) stddev-sans-first:2.64 20:54:50 INFO - PROCESS | 3814 | Values: 64.0 64.0 72.0 64.0 65.0 65.0 65.0 65.0 63.0 64.0 20:54:50 INFO - PROCESS | 3814 | 20:54:50 INFO - PROCESS | 3814 | [#9] json-stringify-tinderbox Cycles:10 Average:65.60 Median:66.00 stddev:0.52 (0.8%) stddev-sans-first:0.53 20:54:50 INFO - PROCESS | 3814 | Values: 66.0 66.0 66.0 66.0 66.0 65.0 65.0 65.0 66.0 65.0 20:54:50 INFO - PROCESS | 3814 | 20:54:50 INFO - PROCESS | 3814 | [#10] stanford-crypto-aes Cycles:10 Average:85.90 Median:84.00 stddev:4.98 (5.9%) stddev-sans-first:5.17 20:54:50 INFO - PROCESS | 3814 | Values: 83.0 82.0 94.0 84.0 84.0 92.0 83.0 93.0 82.0 82.0 20:54:50 INFO - PROCESS | 3814 | 20:54:50 INFO - PROCESS | 3814 | [#11] stanford-crypto-ccm Cycles:10 Average:144.00 Median:142.00 stddev:11.44 (8.1%) stddev-sans-first:12.13 20:54:50 INFO - PROCESS | 3814 | Values: 143.0 146.0 137.0 137.0 141.0 140.0 138.0 146.0 175.0 137.0 20:54:50 INFO - PROCESS | 3814 | 20:54:50 INFO - PROCESS | 3814 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:178.40 Median:179.50 stddev:2.72 (1.5%) stddev-sans-first:2.74 20:54:50 INFO - PROCESS | 3814 | Values: 176.0 180.0 177.0 176.0 182.0 179.0 181.0 182.0 176.0 175.0 20:54:50 INFO - PROCESS | 3814 | 20:54:50 INFO - PROCESS | 3814 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.20 Median:70.50 stddev:1.03 (1.5%) stddev-sans-first:1.00 20:54:50 INFO - PROCESS | 3814 | Values: 69.0 71.0 72.0 71.0 70.0 70.0 71.0 69.0 69.0 70.0 20:54:50 INFO - PROCESS | 3814 | -------- Summary: end -------- 20:54:50 INFO - PROCESS | 3814 | 20:54:52 INFO - TEST-INFO | 3814: exit 0 20:54:52 INFO - TEST-OK | kraken | took 65970ms 20:54:52 INFO - SUITE-END | took 1189s 20:54:52 INFO - Completed test suite (00:19:50) 20:54:52 INFO - javascript benchmark 20:54:52 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2533.835300705454, 2561.103613735194, 2603.557395242809, 2609.360706626877, 2610.4518051209243, 4368.082702632451, 4418.072204836988, 4448.132614140244, 4475.910481790366, 4511.323301504772, 4462.821487140511, 4513.232750432426, 4536.27419612862, 4546.931796023054, 4623.8381656642105, 4178.56125106864, 4232.724872883253, 4245.490541135068, 4247.83008679654, 4262.019735460846, 4186.706930514865, 4205.7897105144775, 4224.514180869209, 4237.957620423803, 4272.703384746566, 4290.313549832027, 4304.935425968613, 4347.260965635834, 4360.106178233455, 4364.912701745963, 4080.0819815541267, 4097.09863829957, 4119.732217405859, 4202.012527056139, 4228.873133805991, 4142.668586513072, 4146.108586653853, 4196.664266858644, 4246.532881383046, 4247.447831781879, 4493.146302202571, 4498.662600304958, 4503.301988191835, 4505.662075344329, 4571.748553829538, 4797.808087676489, 4857.465678775332, 4858.46556878743, 4861.8784530386665, 4915.877103072416, 4580.839670611546, 4590.931136032962, 4754.786034628415, 4786.066716990188, 4799.2801079837955, 4488.0, 4491.73049617024, 4498.977505112453, 4543.023250001233, 4544.818207271738, 4880.95119048805, 4884.902301953941, 4890.144224760724, 4891.0, 4948.331975183376, 4606.216943119678, 4654.534546545318, 4700.764961751899, 4712.458067322234, 4720.669553131248, 4809.591184749335, 4819.638527110411, 4819.759012049453, 4871.707697538088, 4883.877903052452, 4772.475027746945, 4777.187878060738, 4780.856574302707, 4834.468208497063, 4843.346148270009, 4606.101810146989, 4650.720956742606, 4651.720896746206, 4731.077439899255, 4746.762661866962, 3971.543272523697, 3991.960080399159, 4034.9394759078637, 4035.1727895781883, 4085.325921222965, 3585.175409655794, 3609.2601016791496, 3615.240799432149, 3647.708183345379, 3659.341318562631, 4106.3840423936645, 4194.874153775391, 4197.895052623709, 4198.328267477189, 4243.787810609457, 4722.325477659599, 4790.257510085942, 4832.637552183601, 4839.782209800567, 4914.950850491521, 4192.496900371914, 4217.093324935154, 4220.451341325608, 4222.19778242133, 4276.18752437036, 4180.6446452051305, 4324.740515569013, 4326.437563116775, 4328.350747387854, 4363.650907927358, 4547.613452856544, 4652.3719297895705, 4681.742504162304, 4688.484266730588, 4756.881077973078, 4827.348307978378, 4849.563539281482, 4859.222524396079, 4861.222204447272, 4920.015996800583, 4680.391549098732, 4688.2733176357715, 4691.648126390466, 4695.154872122914, 4753.334533165291, 4619.538046195354, 4663.790129444251, 4753.524647535219, 4788.066327066189, 4796.640251981045, 4868.878278043077, 4871.464138944784, 4886.657933944732, 4911.607071434348, 4940.184869496637, 4721.291806229093, 4724.881877952941, 4728.787204575733, 4729.054189162112, 4784.856454306377, 4573.268277075652, 4619.14545809013, 4693.788779504862, 4716.29255611661, 4731.29030645406, 4653.208954477679, 4667.393238878924, 4670.416197975253, 4714.15145273854, 4733.597644200144, 4746.572808447257, 4760.262159365304, 4761.666683332133, 4762.714237145782, 4801.087793319258, 4472.888177795581, 4510.729356238636, 4512.6615503838, 4628.35203071577, 4705.364775755229], "value": 4446.7157196811795, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [548.5858177076308, 549.146077848945, 550.3643291997744, 566.0377358490567, 569.1974316214137, 26292.342691432725, 26939.057133000348, 38231.808840955826, 39096.413553796716, 39136.60863391365, 38733.612663873355, 39094.609053909524, 39168.02079947996, 39196.41205381914, 39231.803840980756, 7542.283483069114, 7702.42231832612, 7704.499207551519, 7705.845883082335, 7706.229377062305, 7646.044244469442, 7723.845523089535, 7733.45865789395, 7733.53598784072, 7736.149023607427, 7722.691092356299, 7765.767026989171, 7767.495112817649, 7781.0, 7781.649825757854, 7703.4222433317445, 7718.498297610638, 7745.380369570477, 7747.418943579198, 7752.26353496417, 7610.695572177106, 7701.807454813618, 7708.383329333696, 7708.884366734504, 7708.884366734504, 36863.262734745425, 37166.25667486662, 37226.627733722584, 37246.441303380474, 37264.0, 2843.118633223707, 2974.677586369206, 3068.186930463429, 3235.6279027911855, 3285.983570082158, 27753.583696244572, 28045.0, 28410.71589284122, 29132.70867291321, 29538.409231815243, 3489.476578513243, 3558.4128618777872, 3610.7472476926628, 3612.259486805199, 3743.101655602663, 173937.0, 175268.0, 175311.0, 175719.0, 175841.0, 31032.0, 51251.48748512542, 51605.22592161121, 51668.48331516637, 51730.48269517332, 31613.84193079066, 31746.0, 31795.682043179735, 31822.0, 31825.0, 13172.934135329453, 13258.73482530344, 13286.3356832158, 13291.734165316639, 13298.66753331155, 11184.720381990515, 11211.887881121247, 11236.94381528087, 11307.0, 11309.547618095348, 7329.486935914435, 7358.1170259568125, 7420.0, 7470.178280389153, 7472.17806041335, 3075.2158199658943, 3083.260017595806, 3102.255458689943, 3119.4696901526795, 3122.859471323796, 858.3948316436897, 893.4326702543801, 903.7288813356098, 928.7538802217417, 998.256299057207, 27082.72917270802, 27706.0, 27744.0, 28087.157385278475, 28179.859100704365, 923.3997901364168, 949.990500095004, 950.4392408479031, 974.4202199691173, 984.3109823123699, 13835.79246311306, 14267.143971361751, 14359.92820035893, 14493.855061449462, 14526.927365363317, 333162.0, 335103.0, 335163.0, 335235.0, 335411.0, 47603.0, 47714.52285477101, 48049.27926081111, 48056.5194348059, 48057.75971120192, 1085.8208395614636, 1138.5218208352512, 1169.216624861345, 1192.3799624195544, 1213.7511810079088, 27358.863205683843, 28646.140615781558, 28844.84620615152, 29350.559741603465, 29529.409411811215, 40893.0, 46139.538604613525, 47227.29159062548, 47521.762391187825, 53004.20493692675, 314332.0, 317890.0, 318193.0, 318207.0, 318248.0, 31801.0, 32752.50871236981, 38062.80968595139, 38854.805725971186, 39773.40339894846, 38232.0, 42385.5761442394, 42901.78549107359, 42974.785126074166, 43308.78345608252, 33178.66821331756, 36416.635833641325, 36544.26911461809, 37116.628833711315, 37322.813385932895, 36347.27305453929, 36453.0, 36544.0, 36565.45151822671, 37528.0, 36096.27807443889, 36630.26739465249, 37102.0, 37391.0, 37420.43869342017, 31810.204744881565, 33482.0, 33628.663713362555, 33836.492452612736, 33843.0, 25171.87414062918, 25176.24471265865, 25636.23091307264, 25823.798968200874, 26215.082472113383], "value": 16239.643376268725, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [328.70580830157024, 361.11166530335373, 368.28552607940594, 369.63036963036956, 384.50590990577115, 12169.878301216986, 12632.11575189737, 12737.872621273784, 14090.859091409096, 16391.91804040981, 15314.617134571641, 16256.75614865775, 16280.83719162808, 16436.424725134624, 16585.83414165858, 4958.0579689858905, 5020.673656212334, 5118.667286626376, 5124.231365295198, 5158.458361872005, 3603.9279214415697, 5059.266406371093, 5151.5106064923775, 5153.330067091291, 5158.896822063556, 3723.3484140275477, 5613.607047506676, 5861.443162899518, 5873.119032145191, 5949.167116603679, 5164.0, 5429.131338985783, 5950.851228719273, 5959.344472108065, 5963.045912653998, 5354.625176237665, 5363.865903352408, 5370.516653501165, 5370.570354371641, 5373.570114390839, 12099.213551119237, 15024.323905424282, 19071.332503362453, 19331.51671208217, 19472.513187170433, 1939.6702560564738, 1954.4625228062255, 2045.7136000959877, 2084.551821358415, 2219.556088782234, 8202.507849529047, 8708.477491350539, 8789.472631642058, 9410.058994100604, 11741.356210130589, 1600.8319126491667, 1620.9351625934949, 1648.826873178323, 1697.5925777813236, 1790.444962061765, 63510.0, 67655.0, 68002.9999999995, 68998.3100169002, 69839.0, 9614.71155865325, 9642.469664168539, 9844.170442619614, 9882.604695812088, 9901.653442129635, 13497.055206135672, 13518.662033449045, 13527.12073715225, 13579.932100339434, 13619.18284902909, 7129.435553473253, 7227.168875579376, 7279.495192786156, 7405.8889116663295, 7431.662300785911, 6921.48088893335, 7043.68303426347, 7212.459065570103, 7238.6018768968215, 7264.673089710976, 4133.855315063958, 4255.616994470451, 4288.849890253826, 4329.9134017319475, 4367.235733746582, 1726.9309227630754, 1805.2147315917355, 1811.5111213024556, 1831.423101722953, 1852.935147269839, 824.7072289337319, 830.8006078541107, 832.9083800781909, 870.2124577257592, 885.406777459091, 15830.366785328688, 16141.838581614034, 16554.751678724828, 16887.493375198763, 16935.237914293888, 831.8086840026828, 853.0871966995379, 864.8789169516273, 875.6541166239427, 894.6242578117207, 8891.155340242667, 8968.327375446868, 9412.435253884789, 9513.143817056498, 9653.082957119062, 272875.0, 277440.0, 338855.0, 340099.0, 342515.0, 46501.0, 46932.0, 55897.0, 80588.0, 81277.0, 881.8941726992801, 936.1574582875467, 937.8968313485648, 939.7180845746385, 943.8772959515219, 14795.556133316019, 15028.849711502746, 15039.924800376366, 15091.622709432351, 15774.0, 35028.47457288194, 35139.82430087833, 35442.8227858859, 35684.46473302851, 35983.0, 46627.53372466368, 47239.29141062818, 47719.28421073617, 49062.0, 54812.17781733357, 6704.66476676174, 6892.827679308058, 7046.612436315847, 7052.0, 7377.594232317059, 9646.951765241129, 11268.436578170895, 11275.436228188722, 11339.206255562032, 11649.301041937511, 9258.166764991183, 9355.204807591159, 9522.428654280766, 9711.27165462579, 10310.32982856112, 9390.436573805593, 9561.235101191749, 9757.60969561238, 9826.75433114178, 9889.802203955736, 8806.0, 9345.579448924951, 9421.104995025462, 9802.803943921224, 9921.55353009102, 6490.935090649222, 6604.240512341143, 6797.388235058868, 6905.89641155373, 6959.234484206834, 7045.365917067488, 8749.737507874774, 9441.433513989183, 9448.385854919408, 9542.952285238529], "value": 7814.686379071424, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1187.6971372300063, 1332.5069724202044, 1375.6148278482026, 1432.9785053224198, 1642.6878893010335, 6566.3433656634315, 7214.819629509265, 7422.517536360133, 7450.10598728152, 7710.228977102287, 7489.588072656002, 7518.81202969926, 7520.924790752105, 7522.586257755821, 7523.4357423193205, 2068.731064961553, 2092.0899408757164, 2095.5075557244036, 2095.6646936490165, 2098.1397626972944, 2065.948351291222, 2087.9478013049643, 2092.9790702093014, 2100.348891843526, 2127.7765834587376, 2091.184438069147, 2099.1813192854797, 2104.389726979174, 2111.6304646686767, 2117.7246957895454, 2013.8993050347424, 2020.454477291138, 2021.1511165310606, 2023.4840115770533, 2023.9999999999927, 1995.8303544198761, 2026.1490174126902, 2048.95902081959, 2063.7523497180287, 2081.771005189428, 7456.3289303962365, 7495.66269517873, 7540.321371076575, 7541.509801862861, 7558.979537762387, 4247.702660813744, 4390.385346051556, 4399.0, 4450.26570615848, 4482.282834746457, 2695.5417579011614, 2840.332521857362, 2851.6720577133688, 2871.9425611487864, 2882.884684612613, 948.9620415183384, 957.6696039866235, 977.3402953006763, 979.9412035277835, 993.64228877604, 10072.546735396925, 10129.0, 10169.338992965433, 10172.542235599416, 10173.643922462677, 3633.4368172933237, 3735.589085200626, 3746.8875933722034, 3810.923781524354, 3885.8445662173194, 7923.762287131395, 8006.15935326794, 8012.0786109596975, 8018.599070046591, 8028.919710802934, 4360.585744354281, 4396.49440314368, 4399.362092496634, 4418.182636212311, 4419.845305414295, 3682.5580930288, 3795.2599243147874, 4003.199360127986, 4128.60778226068, 4136.627703506699, 3072.109088364349, 3074.6771588983283, 3194.121616555466, 3218.2598002459567, 3241.8054916705073, 939.3940908114365, 940.948247846375, 949.2548349545574, 952.3524003677427, 954.4178051388648, 700.7351730127169, 822.2394285286206, 833.4207725630749, 864.2783275964514, 884.9955750221208, 5039.82360617384, 5053.67151135175, 5258.421573626898, 5357.812476563302, 5425.728713564306, 369.49932841000594, 390.6113417149954, 391.07510737107106, 392.2742925587697, 395.30821063139507, 3529.266302331938, 3559.8026880754387, 3816.7709937403843, 3817.351050321452, 3839.4816699745734, 8804.0, 9237.12247336502, 9281.95359023214, 9285.953570232241, 9293.256539476826, 9207.447553146832, 9208.355415120877, 9218.81562368749, 9220.03189665089, 9248.445093294424, 6674.799756007231, 7024.5434046786795, 7043.436525077981, 7093.929060709327, 7101.786946391617, 4887.511248875227, 5008.899822003613, 5125.308083408692, 5229.13719236337, 5251.921221181609, 8107.4324797263625, 8107.554084525408, 8180.46826956246, 8207.302379297827, 8208.138145494875, 8060.355171586376, 8487.702930397407, 8526.403151779565, 8532.104129066358, 8539.615717292612, 5872.0898260769645, 6534.8366290843105, 6730.6634668265415, 6766.5263431559315, 6786.69459874297, 6665.533412661067, 6908.689108990007, 6925.134358205224, 6926.896096558657, 6994.160700715946, 6399.296077431386, 6453.741850325934, 6485.578437401554, 6612.041254018044, 6639.136912201383, 6408.519361047846, 6460.063290822898, 6482.189726284215, 6495.935040649533, 6509.349065093453, 5688.772449102155, 5799.0, 5805.622634528742, 5805.767769289181, 5805.854853628524, 4405.801738921692, 4411.933820992752, 4432.756198409118, 4449.13241917823, 4543.840965566189, 4543.341215523797, 4560.863174104782, 4562.087582483583, 4578.313253012075, 4765.380500534909], "value": 3851.4801929442815, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [282.9207821809894, 285.66434439533543, 291.14693946736065, 292.1119795820705, 295.4637333240168, 4458.375827384169, 4626.861194164172, 4669.743164125972, 4674.252119660855, 4699.506551812062, 4456.442944631921, 4551.317302404633, 4567.200739870526, 4596.655250856191, 4601.4248218972625, 3681.5029970953847, 3683.2081102562943, 3689.760165589228, 3700.0, 3707.443883417482, 3442.845071971767, 3601.8019008954498, 3644.16184277615, 3658.926821463569, 3695.2794205130012, 3560.5045880730027, 3622.619624939383, 3653.8855649027037, 3658.963410365889, 3659.5425571803526, 3644.5079914211638, 3647.7993710345922, 3652.3060618482405, 3652.6347365263528, 3663.1867225723304, 3257.218267615779, 3261.8858339958224, 3269.673032696735, 3269.9509507357407, 3280.2778541266025, 4280.807363668611, 4496.460424749051, 4519.615832654228, 4522.773861306921, 4545.659075569345, 4170.395292682574, 4171.707980441371, 4181.937270940938, 4186.81159347827, 4194.182134483777, 4840.709557426566, 4841.298011788306, 4855.150348688965, 4855.8057677693205, 4859.854204373874, 3375.206826395795, 3554.0937061049267, 3556.5020897074432, 3557.2174121693447, 3567.982160089183, 4971.37857767779, 5001.774920128603, 5012.849614511534, 5012.874678133039, 5052.368453943257, 3605.3690604144695, 3633.709303255786, 3635.9636403635627, 3636.1818590817384, 3653.6163702811355, 3682.5028621135802, 3687.575928768172, 3693.169036966661, 3695.2978934002454, 3703.7592556484283, 3954.248692748426, 4149.481314835645, 4171.853985110507, 4194.0, 4199.181159673895, 4829.444613869379, 4837.153498137812, 4849.80600775965, 4853.684510506876, 4860.538248866352, 1208.1482554798845, 1232.6363722701824, 1233.4881024374963, 1271.1546821363875, 1286.6204469681466, 880.1770344727572, 886.7517095213351, 895.7536677413633, 899.595182168027, 899.7615631857562, 4266.850660226877, 4267.997020700133, 4283.136835476515, 4284.507281662586, 4288.592583704543, 4902.2646603009125, 4912.361393018885, 4922.433920099163, 4924.778384972685, 4926.679765815211, 4287.914241715211, 4291.849785257501, 4294.549072347421, 4295.183915056129, 4307.741535507879, 2304.9539009220057, 2486.539990101837, 2615.790736741056, 2624.1471521755507, 2631.2895518209975, 4795.856124316276, 4798.424189097261, 4810.374651295379, 4813.15769740294, 4819.542143496362, 5052.387542906766, 5060.898782024413, 5084.720340381241, 5090.160123579568, 5099.419180054195, 4669.673122881366, 4766.285057241442, 4807.71633474104, 4818.156822556039, 4818.518148185293, 4946.851594452172, 4950.4059512858685, 4951.653384263067, 4952.752362381794, 4964.851054468371, 4885.825807515622, 4897.8285759998225, 4901.436334821541, 4905.0, 4909.729964851825, 4594.862154135381, 4728.62171026324, 4808.735519546459, 4812.422509298766, 4829.7585120743115, 3484.3728128937037, 3486.302739452069, 3488.1977145256224, 3491.4937334085907, 3506.054139952351, 4736.73947932867, 4889.3888263967, 4921.975390123026, 4924.778384972757, 4940.6788558743565, 4526.456825181, 4741.454732705783, 4800.759962001816, 4804.255340422101, 4858.3441235432765, 4818.0, 4821.7589120544535, 4837.782299796588, 4846.95153048465, 4848.903021939471, 4561.315802629632, 4757.3577567028005, 4772.308015337687, 4778.808847646055, 4787.952120478751, 4849.80600775965, 4870.634702397264, 4870.634702397405, 4874.2444921037295, 4881.926771098508, 4766.833160839354, 4771.902462433591, 4773.809047638056, 4788.832390866303, 4790.329353890528], "value": 3675.326287667157, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [639.8912184928558, 663.8871391863382, 699.9615021173837, 708.8546847896182, 741.9406447484201, 12430.564930227443, 13096.279704616254, 13766.242856642893, 14307.284635768196, 14348.641283967907, 14118.223497707622, 14281.571552853406, 14296.0, 14299.142051476918, 14304.070235434716, 621.5462712220082, 761.2273542354528, 783.4437549339975, 788.538704857659, 788.763370988704, 637.8788030274256, 648.1573953859963, 648.6464876642218, 649.0621052579025, 755.9508631938934, 801.2708435323857, 825.051191130202, 828.494618282847, 829.867221244601, 830.6428235858579, 823.074041703084, 823.3824631526385, 824.11819353292, 824.2005254902734, 824.2046425199682, 486.4964761471895, 489.5593965431105, 605.446016894541, 606.4451027310006, 606.7118118893491, 12121.757564848655, 12549.184303020274, 12598.68503287416, 12861.485540578366, 12862.0, 12027.21823081497, 12677.348275621389, 12948.676283092904, 13039.0, 13139.27733974631, 10502.68491945243, 10552.630657927013, 10595.894041059568, 10730.731731706692, 10813.405262710548, 3281.2453135778906, 3295.3574053059665, 3314.419976504126, 3316.2041110133637, 3323.850426730803, 60753.69623151856, 61379.693101534656, 61402.0, 61457.385426145614, 62343.68828155875, 8986.505742184243, 9104.81790364189, 9172.954135229415, 9223.861642075375, 9453.669121580711, 17222.483325500256, 17354.479365618798, 17357.3057077718, 17642.38251661186, 19201.231950722093, 6324.841878952971, 6414.166158399472, 6436.967815160894, 6549.377809108127, 6815.625140617214, 3509.7543171978227, 3590.5870824854956, 3621.855125794939, 3684.5210122684416, 3704.592494825567, 2882.769378449719, 3003.504421770427, 3043.8630261638277, 3171.6035495563056, 3172.508920807217, 538.265267909301, 540.367769709441, 541.7697478571591, 543.7987944460575, 554.0636324611394, 571.1718008887048, 591.3377017740073, 599.6641880546907, 604.9697515124226, 633.4583930739244, 8062.274395304451, 8204.097549269576, 8571.95714021426, 8643.882248849071, 8650.913490865136, 588.4380416702124, 589.2192844480994, 611.2329027070997, 612.9478994285536, 614.9385061493815, 3908.0, 4147.440095587057, 4240.448741663626, 4255.255599086031, 4356.978215108904, 64264.678676606316, 89499.73501854939, 95031.52484237673, 99228.0, 102114.48942755238, 83503.58248208721, 86219.5689021551, 86499.0, 87944.56027719949, 89948.0, 73048.63475682694, 74033.0, 74207.25792742112, 74412.25587744053, 74585.25414745892, 8057.677692892219, 8249.79375515593, 8328.791780205302, 8377.95811020941, 8388.832223355377, 45909.77045114753, 46604.7669761649, 47126.0, 47545.52454475549, 47577.762111190605, 36903.26193476169, 48655.0, 50248.74875625598, 51390.22914656358, 59699.40300596938, 11022.50398732075, 11062.944685276521, 11166.720831979266, 11684.240524365889, 11911.344876031555, 12379.257244565355, 12459.317992070954, 12866.163699359511, 13095.083344165816, 13345.532906348231, 11070.39112848801, 11945.631299221362, 12321.210154514438, 12372.505099795908, 12472.563460278847, 11394.856730314687, 11789.292642441482, 11845.822312665488, 12385.752284954431, 12395.93802030984, 11089.223754337441, 11817.350045747566, 12401.565945191875, 12406.62780116598, 12408.131430799758, 9163.633454661738, 9385.249180065442, 9577.616895324387, 9716.951415242878, 9978.151857092229, 8772.473651580925, 9208.55752747322, 9487.241020718464, 9594.18449431806, 9788.314817962675], "value": 6498.855073835802, "unit": "score"}], "name": "dromaeo_css", "value": 6107.870500177819, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 115.0, 115.0, 115.0, 115.0, 114.0, 114.0, 116.0, 116.0, 115.0], "value": 114.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 127.0, 131.0, 163.0, 127.0, 131.0, 129.0, 125.0, 181.0, 125.0], "value": 139.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 162.0, 161.0, 161.0, 161.0, 162.0, 162.0, 161.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, 112.0, 76.0, 77.0, 76.0, 77.0, 98.0, 75.0], "value": 81.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 120.0, 83.0, 84.0, 83.0, 105.0, 84.0, 83.0, 113.0], "value": 92.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 116.0, 118.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 146.0, 147.0, 147.0, 147.0, 146.0, 147.0, 146.0, 147.0], "value": 146.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 72.0, 64.0, 65.0, 65.0, 65.0, 65.0, 63.0, 64.0], "value": 65.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 66.0, 66.0, 66.0, 65.0, 65.0, 65.0, 66.0, 65.0], "value": 65.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 94.0, 84.0, 84.0, 92.0, 83.0, 93.0, 82.0, 82.0], "value": 85.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 146.0, 137.0, 137.0, 141.0, 140.0, 138.0, 146.0, 175.0, 137.0], "value": 144.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 180.0, 177.0, 176.0, 182.0, 179.0, 181.0, 182.0, 176.0, 175.0], "value": 178.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 71.0, 72.0, 71.0, 70.0, 70.0, 71.0, 69.0, 69.0, 70.0], "value": 70.2, "unit": "score"}], "name": "kraken", "value": 1558.1000000000004, "alertThreshold": 2.0}]} 20:54:52 INFO - Return code: 0 20:54:52 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 20:54:52 INFO - # TBPL SUCCESS # 20:54:52 INFO - Running post-action listener: _resource_record_post_action 20:54:52 INFO - [mozharness: 2016-10-11 03:54:52.606437Z] Finished run-tests step (success) 20:54:52 INFO - Running post-run listener: _resource_record_post_run 20:54:52 INFO - Total resource usage - Wall time: 1207s; CPU: 13.0%; Read bytes: 7860224; Write bytes: 414941184; Read time: 2268; Write time: 569260 20:54:52 INFO - TinderboxPrint: CPU usage
13.1% 20:54:52 INFO - TinderboxPrint: I/O read bytes / time
7,860,224 / 2,268 20:54:52 INFO - TinderboxPrint: I/O write bytes / time
414,941,184 / 569,260 20:54:52 INFO - TinderboxPrint: CPU idle
8,372.3 (86.9%) 20:54:52 INFO - TinderboxPrint: CPU user
1,204.1 (12.5%) 20:54:52 INFO - TinderboxPrint: Swap in / out
0 / 0 20:54:52 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 92209152; Read time: 0; Write time: 101348 20:54:52 INFO - run-tests - Wall time: 1191s; CPU: 13.0%; Read bytes: 5644288; Write bytes: 322732032; Read time: 2072; Write time: 467912 20:54:53 INFO - Running post-run listener: _upload_blobber_files 20:54:53 INFO - Blob upload gear active. 20:54:53 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:54:53 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 20:54:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 20:54:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 20:54:53 INFO - (blobuploader) - INFO - Open directory for files ... 20:54:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:54:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:54:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:54:57 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:54:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:54:57 INFO - (blobuploader) - INFO - Done attempting. 20:54:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 20:54:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:54:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:54:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 20:54:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:54:57 INFO - (blobuploader) - INFO - Done attempting. 20:54:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 20:54:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:54:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:54:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 20:54:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:54:58 INFO - (blobuploader) - INFO - Done attempting. 20:54:58 INFO - (blobuploader) - INFO - Iteration through files over. 20:54:58 INFO - Return code: 0 20:54:58 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:54:58 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:54:58 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6da3114b27f0058004ec3f8a8e69f1a8e07edb353bcddbb87835f93ad863dbb70d78b822e55480f74452df6d3a995b2e3705c19fb1be34860fd963226802d669", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/afb38726ffd10190dbdbdb037694ac27dedae45cf6737aa27a3e8034e319246baa36faaa19d1017c6a08284f00c9dc21c16b520e57c91086d6f7785417f402ec", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fc99020ed89d0957b8b58ee513537a025fafaf3e530cd9984383a7d3e12ff3791cc61f6835002f9ff86df09798df85dc5ce77a7295daeb6d1e7d474a7693aaf0"} 20:54:58 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:54:58 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:54:58 INFO - Contents: 20:54:58 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6da3114b27f0058004ec3f8a8e69f1a8e07edb353bcddbb87835f93ad863dbb70d78b822e55480f74452df6d3a995b2e3705c19fb1be34860fd963226802d669", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/afb38726ffd10190dbdbdb037694ac27dedae45cf6737aa27a3e8034e319246baa36faaa19d1017c6a08284f00c9dc21c16b520e57c91086d6f7785417f402ec", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fc99020ed89d0957b8b58ee513537a025fafaf3e530cd9984383a7d3e12ff3791cc61f6835002f9ff86df09798df85dc5ce77a7295daeb6d1e7d474a7693aaf0"} 20:54:58 INFO - Running post-run listener: copy_logs_to_upload_dir 20:54:58 INFO - Copying logs to upload dir... 20:54:58 INFO - mkdir: /builds/slave/test/build/upload/logs 20:54:58 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1258.614605 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2016-10-10 20:54:58.592673) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-10 20:54:58.596584) ========= 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=5bd038846534b2fdfa68eeae000001e2-1476156406.407747-1304478935 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6da3114b27f0058004ec3f8a8e69f1a8e07edb353bcddbb87835f93ad863dbb70d78b822e55480f74452df6d3a995b2e3705c19fb1be34860fd963226802d669", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/afb38726ffd10190dbdbdb037694ac27dedae45cf6737aa27a3e8034e319246baa36faaa19d1017c6a08284f00c9dc21c16b520e57c91086d6f7785417f402ec", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fc99020ed89d0957b8b58ee513537a025fafaf3e530cd9984383a7d3e12ff3791cc61f6835002f9ff86df09798df85dc5ce77a7295daeb6d1e7d474a7693aaf0"} build_url:https://queue.taskcluster.net/v1/task/QZspG1aPQOW9z4FOXHJNBA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011271 build_url: 'https://queue.taskcluster.net/v1/task/QZspG1aPQOW9z4FOXHJNBA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6da3114b27f0058004ec3f8a8e69f1a8e07edb353bcddbb87835f93ad863dbb70d78b822e55480f74452df6d3a995b2e3705c19fb1be34860fd963226802d669", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/afb38726ffd10190dbdbdb037694ac27dedae45cf6737aa27a3e8034e319246baa36faaa19d1017c6a08284f00c9dc21c16b520e57c91086d6f7785417f402ec", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fc99020ed89d0957b8b58ee513537a025fafaf3e530cd9984383a7d3e12ff3791cc61f6835002f9ff86df09798df85dc5ce77a7295daeb6d1e7d474a7693aaf0"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-10 20:54:58.621482) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-10 20:54:58.621802) ========= 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=5bd038846534b2fdfa68eeae000001e2-1476156406.407747-1304478935 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004414 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-10 20:54:58.705024) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-10 20:54:58.705345) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-10 20:54:58.705627) ========= ========= Total master_lag: 0.15 =========