builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-002 starttime: 1477064743.81 results: success (0) buildid: 20161021075524 builduid: 53323205ee04478f9de15a1064a4c0af revision: fcadf6ec5ccf67c480047de89b5d063116938fea ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-21 08:45:43.809380) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-21 08:45:43.809808) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-21 08:45:43.810122) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-21 08:45:43.825657) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-21 08:45:43.825920) ========= 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=a0d2d2de893abaa8702a9954000001a7-1477050688.554526-2145565656 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-21 08:45:44-- 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% 21.2M=0.001s 2016-10-21 08:45:44 (21.2 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.082994 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-21 08:45:43.926580) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-21 08:45:43.926858) ========= 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=a0d2d2de893abaa8702a9954000001a7-1477050688.554526-2145565656 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020496 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-21 08:45:43.982169) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-21 08:45:43.982503) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev fcadf6ec5ccf67c480047de89b5d063116938fea --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 fcadf6ec5ccf67c480047de89b5d063116938fea --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=a0d2d2de893abaa8702a9954000001a7-1477050688.554526-2145565656 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-21 08:45:44,362 truncating revision to first 12 chars 2016-10-21 08:45:44,362 Setting DEBUG logging. 2016-10-21 08:45:44,362 attempt 1/10 2016-10-21 08:45:44,362 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/fcadf6ec5ccf?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-21 08:45:45,156 unpacking tar archive at: mozilla-central-fcadf6ec5ccf/testing/mozharness/ program finished with exit code 0 elapsedTime=1.146909 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-21 08:45:45.144078) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-21 08:45:45.144382) ========= script_repo_revision: fcadf6ec5ccf67c480047de89b5d063116938fea ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-21 08:45:45.144785) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-21 08:45:45.145076) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-21 08:45:45.153967) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-10-21 08:45:45.154230) ========= /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=a0d2d2de893abaa8702a9954000001a7-1477050688.554526-2145565656 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:45:45 INFO - MultiFileLogger online at 20161021 08:45:45 in /builds/slave/test 08:45:45 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 08:45:45 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:45:45 INFO - {'append_to_log': False, 08:45:45 INFO - 'base_work_dir': '/builds/slave/test', 08:45:45 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 08:45:45 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:45:45 INFO - 'branch': 'Firefox-Non-PGO', 08:45:45 INFO - 'buildbot_json_path': 'buildprops.json', 08:45:45 INFO - 'config_files': ('talos/linux_config.py',), 08:45:45 INFO - 'default_actions': ('clobber', 08:45:45 INFO - 'read-buildbot-config', 08:45:45 INFO - 'download-and-extract', 08:45:45 INFO - 'populate-webroot', 08:45:45 INFO - 'create-virtualenv', 08:45:45 INFO - 'install', 08:45:45 INFO - 'run-tests'), 08:45:45 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:45:45 INFO - 'download_minidump_stackwalk': True, 08:45:45 INFO - 'download_symbols': 'ondemand', 08:45:45 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:45:45 INFO - 'tooltool.py': '/tools/tooltool.py', 08:45:45 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:45:45 INFO - '/tools/misc-python/virtualenv.py')}, 08:45:45 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:45:45 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:45:45 INFO - 'installer_path': 'installer.exe', 08:45:45 INFO - 'log_level': 'info', 08:45:45 INFO - 'log_name': 'talos', 08:45:45 INFO - 'log_to_console': True, 08:45:45 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:45:45 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:45:45 INFO - 'opt_config_files': (), 08:45:45 INFO - 'pip_index': False, 08:45:45 INFO - 'sps_profile': False, 08:45:45 INFO - 'sps_profile_interval': 0, 08:45:45 INFO - 'suite': 'dromaeojs', 08:45:45 INFO - 'system_bits': '32', 08:45:45 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:45:45 INFO - 'title': 'talos-linux64-ix-002', 08:45:45 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:45:45 INFO - 'use_talos_json': True, 08:45:45 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:45:45 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:45:45 INFO - 'work_dir': 'build'} 08:45:45 INFO - [mozharness: 2016-10-21 15:45:45.636175Z] Running clobber step. 08:45:45 INFO - Running pre-action listener: _resource_record_pre_action 08:45:45 INFO - Running main action method: clobber 08:45:45 INFO - rmtree: /builds/slave/test/build 08:45:45 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:45:46 INFO - Running post-action listener: _resource_record_post_action 08:45:46 INFO - [mozharness: 2016-10-21 15:45:46.091749Z] Finished clobber step (success) 08:45:46 INFO - [mozharness: 2016-10-21 15:45:46.091848Z] Running read-buildbot-config step. 08:45:46 INFO - Running pre-action listener: _resource_record_pre_action 08:45:46 INFO - Running main action method: read_buildbot_config 08:45:46 INFO - Using buildbot properties: 08:45:46 INFO - { 08:45:46 INFO - "project": "", 08:45:46 INFO - "product": "firefox", 08:45:46 INFO - "script_repo_revision": "production", 08:45:46 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 08:45:46 INFO - "repository": "", 08:45:46 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 08:45:46 INFO - "buildid": "20161021075524", 08:45:46 INFO - "pgo_build": "False", 08:45:46 INFO - "basedir": "/builds/slave/test", 08:45:46 INFO - "buildnumber": 781, 08:45:46 INFO - "slavename": "talos-linux64-ix-002", 08:45:46 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 08:45:46 INFO - "platform": "ubuntu64_hw", 08:45:46 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 08:45:46 INFO - "branch": "mozilla-central", 08:45:46 INFO - "repo_path": "mozilla-central", 08:45:46 INFO - "revision": "fcadf6ec5ccf67c480047de89b5d063116938fea", 08:45:46 INFO - "stage_platform": "linux64", 08:45:46 INFO - "builduid": "53323205ee04478f9de15a1064a4c0af", 08:45:46 INFO - "slavebuilddir": "test" 08:45:46 INFO - } 08:45:46 INFO - Found installer url https://queue.taskcluster.net/v1/task/ITFVFJtnTtqb_OsjRt0rww/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 08:45:46 INFO - Running post-action listener: _resource_record_post_action 08:45:46 INFO - [mozharness: 2016-10-21 15:45:46.094313Z] Finished read-buildbot-config step (success) 08:45:46 INFO - [mozharness: 2016-10-21 15:45:46.094400Z] Running download-and-extract step. 08:45:46 INFO - Running pre-action listener: _resource_record_pre_action 08:45:46 INFO - Running main action method: download_and_extract 08:45:46 INFO - mkdir: /builds/slave/test/build/tests 08:45:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:45:46 INFO - trying https://queue.taskcluster.net/v1/task/ITFVFJtnTtqb_OsjRt0rww/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 08:45:46 INFO - Downloading https://queue.taskcluster.net/v1/task/ITFVFJtnTtqb_OsjRt0rww/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 08:45:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ITFVFJtnTtqb_OsjRt0rww/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 08:45:46 INFO - Downloaded 1361 bytes. 08:45:46 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 08:45:46 INFO - Using the following test package requirements: 08:45:46 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 08:45:46 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 08:45:46 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:45:46 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 08:45:46 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:45:46 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 08:45:46 INFO - u'jsshell-linux-x86_64.zip'], 08:45:46 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 08:45:46 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:45:46 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 08:45:46 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 08:45:46 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:45:46 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 08:45:46 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:45:46 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 08:45:46 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:45:46 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 08:45:46 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:45:46 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:45:46 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ITFVFJtnTtqb_OsjRt0rww/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 08:45:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ITFVFJtnTtqb_OsjRt0rww/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:45:46 INFO - Fetch https://queue.taskcluster.net/v1/task/ITFVFJtnTtqb_OsjRt0rww/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 08:45:47 INFO - Http code: 200 08:45:47 INFO - via: 1.1 8008015354a3ca72f56c382a1d1cfe9f.cloudfront.net (CloudFront) 08:45:47 INFO - x-amz-cf-id: vdBhDDAQ_89OC4LN0BP7yY8zL3ZCsS7mUqs4MbVncItZX0vjXdgfSg== 08:45:47 INFO - x-amz-version-id: 6FA7AZ87kwcveOhFrpdP.hkDMb68U9S5 08:45:47 INFO - Expected file size: 20460647 08:45:47 INFO - Obtained file size: 20460647 08:45:51 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 08:45:51 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ITFVFJtnTtqb_OsjRt0rww/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 08:45:51 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ITFVFJtnTtqb_OsjRt0rww/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:45:51 INFO - Fetch https://queue.taskcluster.net/v1/task/ITFVFJtnTtqb_OsjRt0rww/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 08:45:52 INFO - Http code: 200 08:45:52 INFO - via: 1.1 c54d7f08e2f3dab1918454910cc8aad0.cloudfront.net (CloudFront) 08:45:52 INFO - x-amz-cf-id: TYk0vUjOBtBCJdfjeBC1Qh9TfwXbciA7zcjas-BLuinATFkdIKOyAw== 08:45:52 INFO - x-amz-version-id: 6FA7AZ87kwcveOhFrpdP.hkDMb68U9S5 08:45:52 INFO - Expected file size: 20460647 08:45:52 INFO - Obtained file size: 20460647 08:45:56 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ITFVFJtnTtqb_OsjRt0rww/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 08:45:56 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ITFVFJtnTtqb_OsjRt0rww/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 08:45:56 INFO - Fetch https://queue.taskcluster.net/v1/task/ITFVFJtnTtqb_OsjRt0rww/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 08:45:57 INFO - Http code: 200 08:45:57 INFO - via: 1.1 9552af4ceb2e0dd55964a80d1e549fd5.cloudfront.net (CloudFront) 08:45:57 INFO - x-amz-cf-id: cFzmuCPLDQUdbZ-szIAtGHkFO1JTpd7_dqQLGI-EQWA5aqbvw_MWHA== 08:45:57 INFO - x-amz-version-id: BNgHuPuc7c.9tyjYqulDh6_iuZlo5LDG 08:45:57 INFO - Expected file size: 14409028 08:45:57 INFO - Obtained file size: 14409028 08:45:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:45:57 INFO - trying https://queue.taskcluster.net/v1/task/ITFVFJtnTtqb_OsjRt0rww/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 08:45:57 INFO - Downloading https://queue.taskcluster.net/v1/task/ITFVFJtnTtqb_OsjRt0rww/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 08:45:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ITFVFJtnTtqb_OsjRt0rww/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 08:45:58 INFO - Downloaded 55433357 bytes. 08:45:58 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ITFVFJtnTtqb_OsjRt0rww/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 08:45:58 INFO - mkdir: /builds/slave/test/properties 08:45:58 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:45:58 INFO - Writing to file /builds/slave/test/properties/build_url 08:45:58 INFO - Contents: 08:45:58 INFO - build_url:https://queue.taskcluster.net/v1/task/ITFVFJtnTtqb_OsjRt0rww/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 08:45:59 INFO - Running post-action listener: _resource_record_post_action 08:45:59 INFO - Running post-action listener: set_extra_try_arguments 08:45:59 INFO - [mozharness: 2016-10-21 15:45:59.636515Z] Finished download-and-extract step (success) 08:45:59 INFO - [mozharness: 2016-10-21 15:45:59.636813Z] Running populate-webroot step. 08:45:59 INFO - Running pre-action listener: _resource_record_pre_action 08:45:59 INFO - Running main action method: populate_webroot 08:45:59 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:45:59 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:45:59 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:45:59 INFO - '--tppagecycles', 08:45:59 INFO - '7'], 08:45:59 INFO - 'tests': ['tsvgm']}}, 08:45:59 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:45:59 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:45:59 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:45:59 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:45:59 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:45:59 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:45:59 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:45:59 INFO - 'talos_options': ['--disable-e10s'], 08:45:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:45:59 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:45:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:45:59 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:45:59 INFO - 'talos_options': ['--disable-e10s'], 08:45:59 INFO - 'tests': ['damp', 'tps']}, 08:45:59 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:45:59 INFO - 'tests': ['damp', 'tps']}, 08:45:59 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:45:59 INFO - 'tests': ['dromaeo_dom']}, 08:45:59 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:45:59 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:45:59 INFO - 'tests': ['basic_compositor_video']}, 08:45:59 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:45:59 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:45:59 INFO - 'tests': ['a11yr', 08:45:59 INFO - 'ts_paint', 08:45:59 INFO - 'tpaint', 08:45:59 INFO - 'sessionrestore', 08:45:59 INFO - 'sessionrestore_no_auto_restore', 08:45:59 INFO - 'tabpaint']}, 08:45:59 INFO - 'other-e10s': {'tests': ['a11yr', 08:45:59 INFO - 'ts_paint', 08:45:59 INFO - 'tpaint', 08:45:59 INFO - 'sessionrestore', 08:45:59 INFO - 'sessionrestore_no_auto_restore', 08:45:59 INFO - 'tabpaint']}, 08:45:59 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:45:59 INFO - 'ts_paint', 08:45:59 INFO - 'tpaint', 08:45:59 INFO - 'sessionrestore', 08:45:59 INFO - 'sessionrestore_no_auto_restore', 08:45:59 INFO - 'tabpaint']}, 08:45:59 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:45:59 INFO - 'ts_paint', 08:45:59 INFO - 'tpaint', 08:45:59 INFO - 'sessionrestore', 08:45:59 INFO - 'sessionrestore_no_auto_restore', 08:45:59 INFO - 'tabpaint']}, 08:45:59 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:45:59 INFO - 'tests': ['a11yr', 08:45:59 INFO - 'ts_paint', 08:45:59 INFO - 'tpaint', 08:45:59 INFO - 'sessionrestore', 08:45:59 INFO - 'sessionrestore_no_auto_restore', 08:45:59 INFO - 'tabpaint']}, 08:45:59 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:45:59 INFO - 'tests': ['a11yr', 08:45:59 INFO - 'ts_paint', 08:45:59 INFO - 'tpaint', 08:45:59 INFO - 'sessionrestore', 08:45:59 INFO - 'sessionrestore_no_auto_restore', 08:45:59 INFO - 'tabpaint']}, 08:45:59 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:45:59 INFO - 'tests': ['tsvgx', 08:45:59 INFO - 'tsvgr_opacity', 08:45:59 INFO - 'tart', 08:45:59 INFO - 'tscrollx', 08:45:59 INFO - 'cart']}, 08:45:59 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:45:59 INFO - 'tsvgr_opacity', 08:45:59 INFO - 'tart', 08:45:59 INFO - 'tscrollx', 08:45:59 INFO - 'cart']}, 08:45:59 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:45:59 INFO - 'talos_options': ['--disable-e10s'], 08:45:59 INFO - 'tests': ['tp5o']}, 08:45:59 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:45:59 INFO - 'tests': ['tp5o']}, 08:45:59 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:45:59 INFO - 'talos_options': ['--disable-e10s', 08:45:59 INFO - '--xperf_path', 08:45:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:45:59 INFO - 'tests': ['tp5n']}, 08:45:59 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:45:59 INFO - 'talos_options': ['--xperf_path', 08:45:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:45:59 INFO - 'tests': ['tp5n']}}, 08:45:59 INFO - 'talos.zip': {'path': '', 08:45:59 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:45:59 INFO - Running post-action listener: _resource_record_post_action 08:45:59 INFO - [mozharness: 2016-10-21 15:45:59.659835Z] Finished populate-webroot step (success) 08:45:59 INFO - [mozharness: 2016-10-21 15:45:59.659929Z] Running create-virtualenv step. 08:45:59 INFO - Running pre-action listener: _resource_record_pre_action 08:45:59 INFO - Running main action method: create_virtualenv 08:45:59 INFO - Creating virtualenv /builds/slave/test/build/venv 08:45:59 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 08:45:59 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:45:59 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:45:59 INFO - Using real prefix '/usr' 08:45:59 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:46:00 INFO - Installing distribute.............................................................................................................................................................................................done. 08:46:02 INFO - Installing pip.................done. 08:46:02 INFO - Return code: 0 08:46:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:46:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:46:02 INFO - Reading from file tmpfile_stdout 08:46:02 INFO - Output received: 08:46:02 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) 08:46:02 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:46:02 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')]} 08:46:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:46:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:46:02 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')]} 08:46:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:46:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:46:02 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 0x7f7a9fa88f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x210c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21d9ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21d6f60>, '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 0x21d7d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21d81d0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1477050688.554526-2145565656', '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 08:46:02 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 08:46:02 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 08:46:02 INFO - Using env: {'DISPLAY': ':0', 08:46:02 INFO - 'HOME': '/home/cltbld', 08:46:02 INFO - 'LANG': 'en_US.UTF-8', 08:46:02 INFO - 'LANGUAGE': 'en_US:en', 08:46:02 INFO - 'LOGNAME': 'cltbld', 08:46:02 INFO - 'MAIL': '/var/mail/cltbld', 08:46:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:46:02 INFO - 'MOZ_NO_REMOTE': '1', 08:46:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:46:02 INFO - 'NO_EM_RESTART': '1', 08:46:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:46:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:46:02 INFO - 'PWD': '/builds/slave/test', 08:46:02 INFO - 'SHELL': '/bin/bash', 08:46:02 INFO - 'SHLVL': '1', 08:46:02 INFO - 'TERM': 'linux', 08:46:02 INFO - 'TMOUT': '86400', 08:46:02 INFO - 'USER': 'cltbld', 08:46:02 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1477050688.554526-2145565656', 08:46:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:46:02 INFO - '_': '/tools/buildbot/bin/python'} 08:46:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:46:02 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 08:46:02 INFO - Cleaning up... 08:46:02 INFO - Return code: 0 08:46:02 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:46:02 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')]} 08:46:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:46:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:46:02 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')]} 08:46:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:46:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:46:02 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 0x7f7a9fa88f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x210c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21d9ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21d6f60>, '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 0x21d7d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21d81d0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1477050688.554526-2145565656', '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 08:46:02 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 08:46:02 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 08:46:02 INFO - Using env: {'DISPLAY': ':0', 08:46:02 INFO - 'HOME': '/home/cltbld', 08:46:02 INFO - 'LANG': 'en_US.UTF-8', 08:46:02 INFO - 'LANGUAGE': 'en_US:en', 08:46:02 INFO - 'LOGNAME': 'cltbld', 08:46:02 INFO - 'MAIL': '/var/mail/cltbld', 08:46:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:46:02 INFO - 'MOZ_NO_REMOTE': '1', 08:46:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:46:02 INFO - 'NO_EM_RESTART': '1', 08:46:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:46:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:46:02 INFO - 'PWD': '/builds/slave/test', 08:46:02 INFO - 'SHELL': '/bin/bash', 08:46:02 INFO - 'SHLVL': '1', 08:46:02 INFO - 'TERM': 'linux', 08:46:02 INFO - 'TMOUT': '86400', 08:46:02 INFO - 'USER': 'cltbld', 08:46:02 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1477050688.554526-2145565656', 08:46:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:46:02 INFO - '_': '/tools/buildbot/bin/python'} 08:46:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:46:02 INFO - Downloading/unpacking psutil>=3.1.1 08:46:02 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 08:46:02 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 08:46:02 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 08:46:02 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 08:46:02 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 08:46:02 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 08:46:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:46:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:46:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:46:04 INFO - Installing collected packages: psutil 08:46:04 INFO - Running setup.py install for psutil 08:46:04 INFO - building 'psutil._psutil_linux' extension 08:46:04 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 08:46:05 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 08:46:05 INFO - building 'psutil._psutil_posix' extension 08:46:05 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 08:46:05 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 08:46:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:46:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:46:05 INFO - Successfully installed psutil 08:46:05 INFO - Cleaning up... 08:46:05 INFO - Return code: 0 08:46:05 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:46:05 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')]} 08:46:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:46:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:46:05 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')]} 08:46:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:46:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:46:05 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 0x7f7a9fa88f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x210c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21d9ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21d6f60>, '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 0x21d7d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21d81d0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1477050688.554526-2145565656', '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 08:46:05 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 08:46:05 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 08:46:05 INFO - Using env: {'DISPLAY': ':0', 08:46:05 INFO - 'HOME': '/home/cltbld', 08:46:05 INFO - 'LANG': 'en_US.UTF-8', 08:46:05 INFO - 'LANGUAGE': 'en_US:en', 08:46:05 INFO - 'LOGNAME': 'cltbld', 08:46:05 INFO - 'MAIL': '/var/mail/cltbld', 08:46:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:46:05 INFO - 'MOZ_NO_REMOTE': '1', 08:46:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:46:05 INFO - 'NO_EM_RESTART': '1', 08:46:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:46:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:46:05 INFO - 'PWD': '/builds/slave/test', 08:46:05 INFO - 'SHELL': '/bin/bash', 08:46:05 INFO - 'SHLVL': '1', 08:46:05 INFO - 'TERM': 'linux', 08:46:05 INFO - 'TMOUT': '86400', 08:46:05 INFO - 'USER': 'cltbld', 08:46:05 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1477050688.554526-2145565656', 08:46:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:46:05 INFO - '_': '/tools/buildbot/bin/python'} 08:46:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:46:05 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:46:05 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 08:46:05 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 08:46:05 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 08:46:05 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 08:46:05 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 08:46:05 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 08:46:07 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:46:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:46:07 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:46:07 INFO - Installing collected packages: mozsystemmonitor 08:46:07 INFO - Running setup.py install for mozsystemmonitor 08:46:07 INFO - Successfully installed mozsystemmonitor 08:46:07 INFO - Cleaning up... 08:46:07 INFO - Return code: 0 08:46:07 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:46:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:46:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:46:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:46:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:46:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:46:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:46:07 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 0x7f7a9fa88f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x210c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21d9ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21d6f60>, '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 0x21d7d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21d81d0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1477050688.554526-2145565656', '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 08:46:07 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 08:46:07 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 08:46:07 INFO - Using env: {'DISPLAY': ':0', 08:46:07 INFO - 'HOME': '/home/cltbld', 08:46:07 INFO - 'LANG': 'en_US.UTF-8', 08:46:07 INFO - 'LANGUAGE': 'en_US:en', 08:46:07 INFO - 'LOGNAME': 'cltbld', 08:46:07 INFO - 'MAIL': '/var/mail/cltbld', 08:46:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:46:07 INFO - 'MOZ_NO_REMOTE': '1', 08:46:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:46:07 INFO - 'NO_EM_RESTART': '1', 08:46:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:46:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:46:07 INFO - 'PWD': '/builds/slave/test', 08:46:07 INFO - 'SHELL': '/bin/bash', 08:46:07 INFO - 'SHLVL': '1', 08:46:07 INFO - 'TERM': 'linux', 08:46:07 INFO - 'TMOUT': '86400', 08:46:07 INFO - 'USER': 'cltbld', 08:46:07 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1477050688.554526-2145565656', 08:46:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:46:07 INFO - '_': '/tools/buildbot/bin/python'} 08:46:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:46:08 INFO - Downloading/unpacking jsonschema==2.5.1 08:46:08 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 08:46:08 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 08:46:08 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 08:46:08 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 08:46:08 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 08:46:08 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 08:46:09 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:46:09 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:46:09 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 08:46:09 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 08:46:09 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 08:46:09 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 08:46:09 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 08:46:09 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 08:46:10 INFO - Downloading functools32-3.2.3-2.tar.gz 08:46:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:46:10 INFO - warning: no files found matching '*.txt' 08:46:10 INFO - no previously-included directories found matching 'build' 08:46:10 INFO - no previously-included directories found matching 'dist' 08:46:10 INFO - no previously-included directories found matching '.git*' 08:46:10 INFO - Installing collected packages: jsonschema, functools32 08:46:10 INFO - Running setup.py install for functools32 08:46:10 INFO - warning: no files found matching '*.txt' 08:46:10 INFO - no previously-included directories found matching 'build' 08:46:10 INFO - no previously-included directories found matching 'dist' 08:46:10 INFO - no previously-included directories found matching '.git*' 08:46:10 INFO - Successfully installed jsonschema functools32 08:46:10 INFO - Cleaning up... 08:46:10 INFO - Return code: 0 08:46:10 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:46:10 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')]} 08:46:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:46:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:46:10 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')]} 08:46:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:46:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:46:10 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 0x7f7a9fa88f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x210c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21d9ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21d6f60>, '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 0x21d7d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21d81d0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1477050688.554526-2145565656', '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 08:46:10 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 08:46:10 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 08:46:10 INFO - Using env: {'DISPLAY': ':0', 08:46:10 INFO - 'HOME': '/home/cltbld', 08:46:10 INFO - 'LANG': 'en_US.UTF-8', 08:46:10 INFO - 'LANGUAGE': 'en_US:en', 08:46:10 INFO - 'LOGNAME': 'cltbld', 08:46:10 INFO - 'MAIL': '/var/mail/cltbld', 08:46:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:46:10 INFO - 'MOZ_NO_REMOTE': '1', 08:46:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:46:10 INFO - 'NO_EM_RESTART': '1', 08:46:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:46:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:46:10 INFO - 'PWD': '/builds/slave/test', 08:46:10 INFO - 'SHELL': '/bin/bash', 08:46:10 INFO - 'SHLVL': '1', 08:46:10 INFO - 'TERM': 'linux', 08:46:10 INFO - 'TMOUT': '86400', 08:46:10 INFO - 'USER': 'cltbld', 08:46:10 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1477050688.554526-2145565656', 08:46:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:46:10 INFO - '_': '/tools/buildbot/bin/python'} 08:46:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:46:10 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:46:10 INFO - Cleaning up... 08:46:10 INFO - Return code: 0 08:46:10 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:46:10 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')]} 08:46:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:46:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:46:10 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')]} 08:46:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:46:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:46:10 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 0x7f7a9fa88f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x210c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21d9ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21d6f60>, '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 0x21d7d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21d81d0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1477050688.554526-2145565656', '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 08:46:10 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 08:46:10 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 08:46:10 INFO - Using env: {'DISPLAY': ':0', 08:46:10 INFO - 'HOME': '/home/cltbld', 08:46:10 INFO - 'LANG': 'en_US.UTF-8', 08:46:10 INFO - 'LANGUAGE': 'en_US:en', 08:46:10 INFO - 'LOGNAME': 'cltbld', 08:46:10 INFO - 'MAIL': '/var/mail/cltbld', 08:46:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:46:10 INFO - 'MOZ_NO_REMOTE': '1', 08:46:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:46:10 INFO - 'NO_EM_RESTART': '1', 08:46:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:46:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:46:10 INFO - 'PWD': '/builds/slave/test', 08:46:10 INFO - 'SHELL': '/bin/bash', 08:46:10 INFO - 'SHLVL': '1', 08:46:10 INFO - 'TERM': 'linux', 08:46:10 INFO - 'TMOUT': '86400', 08:46:10 INFO - 'USER': 'cltbld', 08:46:10 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1477050688.554526-2145565656', 08:46:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:46:10 INFO - '_': '/tools/buildbot/bin/python'} 08:46:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:46:10 INFO - Downloading/unpacking blobuploader==1.2.4 08:46:10 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 08:46:10 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 08:46:10 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 08:46:10 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 08:46:10 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 08:46:10 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 08:46:12 INFO - Downloading blobuploader-1.2.4.tar.gz 08:46:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:46:12 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:46:12 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 08:46:12 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 08:46:12 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 08:46:12 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 08:46:12 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 08:46:12 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 08:46:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:46:13 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:46:13 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 08:46:13 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 08:46:13 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 08:46:13 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 08:46:13 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 08:46:13 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 08:46:13 INFO - Downloading docopt-0.6.1.tar.gz 08:46:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:46:13 INFO - Installing collected packages: blobuploader, requests, docopt 08:46:13 INFO - Running setup.py install for blobuploader 08:46:13 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:46:13 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:46:13 INFO - Running setup.py install for requests 08:46:14 INFO - Running setup.py install for docopt 08:46:14 INFO - Successfully installed blobuploader requests docopt 08:46:14 INFO - Cleaning up... 08:46:14 INFO - Return code: 0 08:46:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:46:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:46:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:46:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:46:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:46:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:46:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:46:14 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 0x7f7a9fa88f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x210c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21d9ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21d6f60>, '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 0x21d7d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21d81d0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1477050688.554526-2145565656', '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 08:46:14 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 08:46:14 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 08:46:14 INFO - Using env: {'DISPLAY': ':0', 08:46:14 INFO - 'HOME': '/home/cltbld', 08:46:14 INFO - 'LANG': 'en_US.UTF-8', 08:46:14 INFO - 'LANGUAGE': 'en_US:en', 08:46:14 INFO - 'LOGNAME': 'cltbld', 08:46:14 INFO - 'MAIL': '/var/mail/cltbld', 08:46:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:46:14 INFO - 'MOZ_NO_REMOTE': '1', 08:46:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:46:14 INFO - 'NO_EM_RESTART': '1', 08:46:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:46:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:46:14 INFO - 'PWD': '/builds/slave/test', 08:46:14 INFO - 'SHELL': '/bin/bash', 08:46:14 INFO - 'SHLVL': '1', 08:46:14 INFO - 'TERM': 'linux', 08:46:14 INFO - 'TMOUT': '86400', 08:46:14 INFO - 'USER': 'cltbld', 08:46:14 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1477050688.554526-2145565656', 08:46:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:46:14 INFO - '_': '/tools/buildbot/bin/python'} 08:46:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:46:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:46:14 INFO - Running setup.py (path:/tmp/pip-4WJ7fl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:46:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:46:14 INFO - Running setup.py (path:/tmp/pip-vtv3r8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:46:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:46:14 INFO - Running setup.py (path:/tmp/pip-CyqDxx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:46:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:46:14 INFO - Running setup.py (path:/tmp/pip-apR5Kd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:46:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:46:14 INFO - Running setup.py (path:/tmp/pip-vqocFB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:46:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:46:14 INFO - Running setup.py (path:/tmp/pip-CFEpXt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:46:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:46:14 INFO - Running setup.py (path:/tmp/pip-JN3aUr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:46:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:46:14 INFO - Running setup.py (path:/tmp/pip-YTwv8W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:46:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:46:14 INFO - Running setup.py (path:/tmp/pip-ARWOxT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:46:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:46:15 INFO - Running setup.py (path:/tmp/pip-Ggd4DR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:46:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:46:15 INFO - Running setup.py (path:/tmp/pip-qbnWb8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:46:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:46:15 INFO - Running setup.py (path:/tmp/pip-5tupUF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:46:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:46:15 INFO - Running setup.py (path:/tmp/pip-HXNvLh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:46:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:46:15 INFO - Running setup.py (path:/tmp/pip-UcAVcm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:46:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:46:15 INFO - Running setup.py (path:/tmp/pip-eNSN4k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:46:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:46:15 INFO - Running setup.py (path:/tmp/pip-pVZjId-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:46:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:46:15 INFO - Running setup.py (path:/tmp/pip-okgpqk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:46:15 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:46:15 INFO - Running setup.py install for manifestparser 08:46:15 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:46:15 INFO - Running setup.py install for mozcrash 08:46:15 INFO - Running setup.py install for mozdebug 08:46:15 INFO - Running setup.py install for mozdevice 08:46:16 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:46:16 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:46:16 INFO - Running setup.py install for mozfile 08:46:16 INFO - Running setup.py install for mozhttpd 08:46:16 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:46:16 INFO - Running setup.py install for mozinfo 08:46:16 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:46:16 INFO - Running setup.py install for mozInstall 08:46:16 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:46:16 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:46:16 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:46:16 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:46:16 INFO - Running setup.py install for mozleak 08:46:16 INFO - Running setup.py install for mozlog 08:46:16 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:46:16 INFO - Running setup.py install for moznetwork 08:46:16 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:46:16 INFO - Running setup.py install for mozprocess 08:46:16 INFO - Running setup.py install for mozprofile 08:46:16 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:46:16 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:46:16 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:46:16 INFO - Running setup.py install for mozrunner 08:46:17 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:46:17 INFO - Running setup.py install for mozscreenshot 08:46:17 INFO - Running setup.py install for moztest 08:46:17 INFO - Running setup.py install for mozversion 08:46:17 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:46:17 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:46:17 INFO - Cleaning up... 08:46:17 INFO - Return code: 0 08:46:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:46:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:46:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:46:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:46:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:46:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:46:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:46:17 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 0x7f7a9fa88f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x210c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21d9ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21d6f60>, '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 0x21d7d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21d81d0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1477050688.554526-2145565656', '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 08:46:17 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 08:46:17 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 08:46:17 INFO - Using env: {'DISPLAY': ':0', 08:46:17 INFO - 'HOME': '/home/cltbld', 08:46:17 INFO - 'LANG': 'en_US.UTF-8', 08:46:17 INFO - 'LANGUAGE': 'en_US:en', 08:46:17 INFO - 'LOGNAME': 'cltbld', 08:46:17 INFO - 'MAIL': '/var/mail/cltbld', 08:46:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:46:17 INFO - 'MOZ_NO_REMOTE': '1', 08:46:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:46:17 INFO - 'NO_EM_RESTART': '1', 08:46:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:46:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:46:17 INFO - 'PWD': '/builds/slave/test', 08:46:17 INFO - 'SHELL': '/bin/bash', 08:46:17 INFO - 'SHLVL': '1', 08:46:17 INFO - 'TERM': 'linux', 08:46:17 INFO - 'TMOUT': '86400', 08:46:17 INFO - 'USER': 'cltbld', 08:46:17 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1477050688.554526-2145565656', 08:46:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:46:17 INFO - '_': '/tools/buildbot/bin/python'} 08:46:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:46:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:46:17 INFO - Running setup.py (path:/tmp/pip-ZA83T_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:46:17 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)) 08:46:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:46:17 INFO - Running setup.py (path:/tmp/pip-wqfbjA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:46:17 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)) 08:46:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:46:17 INFO - Running setup.py (path:/tmp/pip-mvGwYc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:46:17 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)) 08:46:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:46:17 INFO - Running setup.py (path:/tmp/pip-tKiOgx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:46:17 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)) 08:46:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:46:17 INFO - Running setup.py (path:/tmp/pip-KNpPkl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:46:18 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)) 08:46:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:46:18 INFO - Running setup.py (path:/tmp/pip-BFT0AL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:46:18 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)) 08:46:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:46:18 INFO - Running setup.py (path:/tmp/pip-ToCbkU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:46:18 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)) 08:46:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:46:18 INFO - Running setup.py (path:/tmp/pip-_lfjTT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:46:18 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)) 08:46:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:46:18 INFO - Running setup.py (path:/tmp/pip-jR4bzF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:46:18 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)) 08:46:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:46:18 INFO - Running setup.py (path:/tmp/pip-cPj32C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:46:18 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)) 08:46:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:46:18 INFO - Running setup.py (path:/tmp/pip-SUKHRf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:46:18 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)) 08:46:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:46:18 INFO - Running setup.py (path:/tmp/pip-i2cJNN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:46:18 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)) 08:46:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:46:18 INFO - Running setup.py (path:/tmp/pip-Uskvam-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:46:18 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)) 08:46:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:46:18 INFO - Running setup.py (path:/tmp/pip-XCQrrr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:46:18 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)) 08:46:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:46:18 INFO - Running setup.py (path:/tmp/pip-894tc3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:46:18 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)) 08:46:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:46:18 INFO - Running setup.py (path:/tmp/pip-rxEPv_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:46:18 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)) 08:46:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:46:18 INFO - Running setup.py (path:/tmp/pip-FO8mjz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:46:18 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)) 08:46:18 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)) 08:46:18 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)) 08:46:18 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)) 08:46:18 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)) 08:46:18 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)) 08:46:18 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:46:18 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 08:46:18 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 08:46:18 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 08:46:18 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 08:46:18 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 08:46:18 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 08:46:20 INFO - Downloading blessings-1.6.tar.gz 08:46:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:46:20 INFO - Installing collected packages: blessings 08:46:20 INFO - Running setup.py install for blessings 08:46:21 INFO - Successfully installed blessings 08:46:21 INFO - Cleaning up... 08:46:21 INFO - Return code: 0 08:46:21 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:46:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:46:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:46:21 INFO - Reading from file tmpfile_stdout 08:46:21 INFO - Current package versions: 08:46:21 INFO - argparse == 1.2.1 08:46:21 INFO - blessings == 1.6 08:46:21 INFO - blobuploader == 1.2.4 08:46:21 INFO - docopt == 0.6.1 08:46:21 INFO - functools32 == 3.2.3-2 08:46:21 INFO - jsonschema == 2.5.1 08:46:21 INFO - manifestparser == 1.1 08:46:21 INFO - mozInstall == 1.12 08:46:21 INFO - mozcrash == 0.17 08:46:21 INFO - mozdebug == 0.1 08:46:21 INFO - mozdevice == 0.48 08:46:21 INFO - mozfile == 1.2 08:46:21 INFO - mozhttpd == 0.7 08:46:21 INFO - mozinfo == 0.9 08:46:21 INFO - mozleak == 0.1 08:46:21 INFO - mozlog == 3.4 08:46:21 INFO - moznetwork == 0.27 08:46:21 INFO - mozprocess == 0.23 08:46:21 INFO - mozprofile == 0.28 08:46:21 INFO - mozrunner == 6.12 08:46:21 INFO - mozscreenshot == 0.1 08:46:21 INFO - mozsystemmonitor == 0.3 08:46:21 INFO - moztest == 0.7 08:46:21 INFO - mozversion == 1.4 08:46:21 INFO - psutil == 3.1.1 08:46:21 INFO - requests == 1.2.3 08:46:21 INFO - wsgiref == 0.1.2 08:46:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:46:21 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')]} 08:46:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:46:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:46:21 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')]} 08:46:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:46:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:46:21 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 0x7f7a9fa88f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x210c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21d9ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21d6f60>, '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 0x21d7d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21d81d0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1477050688.554526-2145565656', '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 08:46:21 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 08:46:21 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 08:46:21 INFO - Using env: {'DISPLAY': ':0', 08:46:21 INFO - 'HOME': '/home/cltbld', 08:46:21 INFO - 'LANG': 'en_US.UTF-8', 08:46:21 INFO - 'LANGUAGE': 'en_US:en', 08:46:21 INFO - 'LOGNAME': 'cltbld', 08:46:21 INFO - 'MAIL': '/var/mail/cltbld', 08:46:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:46:21 INFO - 'MOZ_NO_REMOTE': '1', 08:46:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:46:21 INFO - 'NO_EM_RESTART': '1', 08:46:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:46:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:46:21 INFO - 'PWD': '/builds/slave/test', 08:46:21 INFO - 'SHELL': '/bin/bash', 08:46:21 INFO - 'SHLVL': '1', 08:46:21 INFO - 'TERM': 'linux', 08:46:21 INFO - 'TMOUT': '86400', 08:46:21 INFO - 'USER': 'cltbld', 08:46:21 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1477050688.554526-2145565656', 08:46:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:46:21 INFO - '_': '/tools/buildbot/bin/python'} 08:46:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:46:21 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)) 08:46:21 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)) 08:46:21 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)) 08:46:21 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)) 08:46:21 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)) 08:46:21 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)) 08:46:21 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)) 08:46:21 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)) 08:46:21 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)) 08:46:21 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)) 08:46:21 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)) 08:46:21 INFO - Cleaning up... 08:46:21 INFO - Return code: 0 08:46:21 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:46:21 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')]} 08:46:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:46:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:46:21 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')]} 08:46:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:46:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:46:21 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 0x7f7a9fa88f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x210c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21d9ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21d6f60>, '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 0x21d7d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21d81d0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1477050688.554526-2145565656', '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 08:46:21 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 08:46:21 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 08:46:21 INFO - Using env: {'DISPLAY': ':0', 08:46:21 INFO - 'HOME': '/home/cltbld', 08:46:21 INFO - 'LANG': 'en_US.UTF-8', 08:46:21 INFO - 'LANGUAGE': 'en_US:en', 08:46:21 INFO - 'LOGNAME': 'cltbld', 08:46:21 INFO - 'MAIL': '/var/mail/cltbld', 08:46:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:46:21 INFO - 'MOZ_NO_REMOTE': '1', 08:46:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:46:21 INFO - 'NO_EM_RESTART': '1', 08:46:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:46:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:46:21 INFO - 'PWD': '/builds/slave/test', 08:46:21 INFO - 'SHELL': '/bin/bash', 08:46:21 INFO - 'SHLVL': '1', 08:46:21 INFO - 'TERM': 'linux', 08:46:21 INFO - 'TMOUT': '86400', 08:46:21 INFO - 'USER': 'cltbld', 08:46:21 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1477050688.554526-2145565656', 08:46:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:46:21 INFO - '_': '/tools/buildbot/bin/python'} 08:46:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:46:21 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:46:21 INFO - Cleaning up... 08:46:21 INFO - Return code: 0 08:46:21 INFO - Running post-action listener: _resource_record_post_action 08:46:21 INFO - Running post-action listener: _start_resource_monitoring 08:46:21 INFO - Starting resource monitoring. 08:46:21 INFO - [mozharness: 2016-10-21 15:46:21.805295Z] Finished create-virtualenv step (success) 08:46:21 INFO - [mozharness: 2016-10-21 15:46:21.805818Z] Running install step. 08:46:21 INFO - Running pre-action listener: _resource_record_pre_action 08:46:21 INFO - Running main action method: install 08:46:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:46:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:46:22 INFO - Reading from file tmpfile_stdout 08:46:22 INFO - Detecting whether we're running mozinstall >=1.0... 08:46:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:46:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:46:22 INFO - Reading from file tmpfile_stdout 08:46:22 INFO - Output received: 08:46:22 INFO - Usage: mozinstall [options] installer 08:46:22 INFO - Options: 08:46:22 INFO - -h, --help show this help message and exit 08:46:22 INFO - -d DEST, --destination=DEST 08:46:22 INFO - Directory to install application into. [default: 08:46:22 INFO - "/builds/slave/test"] 08:46:22 INFO - --app=APP Application being installed. [default: firefox] 08:46:22 INFO - mkdir: /builds/slave/test/build/application 08:46:22 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'] 08:46:22 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 08:46:38 INFO - Reading from file tmpfile_stdout 08:46:38 INFO - Output received: 08:46:38 INFO - /builds/slave/test/build/application/firefox/firefox 08:46:38 INFO - Running post-action listener: _resource_record_post_action 08:46:38 INFO - [mozharness: 2016-10-21 15:46:38.127612Z] Finished install step (success) 08:46:38 INFO - [mozharness: 2016-10-21 15:46:38.127858Z] Running run-tests step. 08:46:38 INFO - Running pre-action listener: _resource_record_pre_action 08:46:38 INFO - Running main action method: run_tests 08:46:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:46:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:46:38 INFO - Python 2.7.3 08:46:38 INFO - Return code: 0 08:46:38 INFO - grabbing minidump binary from tooltool 08:46:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:46:38 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 0x21d6f60>, '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 0x21d7d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21d81d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:46:38 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 08:46:38 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 08:46:38 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 08:46:38 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:46:38 INFO - Return code: 0 08:46:38 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:46:38 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:46:38 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:46:38 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:46:38 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:46:38 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/ITFVFJtnTtqb_OsjRt0rww/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-002', '--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 08:46:38 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/ITFVFJtnTtqb_OsjRt0rww/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-002 --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 08:46:38 INFO - Using env: {'DISPLAY': ':0', 08:46:38 INFO - 'HOME': '/home/cltbld', 08:46:38 INFO - 'LANG': 'en_US.UTF-8', 08:46:38 INFO - 'LANGUAGE': 'en_US:en', 08:46:38 INFO - 'LOGNAME': 'cltbld', 08:46:38 INFO - 'MAIL': '/var/mail/cltbld', 08:46:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:46:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:46:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:46:38 INFO - 'MOZ_NO_REMOTE': '1', 08:46:38 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:46:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:46:38 INFO - 'NO_EM_RESTART': '1', 08:46:38 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:46:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:46:38 INFO - 'PWD': '/builds/slave/test', 08:46:38 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:46:38 INFO - 'SHELL': '/bin/bash', 08:46:38 INFO - 'SHLVL': '1', 08:46:38 INFO - 'TERM': 'linux', 08:46:38 INFO - 'TMOUT': '86400', 08:46:38 INFO - 'USER': 'cltbld', 08:46:38 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1477050688.554526-2145565656', 08:46:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:46:38 INFO - '_': '/tools/buildbot/bin/python'} 08:46:38 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/ITFVFJtnTtqb_OsjRt0rww/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-002', '--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 08:46:38 INFO - mozversion application_buildid: 20161021075524 08:46:38 INFO - mozversion application_changeset: fcadf6ec5ccf67c480047de89b5d063116938fea 08:46:38 INFO - mozversion application_display_name: Nightly 08:46:38 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:46:38 INFO - mozversion application_name: Firefox 08:46:38 INFO - mozversion application_remotingname: firefox 08:46:38 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 08:46:38 INFO - mozversion application_vendor: Mozilla 08:46:38 INFO - mozversion application_version: 52.0a1 08:46:38 INFO - mozversion platform_buildid: 20161021075524 08:46:38 INFO - mozversion platform_changeset: fcadf6ec5ccf67c480047de89b5d063116938fea 08:46:38 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 08:46:38 INFO - mozversion platform_version: 52.0a1 08:46:38 INFO - using testdate: 1477064798 08:46:38 INFO - actual date: 1477064798 08:46:38 INFO - starting webserver on 'localhost:45662' 08:46:38 INFO - SUITE-START | Running 2 tests 08:46:38 INFO - TEST-START | dromaeo_css 08:46:38 INFO - operating with platform_type : linux_ 08:46:38 INFO - Initialising browser for dromaeo_css test... 08:46:38 INFO - TEST-INFO | started process 8904 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuPcFJL/profile http://localhost:45662/getInfo.html) 08:46:42 INFO - PROCESS | 8904 | __metrics Screen width/height:1600/1200 08:46:42 INFO - PROCESS | 8904 | colorDepth:24 08:46:42 INFO - PROCESS | 8904 | Browser inner width/height: 1024/697 08:46:42 INFO - PROCESS | 8904 | __metrics 08:46:43 INFO - PROCESS | 8904 | 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" 08:46:43 INFO - PROCESS | 8904 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:46:44 INFO - PROCESS | 8904 | console.error: PushService: 08:46:44 INFO - PROCESS | 8904 | stateChangeProcessEnqueue: Error transitioning state 08:46:44 INFO - PROCESS | 8904 | UnknownError 08:46:44 INFO - TEST-INFO | 8904: exit 0 08:46:44 INFO - Browser initialized. 08:46:44 INFO - Running cycle 1/1 for dromaeo_css test... 08:46:44 INFO - TEST-INFO | started process 8984 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuPcFJL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:46:57 INFO - PROCESS | 8984 | RSS: Main: 173162496 08:46:57 INFO - PROCESS | 8984 | 08:47:48 INFO - PROCESS | 8984 | 1477064868800 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] 08:50:01 INFO - PROCESS | 8984 | Cycle 1(1): loaded http://localhost:45662/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45662/tests/dromaeo/cssquery-ext.html) 08:50:03 INFO - PROCESS | 8984 | RSS: Main: 354217984 08:50:03 INFO - PROCESS | 8984 | 08:53:06 INFO - PROCESS | 8984 | Cycle 1(1): loaded http://localhost:45662/tests/dromaeo/cssquery-ext.html (next: http://localhost:45662/tests/dromaeo/cssquery-jquery.html) 08:53:07 INFO - PROCESS | 8984 | RSS: Main: 288788480 08:53:07 INFO - PROCESS | 8984 | 08:56:09 INFO - PROCESS | 8984 | Cycle 1(1): loaded http://localhost:45662/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45662/tests/dromaeo/cssquery-mootools.html) 08:56:10 INFO - PROCESS | 8984 | RSS: Main: 218443776 08:56:10 INFO - PROCESS | 8984 | 08:59:12 INFO - PROCESS | 8984 | Cycle 1(1): loaded http://localhost:45662/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45662/tests/dromaeo/cssquery-prototype.html) 08:59:12 INFO - PROCESS | 8984 | RSS: Main: 238358528 08:59:12 INFO - PROCESS | 8984 | 09:02:16 INFO - PROCESS | 8984 | Cycle 1(1): loaded http://localhost:45662/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45662/tests/dromaeo/cssquery-yui.html) 09:02:16 INFO - PROCESS | 8984 | RSS: Main: 218804224 09:02:16 INFO - PROCESS | 8984 | 09:05:19 INFO - PROCESS | 8984 | Cycle 1(1): loaded http://localhost:45662/tests/dromaeo/cssquery-yui.html (next: http://localhost:45662/tests/dromaeo/cssquery-dojo.html) 09:05:20 INFO - PROCESS | 8984 | RSS: Main: 315080704 09:05:20 INFO - PROCESS | 8984 | 09:05:20 INFO - PROCESS | 8984 | __start_tp_report 09:05:20 INFO - PROCESS | 8984 | _x_x_mozilla_page_load 09:05:20 INFO - PROCESS | 8984 | _x_x_mozilla_page_load_details 09:05:20 INFO - PROCESS | 8984 | |i|pagename|runs| 09:05:20 INFO - PROCESS | 8984 | |0;dojo.html;2577.6004719268512;2584.0568192609703;2619.8952041918324;2634.328246297194;2638.208537438768;4635.304704294349;4700.224462963607;4709.64677649176;4728.101660684468;4729.716217026981;4685.812567497296;4688.9765551172195;4702.670813043088;4740.525947405258;4773.379460670117;4300.827966881321;4319.460067491564;4370.409994650713;4378.956210437903;4382.057857560624;4361.193179261847;4431.534688857671;4452.087322098978;4463.799129039185;4512.819487220508;4259.87220383389;4384.4081049058605;4387.802548885308;4425.800838962255;4505.414296141497;4294.892627684301;4306.332518459643;4341;4363.629091527224;4385.079133381993;4336.067745434715;4338.501072376685;4346.47842258931;4399.054203346296;4404.4494438195225;4713.457952335457;4717.481077081518;4727.66906316558;4730.858074257778;4740.525947405266;4883.267509873512;4931.901361972777;4935.728534930578;4993.101241776479;5061.569766569846;4998.300237966688;5014.172661510846;5014.222795466709;5017.247412888059;5021.07110184617;4672.135654903854;4685.554872287127;4687.906241875177;4691.976540117345;4701.95298047022;5057.988402319551;5088.796448142107;5094.949050509522;5103.362079740033;5116.053530096944;4871.2206047032305;4900.436449808247;4907.190313598217;4911.115999120121;4913.484084171182;5001.299818025479;5015.122353588107;5019.498050194951;5021.246812978083;5022.271770593244;4975.527324904128;4976.676516026447;4979.551840334388;4980.850574482699;4984.22744474607;4998;5000.924986125211;5010.674306170087;5018.924716129261;5067.493250674903;4169.583041695806;4206.47419072616;4240.660747140221;4261.2542805009;4295.463067116611;3750.718696097804;3764.9435258471144;3768.1898391845884;3768.773873567595;3781.2248489059675;4379.4087798147475;4385.6052955233545;4388.232059389594;4388.495323037828;4389.802458889294;5072.264521644341;5105.2086926526445;5114.33513643224;5133.23001549763;5170.1727723564045;4379.5182529921685;4381.561843815657;4383.123375324948;4392.582704643054;4443.977885086383;4419.602235798793;4552.772361381918;4561.876942998826;4568.931466028012;4618.722876627413;4691.272852707836;4747.596454301354;4773;4807.254875494304;4814.253790662453;5121.462246464068;5125.897482050413;5138.8972220556125;5148.897022059613;5200.63595548308;4796.872734907363;4801.783919723551;4805.8946442317765;4809.831655892027;4870.975645121752;4845.3216549683775;4910.484399138182;4912.140375434356;4953.975230123826;5046.9747651261505;5072.923906141485;5123.052235336475;5152.175651895679;5156.355455568054;5158.200478925773;4938.728369939688;4939.357883475125;4956.8760780980765;4960.851174464772;4975.477574854588;4943.579795717261;4943.5797957174045;4955.677880937727;4964.354633897715;5006.799728010838;4795.592374648194;4806.519348065165;4835.226363781778;4852.369192005158;4858.78135483897;4975.776090075883;4975.975120124376;4986.15235409974;4986.850394488171;4995.350604421402;4865.026994601165;4868.610511159028;4878.487758785418;4883.389576302962;4898.069366820293 09:05:20 INFO - PROCESS | 8984 | |1;ext.html;553.5986409852857;562.9662220266785;565.0478942981075;583.9737211825468;584.3922320786382;37916;39419.60580394195;39434.01414964624;39450.21099578014;43987;40861.79569102158;41271.17457650845;41298.587014129924;41328.38007429891;41417.792911035474;7639.65621547029;7791.337736292422;7793.415493837985;7794.76615701527;7803.414743894202;7538.547687138762;7680.65437055331;7680.923190768104;7682.231776822329;7687.385009199279;7619.847603047936;7660.310572048515;7673.961630191841;7694.076710794712;7737.226277372274;7579.317861392474;7621;7627.084749830056;7632.847343053163;7644.273793989562;7651.387888968869;7700.152983171846;7721.03487064117;7763.767086987399;7765.922340776577;38856;39259.803700981596;39282.41076383857;39319.803400983095;39332.80333598342;2925.2394377462015;2965.303153758865;2969.6733359330456;3115.5482455043893;3465.8440370183403;28328.575071373947;28539.28651783722;29021.709782902322;30107.849460752775;30267.545986810215;3094.7430063076004;3153.495440729472;3250.4066739296027;3259.2194398403362;3275.197576593726;257738;258047;258962;259592;259865;51402.48597514052;51538;51817.48182518202;51942;52060;32542.674573254437;55336.72331638396;55407;55510.72244638751;55556.72221638866;13620.795688064687;14291.285435728172;14295.213763242913;14319.856801431852;14432;11283.605073822377;11408.885911140782;11412.486438110305;11413.201075924606;11414.94292528532;18078.5480362992;18115.184816683282;18138.18378172959;18149.455516334532;18312.26750929948;6711.449619178425;6777.220619628806;6878.975799157449;6929.203141638675;6954.200266969363;766.7853001159684;881.532787622561;894.8478758611052;905.7418635688929;932.6502561539422;27485;28924.566131508043;30827.537586936214;32640.403014644875;32650;766.8918412893315;924.8890133183926;944.17856464876;948.9478078705738;954.9856752148723;13955.930220349037;14621.926890365692;15458.6135346615;16177.433789817534;16325.146152157788;370958;371170;371481;373986;375811;50803.49196507988;51024.48975510272;51103.23345149826;51111.23333150006;51226.48773512217;977.1791694976254;1087.842262871895;1146.90251328638;1160.14729174057;1164.6622479480855;24106.51786964286;27515.17454476369;29432.11703648894;29509;29941.556720977365;48303.516964829905;49039;49057.2641410372;49064.50935490742;49069.263961041324;336719;340076;340595;340912;341364;24665.383365416008;25228.117015904354;25324.11365602195;27039.45921081528;38388.61611383851;41245;41290.38064428976;42273.674947878164;42430.36354454624;42761.35857962071;35834;35924.4611330825;35994.8200258997;36312.4553131698;36826;35502.8224858874;35791.105222369646;36389;36617;37026;34974.30051398907;35898;36211.637883620824;36650.633493664725;36690;31207.687923121386;31907.202319942186;32935.835320824204;34134;34469;20242.59514809666;20304.89847550753;20312.492187694836;20435.693464597745;20474 09:05:20 INFO - PROCESS | 8984 | |2;jquery.html;336.46502061721856;348.8674303764571;358.97128229741617;359.6062311768613;374.1768110157652;12315.445804938778;13341.666458338534;15814.367425302988;16300.918495407506;16719;15453;15685;16050.147964488526;16439.91780041101;16483.258253378597;3932.941005884914;4099.938500922489;4101.91796164078;4104.466419365478;4104.815283312243;4305.806238719265;5129.897402051956;5142.51146141116;5147.408048074463;5149.536541711245;5109.156989096795;5112.769925353368;5118.3857937047605;5118.564921981636;5120.513551212629;4907.730074845864;5027.542012816279;5030.396352437694;5053.242013697938;5056.898862022739;4513.52607976161;4517;4518.367428560005;4521.932171017437;4526.388937493429;19956.201751929904;20624.58750824975;20662;20878.26926057596;21255.468613284636;1724.7585338052684;1754.2456743600246;1765.9646807063916;1799.9010054447;1816.5821860971919;8478.703245386443;8680.913190868074;11984.64046078619;12100.515979360815;12531.624051278477;1538.7461068923615;1586.373382513912;1626.211287525549;1632.918354082303;1691.7039518084287;69405;70548.29451705469;71658.64170679165;72814.27185728181;73798.63100684516;9311.208547273422;9462.688059179232;9609.47147906858;9710.805783884283;9722.222222222204;13273.933630331787;13295.401706923212;13308;13310.933445332712;13334.533291334757;6823.112995310578;6885.896711549331;7011.544249623758;7031.261717519689;7075;6253.1245625612455;6317.210348706411;6388.840278993062;6495.350464953562;6529.347065293433;3805.6955443565002;3900.863469778544;3941.6058394160355;4216.64158546527;4243.405923170759;1693.1280390598852;1693.8644908407298;1728.9394871179447;1742.2072956804623;1815.7457955886186;697.2957313113792;723.6128671161009;781.7928249014016;783.295034468971;831.9209675080857;15239.619009524851;15319.617009574627;15440.691186176213;15551.377944882079;16178.110203938897;737.5058710663868;762.9694812207449;766.6243540665146;772.4669977715358;773.1225059557443;8469.491830490191;8751.693690720795;9080.364374493854;9619;10578.153747700166;394555;395338;398738;403661;404416;79699.60150199328;83454;84575.99999999876;85176.57411713025;85434;907.5643691028212;920.7191806498948;956.8038552096942;958.5111593087576;959.8176346494143;15434.691306174038;15446.227688615749;16027.599310017344;16256.349746010028;16306.836931630532;36723;37211.25577488489;37384.252314953;37631.81184094062;37779.244415110996;47362.52637473581;48283.75858120687;49116;53400.73299633477;54033;7145.749898753519;7280.635968201463;7297.306755858185;7454.552726836408;7786;7929.643166057426;10265.58937642486;10625.096866766411;10789.838152427878;10848.077913377452;8954.820903582022;9365.250779937453;9410.576524056298;9429.198518126037;9932.652357167464;9412.247020238228;9545.379550329206;9580.515827897758;9691.757706057406;9851.359661621971;9528.714138575853;9601.759956001157;9666.854997174907;9826.459544725109;10050.597976080875;7407.8148046299275;7438.367738742268;7584.5070070445245;7630.885536716843;7661.620908236571;8665.2634526066;9233;9485.952570237381;9800.607975681178;9830.950845245728 09:05:20 INFO - PROCESS | 8984 | |3;mootools.html;1363.924984125873;1414.370605080739;1475.2328789029705;1694.0851939952427;1703.5741064733809;6952.2352541220425;7216.494845360827;7559.244075592438;8229.794255143624;8229.917700822998;7464.328210461057;7734.419918506121;7741.612919354038;7976.401769867269;7990.840183196347;2070.81362677359;2092.2258764257244;2092.393205970267;2111.4826867417505;2114.8942552872372;1788.2399980008445;1856.452346557762;2035.6335859545277;2046.2326627514683;2048.498117961094;1841.1254654039358;1858.637565674694;2020.666590012646;2082.541840795023;2088.634488964433;2006.9297574584893;2007.7389939307943;2009.65835807913;2010.1055030511502;2014.5064459207588;2057.660486019805;2078.3972647932083;2118.93643190703;2120.8409369297365;2127.702121702963;7977.641006154737;8060.113387527367;8064.072631647318;8064.274215320591;8066.314363279128;4510.751908645023;4578.908421831545;4630.282306242538;4634.791434385461;4672.6261899047995;2945.5287154055463;3081.784275100744;3153.8423078845967;3157.289609837791;3165.8733650653944;925.4447331601053;962.0716009051229;972.9805403891953;975.3757595139117;1009.6415772400766;10906.182036347305;10931.234813562975;10932.56269749209;10939.12487001038;10949.890501094967;4106.117184805222;4346.217680817484;4394.231009573312;4460.553944605578;4462.888427789267;9279.211267042241;9279.72160835176;9288.953555232181;9294.163525282622;9294.72115836526;4669.766511674403;4681.742504162304;4687.086018226481;4689.226277664147;4689.296605509201;4114.958850411517;4222.59885310895;4228.069824638575;4240.766757828349;4245.3844192591905;3476.800503826176;3482.895513134559;3554.129238336572;3576.5529308836394;3694.7413681042067;1167.235460773195;1199.5681554640323;1204.3496511883484;1215;1222.0712258683463;625.3340192694766;629.0689779126826;659.2583343738295;746.0264355016647;822.1860358245414;5095.490450954875;5121.948780512222;5140.820071297561;5283.07546179417;5584.46947539983;818.5334359415076;843.3042739739617;847.3856454070873;892.2237653241722;894.1684233662626;3247.9675203247666;3311.1887587540723;3373.2916087621384;3417.4019546579248;3435.175557866144;9437.433753974783;9687.9031209687;9837.655682051094;9989.35069220513;10086.596536138471;9995.550200241007;9999.650012249536;10002.199824014062;10002.199824014062;10006;7283.562986220843;7347.375473084848;7392.852142957111;7477.887831682529;7485.775426737097;5007.574356179765;5064.620153488429;5125.7693403796175;5133.614978876674;5159.819406320761;8371.874421883555;8721;8921.375503714937;8967.551622418723;8981;8594.699185528476;8755.343349248958;8902.643894244158;8920.509371984603;8943.865842012245;6630.602163870183;6774.86450270982;6778.796636100925;6782.898256526255;6786.76246331376;7605.391568674603;7612.581308028111;7626.665333566714;7671.117821450604;7685.807854803675;6654.168228971379;6686.498512611476;6739.73041078371;6819.965900170468;6839.316068393121;6345.3654634538025;6459.9031014533875;6524.608523488606;6551.4103730664465;6563.671816409256;6246.125542424155;6358.1734374531015;6359.20509936258;6362.300146983735;6400.935990640034;4247.723897946624;4282.528921818535;4283.721558098714;4311.9784401077795;4522.683412161117;4250.744955302692;4313.84901528445;4350.804213810323;4408.7575183365225;4520.937579668709 09:05:20 INFO - PROCESS | 8984 | |4;prototype.html;282.3435512433591;290.6134840661919;293.7121620811605;297.8153544802223;298.6431214698436;4801.4718380978065;4826.71039737616;4847.321375007497;4888.902221955559;4929.975350123249;4518.412606361168;4606.3781389512405;4700;4737.810487580501;4799.544043315879;3742.5696044954907;3747.2318174774105;3748.257060466882;3754.5119134512543;3762;3758.191988722424;3764.3600587900123;3768.152165762695;3771.3023090728166;3772.962435330279;3566.589842168145;3614.457831325296;3667.688246499051;3672.375696131651;3724.16206353571;3686.8525258989876;3699.2231631357313;3699.408094704834;3710.777353358807;3729.4032954727386;3273.5580696605894;3276.4757638777683;3278.983605081983;3282.2778988622463;3282.885099021523;4491.2603311979665;4662.930056049162;4681.9297710534365;4682.133805246006;4704.223803072489;4170.164288283966;4189.360702757243;4198.979005104955;4201.823489422966;4211.968067823373;4986.152354099811;4998.775055122528;5012.573931215815;5014.147594908838;5015.673981191211;3563.750537462379;3578.8926332210076;3583.122135076923;3588.766730162531;3597.6402359764074;5090.556532864209;5198.4801519847715;5200.6879587224885;5222.843314700565;5233.9738301308635;3638.21778317663;3640.3993341098953;3642.7814331140216;3651.3610118229203;3655.6344365563764;3666.7433279670167;3670.6696397324367;3675.9264814703556;3683.6684698377276;3687.3178461984617;4023.3562629979647;4162;4185.665146788249;4193.601607847249;4201.6008479194425;4987.750612469362;4993.425756038102;5003.3495645565845;5007.94674183583;5016.924746128811;1227.4537830665267;1285.2609749394135;1304.6953046953047;1306.8956731561816;1306.9738605228033;790.774299835253;807.4509333653054;808.9595520223966;809.6720828064643;812.1999830167281;4395.164918665443;4468.151051300308;4483.887902802391;4491.505934347219;4498.8425405110665;5191.195364718475;5202.2196670499725;5207.817726379559;5208.609354298443;5208.8958220835375;4258.318669012943;4499.482559505634;4504.819807207675;4506.436695413074;4527.4340707411575;2719.1706529508688;2760.3651160233258;2763.226296636945;2764.378014946621;2766.1286694691107;4890.144224760653;4895.877603059881;4897;4898.289747986522;4920.138975679241;5079.97460012705;5287.339082614673;5327.387350454747;5339.439358867263;5340.599455040888;4891.239153904591;4894.804207831647;4900.240462728283;4914.125236736478;4917.483664215206;5168.811173430057;5175.120229560908;5191.377034755854;5210.713410762444;5214.32213812202;4963.801447942186;5097.7706003229205;5120.487951204998;5124.743762811919;5131.79472821083;4832.8791780205775;4846.781894814671;4874.268859671078;4880.853574392774;4898.975505122452;3254.511823226535;3265.526498657729;3273.3780581689402;3329.583802024747;3345.481450375196;4538.6369090473345;4643;4868.344762780672;5193.37679478465;5201.42784293735;5059.519345662156;5063.215201643751;5064.620153488577;5066.949330506795;5080.898382032413;5064.898702026013;5070.239464080418;5075.111855425212;5081.644284900021;5119.87200319995;4722.252766476426;4762.9285560715925;4943.382077240345;4983.327250821238;5000.1749711297225;4979.584901322928;4979.726115063561;4992.475790042138;5001.024800163933;5005.674631148963;4836.5248599177585;4949.678270912379;4989.201727723546;4989.575886049726;4990.925136123034 09:05:20 INFO - PROCESS | 8984 | |5;yui.html;641.6438876423583;644.3653001793233;663.4625952978085;728.4645785347772;753.227941360106;12653.240805551663;13726.656833579153;13732.65668358289;13743.518976835812;13772.311384430788;13246.536371227008;13256.204627722344;13271.20372777634;13285.667858303546;13332.866671333284;620.3455354600894;637.1271358239219;770.8458308338327;773.6711897443578;796.7410591557738;791.8495485857669;792.9524228546277;795.0657976877175;795.6021989005498;796.0526972902228;841.8989721233461;843.2115971566574;843.2874221283006;843.3379796859466;843.5782108945527;653.1802587752388;659;837.351052933981;837.5351679817699;837.811492414205;492.18297625940767;492.3058487532562;492.4066499867651;601.4947444146937;608.4736702752132;12986.675333116653;13044.41300141496;13059.085863989525;13103.86896131036;13137.408816603276;12603.873961260362;12983.545575904798;13356.732865342736;13479.595612131652;13550.728985420335;10761.892381076246;11101.888981110167;11477.540898364055;11488.712782180428;11588.768224635545;3043.421749867518;3116.298832762633;3151.133438304462;3164.6677098904743;3211.775175737699;58680.41319586792;59350;59907.400925990616;60478.39521604771;60485.39514604842;10448.738781530523;10701.732456688645;10839.83740243897;10860.13118950482;11191.384473853854;20913.686294705592;21173.258935937476;21209.257675981265;21211.575768484854;21299.46751331229;7137.614037540618;7178.8205294867;7220.422366210691;7247.057882475245;7510.774676759706;3303.752218583616;3310.4537751270773;3357.8824741133944;3388.9322213555592;3423.3495635829113;2896.6675329348313;2951.4834903891733;2973.8067025643263;2984.418038482475;3004.1888690053565;509.6967304453844;523.2099529710089;528.9975496434236;534.7700488789858;540.9377921538995;551.3549147497438;570.7574280930588;620.9844753881099;621.5959626242978;630.2814791138014;7927.167647397056;8070.878936815952;8172.305354044973;8257.298129658926;8372.41393102477;511.63929429751937;533.6184627991005;604.3956043956044;606.1544145916422;623.1991890420787;3671.908202294964;3813.923721525554;3873.8450461981206;3888.0862997195636;3908.270018696059;99330;100147;101340.49329753304;104532.47733761283;104818.47590761997;49160.75419622879;77306.65586769248;79223.60388198022;80528.59735701284;80865.59567202126;75393.62303188558;77877.6106119477;79114.20885791183;81012.59493702494;83304.58347708343;7251.166115896739;7304.525205861814;7358.816029599303;7545;7649.196834332315;29996;34962.47556286607;41230.76307710774;41462.1707565841;42514.93115425993;55633.72183139058;56314.718426407606;56912;57686.423135768106;58725.961177957564;11400;11499;11556.191066625255;11658.18392712502;11714.121440891797;11929;12265.754684906431;12266.202696824677;12319.63041108768;13384.866151338361;11916.712959289096;12041.217320874115;12114.15200935926;12210.32443663103;12662.240265584094;10627.574897004033;10751.677449676523;10808.621698240524;11167.944160279147;11753.647390578297;12045.51817927273;12085.697857553632;12595.87404125947;12724.809127862904;12732.936335318635;9623.951880240555;9806.901930980885;10423.166146708094;10566.788664226826;10594.629187978384;10169.644062457779;10208.489575521045;10257.230707696803;10369.481525923824;10394.740131496774 09:05:20 INFO - PROCESS | 8984 | __end_tp_report 09:05:20 INFO - PROCESS | 8984 | __start_cc_report 09:05:20 INFO - PROCESS | 8984 | _x_x_mozilla_cycle_collect,2010 09:05:20 INFO - PROCESS | 8984 | __end_cc_report 09:05:20 INFO - PROCESS | 8984 | __startTimestamp1477065920022__endTimestamp 09:05:20 INFO - PROCESS | 8984 | 09:05:20 INFO - PROCESS | 8984 | ------- Summary: start ------- 09:05:20 INFO - PROCESS | 8984 | Number of tests: 6 09:05:20 INFO - PROCESS | 8984 | 09:05:20 INFO - PROCESS | 8984 | [#0] dojo.html Cycles:165 Average:4671.80 Median:4806.52 stddev:485.92 (10.1%) stddev-sans-first:458.80 09:05:20 INFO - PROCESS | 8984 | Values: 2577.6 2584.1 2619.9 2634.3 2638.2 4635.3 4700.2 4709.6 4728.1 4729.7 4685.8 4689.0 4702.7 4740.5 4773.4 4300.8 4319.5 4370.4 4379.0 4382.1 4361.2 4431.5 4452.1 4463.8 4512.8 4259.9 4384.4 4387.8 4425.8 4505.4 4294.9 4306.3 4341.0 4363.6 4385.1 4336.1 4338.5 4346.5 4399.1 4404.4 4713.5 4717.5 4727.7 4730.9 4740.5 4883.3 4931.9 4935.7 4993.1 5061.6 4998.3 5014.2 5014.2 5017.2 5021.1 4672.1 4685.6 4687.9 4692.0 4702.0 5058.0 5088.8 5094.9 5103.4 5116.1 4871.2 4900.4 4907.2 4911.1 4913.5 5001.3 5015.1 5019.5 5021.2 5022.3 4975.5 4976.7 4979.6 4980.9 4984.2 4998.0 5000.9 5010.7 5018.9 5067.5 4169.6 4206.5 4240.7 4261.3 4295.5 3750.7 3764.9 3768.2 3768.8 3781.2 4379.4 4385.6 4388.2 4388.5 4389.8 5072.3 5105.2 5114.3 5133.2 5170.2 4379.5 4381.6 4383.1 4392.6 4444.0 4419.6 4552.8 4561.9 4568.9 4618.7 4691.3 4747.6 4773.0 4807.3 4814.3 5121.5 5125.9 5138.9 5148.9 5200.6 4796.9 4801.8 4805.9 4809.8 4871.0 4845.3 4910.5 4912.1 4954.0 5047.0 5072.9 5123.1 5152.2 5156.4 5158.2 4938.7 4939.4 4956.9 4960.9 4975.5 4943.6 4943.6 4955.7 4964.4 5006.8 4795.6 4806.5 4835.2 4852.4 4858.8 4975.8 4976.0 4986.2 4986.9 4995.4 4865.0 4868.6 4878.5 4883.4 4898.1 09:05:20 INFO - PROCESS | 8984 | 09:05:20 INFO - PROCESS | 8984 | [#1] ext.html Cycles:180 Average:48011.56 Median:371325.50 stddev:86120.36 (23.2%) stddev-sans-first:86288.24 09:05:20 INFO - PROCESS | 8984 | Values: 553.6 563.0 565.0 584.0 584.4 37916.0 39419.6 39434.0 39450.2 43987.0 40861.8 41271.2 41298.6 41328.4 41417.8 7639.7 7791.3 7793.4 7794.8 7803.4 7538.5 7680.7 7680.9 7682.2 7687.4 7619.8 7660.3 7674.0 7694.1 7737.2 7579.3 7621.0 7627.1 7632.8 7644.3 7651.4 7700.2 7721.0 7763.8 7765.9 38856.0 39259.8 39282.4 39319.8 39332.8 2925.2 2965.3 2969.7 3115.5 3465.8 28328.6 28539.3 29021.7 30107.8 30267.5 3094.7 3153.5 3250.4 3259.2 3275.2 257738.0 258047.0 258962.0 259592.0 259865.0 51402.5 51538.0 51817.5 51942.0 52060.0 32542.7 55336.7 55407.0 55510.7 55556.7 13620.8 14291.3 14295.2 14319.9 14432.0 11283.6 11408.9 11412.5 11413.2 11414.9 18078.5 18115.2 18138.2 18149.5 18312.3 6711.4 6777.2 6879.0 6929.2 6954.2 766.8 881.5 894.8 905.7 932.7 27485.0 28924.6 30827.5 32640.4 32650.0 766.9 924.9 944.2 948.9 955.0 13955.9 14621.9 15458.6 16177.4 16325.1 370958.0 371170.0 371481.0 373986.0 375811.0 50803.5 51024.5 51103.2 51111.2 51226.5 977.2 1087.8 1146.9 1160.1 1164.7 24106.5 27515.2 29432.1 29509.0 29941.6 48303.5 49039.0 49057.3 49064.5 49069.3 336719.0 340076.0 340595.0 340912.0 341364.0 24665.4 25228.1 25324.1 27039.5 38388.6 41245.0 41290.4 42273.7 42430.4 42761.4 35834.0 35924.5 35994.8 36312.5 36826.0 35502.8 35791.1 36389.0 36617.0 37026.0 34974.3 35898.0 36211.6 36650.6 36690.0 31207.7 31907.2 32935.8 34134.0 34469.0 20242.6 20304.9 20312.5 20435.7 20474.0 09:05:20 INFO - PROCESS | 8984 | 09:05:20 INFO - PROCESS | 8984 | [#2] jquery.html Cycles:180 Average:24461.76 Median:5041.82 stddev:66164.51 (1312.3%) stddev-sans-first:66325.32 09:05:20 INFO - PROCESS | 8984 | Values: 336.5 348.9 359.0 359.6 374.2 12315.4 13341.7 15814.4 16300.9 16719.0 15453.0 15685.0 16050.1 16439.9 16483.3 3932.9 4099.9 4101.9 4104.5 4104.8 4305.8 5129.9 5142.5 5147.4 5149.5 5109.2 5112.8 5118.4 5118.6 5120.5 4907.7 5027.5 5030.4 5053.2 5056.9 4513.5 4517.0 4518.4 4521.9 4526.4 19956.2 20624.6 20662.0 20878.3 21255.5 1724.8 1754.2 1766.0 1799.9 1816.6 8478.7 8680.9 11984.6 12100.5 12531.6 1538.7 1586.4 1626.2 1632.9 1691.7 69405.0 70548.3 71658.6 72814.3 73798.6 9311.2 9462.7 9609.5 9710.8 9722.2 13273.9 13295.4 13308.0 13310.9 13334.5 6823.1 6885.9 7011.5 7031.3 7075.0 6253.1 6317.2 6388.8 6495.4 6529.3 3805.7 3900.9 3941.6 4216.6 4243.4 1693.1 1693.9 1728.9 1742.2 1815.7 697.3 723.6 781.8 783.3 831.9 15239.6 15319.6 15440.7 15551.4 16178.1 737.5 763.0 766.6 772.5 773.1 8469.5 8751.7 9080.4 9619.0 10578.2 394555.0 395338.0 398738.0 403661.0 404416.0 79699.6 83454.0 84576.0 85176.6 85434.0 907.6 920.7 956.8 958.5 959.8 15434.7 15446.2 16027.6 16256.3 16306.8 36723.0 37211.3 37384.3 37631.8 37779.2 47362.5 48283.8 49116.0 53400.7 54033.0 7145.7 7280.6 7297.3 7454.6 7786.0 7929.6 10265.6 10625.1 10789.8 10848.1 8954.8 9365.3 9410.6 9429.2 9932.7 9412.2 9545.4 9580.5 9691.8 9851.4 9528.7 9601.8 9666.9 9826.5 10050.6 7407.8 7438.4 7584.5 7630.9 7661.6 8665.3 9233.0 9486.0 9800.6 9831.0 09:05:20 INFO - PROCESS | 8984 | 09:05:20 INFO - PROCESS | 8984 | [#3] mootools.html Cycles:180 Average:5132.98 Median:5036.10 stddev:2945.84 (58.5%) stddev-sans-first:2940.49 09:05:20 INFO - PROCESS | 8984 | Values: 1363.9 1414.4 1475.2 1694.1 1703.6 6952.2 7216.5 7559.2 8229.8 8229.9 7464.3 7734.4 7741.6 7976.4 7990.8 2070.8 2092.2 2092.4 2111.5 2114.9 1788.2 1856.5 2035.6 2046.2 2048.5 1841.1 1858.6 2020.7 2082.5 2088.6 2006.9 2007.7 2009.7 2010.1 2014.5 2057.7 2078.4 2118.9 2120.8 2127.7 7977.6 8060.1 8064.1 8064.3 8066.3 4510.8 4578.9 4630.3 4634.8 4672.6 2945.5 3081.8 3153.8 3157.3 3165.9 925.4 962.1 973.0 975.4 1009.6 10906.2 10931.2 10932.6 10939.1 10949.9 4106.1 4346.2 4394.2 4460.6 4462.9 9279.2 9279.7 9289.0 9294.2 9294.7 4669.8 4681.7 4687.1 4689.2 4689.3 4115.0 4222.6 4228.1 4240.8 4245.4 3476.8 3482.9 3554.1 3576.6 3694.7 1167.2 1199.6 1204.3 1215.0 1222.1 625.3 629.1 659.3 746.0 822.2 5095.5 5121.9 5140.8 5283.1 5584.5 818.5 843.3 847.4 892.2 894.2 3248.0 3311.2 3373.3 3417.4 3435.2 9437.4 9687.9 9837.7 9989.4 10086.6 9995.6 9999.7 10002.2 10002.2 10006.0 7283.6 7347.4 7392.9 7477.9 7485.8 5007.6 5064.6 5125.8 5133.6 5159.8 8371.9 8721.0 8921.4 8967.6 8981.0 8594.7 8755.3 8902.6 8920.5 8943.9 6630.6 6774.9 6778.8 6782.9 6786.8 7605.4 7612.6 7626.7 7671.1 7685.8 6654.2 6686.5 6739.7 6820.0 6839.3 6345.4 6459.9 6524.6 6551.4 6563.7 6246.1 6358.2 6359.2 6362.3 6400.9 4247.7 4282.5 4283.7 4312.0 4522.7 4250.7 4313.8 4350.8 4408.8 4520.9 09:05:20 INFO - PROCESS | 8984 | 09:05:20 INFO - PROCESS | 8984 | [#4] prototype.html Cycles:180 Average:4150.80 Median:4730.03 stddev:1220.10 (25.8%) stddev-sans-first:1188.47 09:05:20 INFO - PROCESS | 8984 | Values: 282.3 290.6 293.7 297.8 298.6 4801.5 4826.7 4847.3 4888.9 4930.0 4518.4 4606.4 4700.0 4737.8 4799.5 3742.6 3747.2 3748.3 3754.5 3762.0 3758.2 3764.4 3768.2 3771.3 3773.0 3566.6 3614.5 3667.7 3672.4 3724.2 3686.9 3699.2 3699.4 3710.8 3729.4 3273.6 3276.5 3279.0 3282.3 3282.9 4491.3 4662.9 4681.9 4682.1 4704.2 4170.2 4189.4 4199.0 4201.8 4212.0 4986.2 4998.8 5012.6 5014.1 5015.7 3563.8 3578.9 3583.1 3588.8 3597.6 5090.6 5198.5 5200.7 5222.8 5234.0 3638.2 3640.4 3642.8 3651.4 3655.6 3666.7 3670.7 3675.9 3683.7 3687.3 4023.4 4162.0 4185.7 4193.6 4201.6 4987.8 4993.4 5003.3 5007.9 5016.9 1227.5 1285.3 1304.7 1306.9 1307.0 790.8 807.5 809.0 809.7 812.2 4395.2 4468.2 4483.9 4491.5 4498.8 5191.2 5202.2 5207.8 5208.6 5208.9 4258.3 4499.5 4504.8 4506.4 4527.4 2719.2 2760.4 2763.2 2764.4 2766.1 4890.1 4895.9 4897.0 4898.3 4920.1 5080.0 5287.3 5327.4 5339.4 5340.6 4891.2 4894.8 4900.2 4914.1 4917.5 5168.8 5175.1 5191.4 5210.7 5214.3 4963.8 5097.8 5120.5 5124.7 5131.8 4832.9 4846.8 4874.3 4880.9 4899.0 3254.5 3265.5 3273.4 3329.6 3345.5 4538.6 4643.0 4868.3 5193.4 5201.4 5059.5 5063.2 5064.6 5066.9 5080.9 5064.9 5070.2 5075.1 5081.6 5119.9 4722.3 4762.9 4943.4 4983.3 5000.2 4979.6 4979.7 4992.5 5001.0 5005.7 4836.5 4949.7 4989.2 4989.6 4990.9 09:05:20 INFO - PROCESS | 8984 | 09:05:20 INFO - PROCESS | 8984 | [#5] yui.html Cycles:180 Average:17452.34 Median:3843.88 stddev:24865.81 (646.9%) stddev-sans-first:24903.53 09:05:20 INFO - PROCESS | 8984 | Values: 641.6 644.4 663.5 728.5 753.2 12653.2 13726.7 13732.7 13743.5 13772.3 13246.5 13256.2 13271.2 13285.7 13332.9 620.3 637.1 770.8 773.7 796.7 791.8 793.0 795.1 795.6 796.1 841.9 843.2 843.3 843.3 843.6 653.2 659.0 837.4 837.5 837.8 492.2 492.3 492.4 601.5 608.5 12986.7 13044.4 13059.1 13103.9 13137.4 12603.9 12983.5 13356.7 13479.6 13550.7 10761.9 11101.9 11477.5 11488.7 11588.8 3043.4 3116.3 3151.1 3164.7 3211.8 58680.4 59350.0 59907.4 60478.4 60485.4 10448.7 10701.7 10839.8 10860.1 11191.4 20913.7 21173.3 21209.3 21211.6 21299.5 7137.6 7178.8 7220.4 7247.1 7510.8 3303.8 3310.5 3357.9 3388.9 3423.3 2896.7 2951.5 2973.8 2984.4 3004.2 509.7 523.2 529.0 534.8 540.9 551.4 570.8 621.0 621.6 630.3 7927.2 8070.9 8172.3 8257.3 8372.4 511.6 533.6 604.4 606.2 623.2 3671.9 3813.9 3873.8 3888.1 3908.3 99330.0 100147.0 101340.5 104532.5 104818.5 49160.8 77306.7 79223.6 80528.6 80865.6 75393.6 77877.6 79114.2 81012.6 83304.6 7251.2 7304.5 7358.8 7545.0 7649.2 29996.0 34962.5 41230.8 41462.2 42514.9 55633.7 56314.7 56912.0 57686.4 58726.0 11400.0 11499.0 11556.2 11658.2 11714.1 11929.0 12265.8 12266.2 12319.6 13384.9 11916.7 12041.2 12114.2 12210.3 12662.2 10627.6 10751.7 10808.6 11167.9 11753.6 12045.5 12085.7 12595.9 12724.8 12732.9 9624.0 9806.9 10423.2 10566.8 10594.6 10169.6 10208.5 10257.2 10369.5 10394.7 09:05:20 INFO - PROCESS | 8984 | -------- Summary: end -------- 09:05:20 INFO - PROCESS | 8984 | 09:05:21 INFO - TEST-INFO | 8984: exit 0 09:05:21 INFO - TEST-OK | dromaeo_css | took 1122617ms 09:05:21 INFO - TEST-START | kraken 09:05:21 INFO - operating with platform_type : linux_ 09:05:21 INFO - Initialising browser for kraken test... 09:05:21 INFO - TEST-INFO | started process 9290 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpj2u2Qi/profile http://localhost:45662/getInfo.html) 09:05:25 INFO - PROCESS | 9290 | __metrics Screen width/height:1600/1200 09:05:25 INFO - PROCESS | 9290 | colorDepth:24 09:05:25 INFO - PROCESS | 9290 | Browser inner width/height: 1024/697 09:05:25 INFO - PROCESS | 9290 | __metrics 09:05:25 INFO - PROCESS | 9290 | 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" 09:05:25 INFO - PROCESS | 9290 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:05:26 INFO - PROCESS | 9290 | console.error: PushService: 09:05:26 INFO - PROCESS | 9290 | stateChangeProcessEnqueue: Error transitioning state 09:05:26 INFO - PROCESS | 9290 | UnknownError 09:05:26 INFO - TEST-INFO | 9290: exit 0 09:05:26 INFO - Browser initialized. 09:05:26 INFO - Running cycle 1/1 for kraken test... 09:05:27 INFO - TEST-INFO | started process 9371 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpj2u2Qi/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:05:39 INFO - PROCESS | 9371 | RSS: Main: 173006848 09:05:39 INFO - PROCESS | 9371 | 09:05:42 INFO - PROCESS | 9371 | Cycle 1(1): loaded http://localhost:45662/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45662/tests/kraken/driver.html?testName=audio-beat-detection) 09:05:42 INFO - PROCESS | 9371 | RSS: Main: 234442752 09:05:42 INFO - PROCESS | 9371 | 09:05:45 INFO - PROCESS | 9371 | Cycle 1(1): loaded http://localhost:45662/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45662/tests/kraken/driver.html?testName=audio-dft) 09:05:46 INFO - PROCESS | 9371 | RSS: Main: 217391104 09:05:46 INFO - PROCESS | 9371 | 09:05:49 INFO - PROCESS | 9371 | Cycle 1(1): loaded http://localhost:45662/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45662/tests/kraken/driver.html?testName=audio-fft) 09:05:50 INFO - PROCESS | 9371 | RSS: Main: 299110400 09:05:50 INFO - PROCESS | 9371 | 09:05:52 INFO - PROCESS | 9371 | Cycle 1(1): loaded http://localhost:45662/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45662/tests/kraken/driver.html?testName=audio-oscillator) 09:05:52 INFO - PROCESS | 9371 | RSS: Main: 210370560 09:05:52 INFO - PROCESS | 9371 | 09:05:55 INFO - PROCESS | 9371 | Cycle 1(1): loaded http://localhost:45662/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45662/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:05:55 INFO - PROCESS | 9371 | RSS: Main: 212738048 09:05:55 INFO - PROCESS | 9371 | 09:05:58 INFO - PROCESS | 9371 | Cycle 1(1): loaded http://localhost:45662/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45662/tests/kraken/driver.html?testName=imaging-darkroom) 09:05:59 INFO - PROCESS | 9371 | RSS: Main: 248696832 09:05:59 INFO - PROCESS | 9371 | 09:06:02 INFO - PROCESS | 9371 | Cycle 1(1): loaded http://localhost:45662/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45662/tests/kraken/driver.html?testName=imaging-desaturate) 09:06:03 INFO - PROCESS | 9371 | RSS: Main: 248123392 09:06:03 INFO - PROCESS | 9371 | 09:06:06 INFO - PROCESS | 9371 | Cycle 1(1): loaded http://localhost:45662/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45662/tests/kraken/driver.html?testName=json-parse-financial) 09:06:06 INFO - PROCESS | 9371 | RSS: Main: 247517184 09:06:06 INFO - PROCESS | 9371 | 09:06:08 INFO - PROCESS | 9371 | Cycle 1(1): loaded http://localhost:45662/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45662/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:06:09 INFO - PROCESS | 9371 | RSS: Main: 209760256 09:06:09 INFO - PROCESS | 9371 | 09:06:11 INFO - PROCESS | 9371 | Cycle 1(1): loaded http://localhost:45662/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45662/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:06:11 INFO - PROCESS | 9371 | RSS: Main: 217268224 09:06:11 INFO - PROCESS | 9371 | 09:06:14 INFO - PROCESS | 9371 | Cycle 1(1): loaded http://localhost:45662/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45662/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:06:14 INFO - PROCESS | 9371 | RSS: Main: 226603008 09:06:14 INFO - PROCESS | 9371 | 09:06:17 INFO - PROCESS | 9371 | Cycle 1(1): loaded http://localhost:45662/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45662/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:06:18 INFO - PROCESS | 9371 | RSS: Main: 236285952 09:06:18 INFO - PROCESS | 9371 | 09:06:21 INFO - PROCESS | 9371 | Cycle 1(1): loaded http://localhost:45662/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45662/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:06:21 INFO - PROCESS | 9371 | RSS: Main: 231936000 09:06:21 INFO - PROCESS | 9371 | 09:06:23 INFO - PROCESS | 9371 | Cycle 1(1): loaded http://localhost:45662/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45662/tests/kraken/driver.html?testName=ai-astar) 09:06:23 INFO - PROCESS | 9371 | RSS: Main: 282202112 09:06:23 INFO - PROCESS | 9371 | 09:06:23 INFO - PROCESS | 9371 | __start_tp_report 09:06:23 INFO - PROCESS | 9371 | _x_x_mozilla_page_load 09:06:23 INFO - PROCESS | 9371 | _x_x_mozilla_page_load_details 09:06:23 INFO - PROCESS | 9371 | |i|pagename|runs| 09:06:23 INFO - PROCESS | 9371 | |0;ai-astar;107;115;115;117;116;116;115;117;115;115 09:06:23 INFO - PROCESS | 9371 | |1;audio-beat-detection;153;128;132;174;129;135;126;129;163;127 09:06:23 INFO - PROCESS | 9371 | |2;audio-dft;160;163;160;161;161;163;161;164;161;160 09:06:23 INFO - PROCESS | 9371 | |3;audio-fft;76;76;78;110;77;77;76;76;108;75 09:06:23 INFO - PROCESS | 9371 | |4;audio-oscillator;84;83;129;85;83;83;119;84;83;121 09:06:23 INFO - PROCESS | 9371 | |5;imaging-gaussian-blur;117;117;117;116;116;117;117;117;116;118 09:06:23 INFO - PROCESS | 9371 | |6;imaging-darkroom;146;148;146;147;145;146;148;147;146;147 09:06:23 INFO - PROCESS | 9371 | |7;imaging-desaturate;85;85;84;84;85;85;84;84;84;84 09:06:23 INFO - PROCESS | 9371 | |8;json-parse-financial;63;65;64;64;63;65;65;65;74;65 09:06:23 INFO - PROCESS | 9371 | |9;json-stringify-tinderbox;67;68;68;68;69;68;69;68;67;68 09:06:23 INFO - PROCESS | 9371 | |10;stanford-crypto-aes;84;84;84;83;91;86;83;84;92;83 09:06:23 INFO - PROCESS | 9371 | |11;stanford-crypto-ccm;145;145;150;155;141;144;143;143;188;161 09:06:23 INFO - PROCESS | 9371 | |12;stanford-crypto-pbkdf2;179;178;181;176;181;178;176;181;186;176 09:06:23 INFO - PROCESS | 9371 | |13;stanford-crypto-sha256-iterative;72;71;72;69;71;70;72;78;72;70 09:06:23 INFO - PROCESS | 9371 | __end_tp_report 09:06:23 INFO - PROCESS | 9371 | __start_cc_report 09:06:23 INFO - PROCESS | 9371 | _x_x_mozilla_cycle_collect,1992 09:06:23 INFO - PROCESS | 9371 | __end_cc_report 09:06:23 INFO - PROCESS | 9371 | __startTimestamp1477065983936__endTimestamp 09:06:23 INFO - PROCESS | 9371 | 09:06:23 INFO - PROCESS | 9371 | ------- Summary: start ------- 09:06:23 INFO - PROCESS | 9371 | Number of tests: 14 09:06:23 INFO - PROCESS | 9371 | 09:06:23 INFO - PROCESS | 9371 | [#0] ai-astar Cycles:10 Average:114.80 Median:115.50 stddev:2.86 (2.5%) stddev-sans-first:0.87 09:06:23 INFO - PROCESS | 9371 | Values: 107.0 115.0 115.0 117.0 116.0 116.0 115.0 117.0 115.0 115.0 09:06:23 INFO - PROCESS | 9371 | 09:06:23 INFO - PROCESS | 9371 | [#1] audio-beat-detection Cycles:10 Average:139.60 Median:133.50 stddev:17.30 (13.0%) stddev-sans-first:17.65 09:06:23 INFO - PROCESS | 9371 | Values: 153.0 128.0 132.0 174.0 129.0 135.0 126.0 129.0 163.0 127.0 09:06:23 INFO - PROCESS | 9371 | 09:06:23 INFO - PROCESS | 9371 | [#2] audio-dft Cycles:10 Average:161.40 Median:161.00 stddev:1.43 (0.9%) stddev-sans-first:1.42 09:06:23 INFO - PROCESS | 9371 | Values: 160.0 163.0 160.0 161.0 161.0 163.0 161.0 164.0 161.0 160.0 09:06:23 INFO - PROCESS | 9371 | 09:06:23 INFO - PROCESS | 9371 | [#3] audio-fft Cycles:10 Average:82.90 Median:76.00 stddev:13.79 (18.1%) stddev-sans-first:14.40 09:06:23 INFO - PROCESS | 9371 | Values: 76.0 76.0 78.0 110.0 77.0 77.0 76.0 76.0 108.0 75.0 09:06:23 INFO - PROCESS | 9371 | 09:06:23 INFO - PROCESS | 9371 | [#4] audio-oscillator Cycles:10 Average:95.40 Median:83.00 stddev:19.22 (23.2%) stddev-sans-first:19.94 09:06:23 INFO - PROCESS | 9371 | Values: 84.0 83.0 129.0 85.0 83.0 83.0 119.0 84.0 83.0 121.0 09:06:23 INFO - PROCESS | 9371 | 09:06:23 INFO - PROCESS | 9371 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.67 09:06:23 INFO - PROCESS | 9371 | Values: 117.0 117.0 117.0 116.0 116.0 117.0 117.0 117.0 116.0 118.0 09:06:23 INFO - PROCESS | 9371 | 09:06:23 INFO - PROCESS | 9371 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:147.00 stddev:0.97 (0.7%) stddev-sans-first:1.00 09:06:23 INFO - PROCESS | 9371 | Values: 146.0 148.0 146.0 147.0 145.0 146.0 148.0 147.0 146.0 147.0 09:06:23 INFO - PROCESS | 9371 | 09:06:23 INFO - PROCESS | 9371 | [#7] imaging-desaturate Cycles:10 Average:84.40 Median:84.50 stddev:0.52 (0.6%) stddev-sans-first:0.50 09:06:23 INFO - PROCESS | 9371 | Values: 85.0 85.0 84.0 84.0 85.0 85.0 84.0 84.0 84.0 84.0 09:06:23 INFO - PROCESS | 9371 | 09:06:23 INFO - PROCESS | 9371 | [#8] json-parse-financial Cycles:10 Average:65.30 Median:65.00 stddev:3.16 (4.9%) stddev-sans-first:3.24 09:06:23 INFO - PROCESS | 9371 | Values: 63.0 65.0 64.0 64.0 63.0 65.0 65.0 65.0 74.0 65.0 09:06:23 INFO - PROCESS | 9371 | 09:06:23 INFO - PROCESS | 9371 | [#9] json-stringify-tinderbox Cycles:10 Average:68.00 Median:68.00 stddev:0.67 (1.0%) stddev-sans-first:0.60 09:06:23 INFO - PROCESS | 9371 | Values: 67.0 68.0 68.0 68.0 69.0 68.0 69.0 68.0 67.0 68.0 09:06:23 INFO - PROCESS | 9371 | 09:06:23 INFO - PROCESS | 9371 | [#10] stanford-crypto-aes Cycles:10 Average:85.40 Median:84.00 stddev:3.34 (4.0%) stddev-sans-first:3.50 09:06:23 INFO - PROCESS | 9371 | Values: 84.0 84.0 84.0 83.0 91.0 86.0 83.0 84.0 92.0 83.0 09:06:23 INFO - PROCESS | 9371 | 09:06:23 INFO - PROCESS | 9371 | [#11] stanford-crypto-ccm Cycles:10 Average:151.50 Median:147.50 stddev:14.27 (9.7%) stddev-sans-first:14.94 09:06:23 INFO - PROCESS | 9371 | Values: 145.0 145.0 150.0 155.0 141.0 144.0 143.0 143.0 188.0 161.0 09:06:23 INFO - PROCESS | 9371 | 09:06:23 INFO - PROCESS | 9371 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:179.20 Median:180.00 stddev:3.16 (1.8%) stddev-sans-first:3.35 09:06:23 INFO - PROCESS | 9371 | Values: 179.0 178.0 181.0 176.0 181.0 178.0 176.0 181.0 186.0 176.0 09:06:23 INFO - PROCESS | 9371 | 09:06:23 INFO - PROCESS | 9371 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.70 Median:72.00 stddev:2.45 (3.4%) stddev-sans-first:2.60 09:06:23 INFO - PROCESS | 9371 | Values: 72.0 71.0 72.0 69.0 71.0 70.0 72.0 78.0 72.0 70.0 09:06:23 INFO - PROCESS | 9371 | -------- Summary: end -------- 09:06:23 INFO - PROCESS | 9371 | 09:06:25 INFO - TEST-INFO | 9371: exit 0 09:06:25 INFO - TEST-OK | kraken | took 64205ms 09:06:25 INFO - SUITE-END | took 1186s 09:06:25 INFO - Completed test suite (00:19:47) 09:06:25 INFO - javascript benchmark 09:06:25 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2577.6004719268512, 2584.0568192609703, 2619.8952041918324, 2634.328246297194, 2638.208537438768, 4635.304704294349, 4700.224462963607, 4709.64677649176, 4728.101660684468, 4729.716217026981, 4685.812567497296, 4688.9765551172195, 4702.670813043088, 4740.525947405258, 4773.379460670117, 4300.827966881321, 4319.460067491564, 4370.409994650713, 4378.956210437903, 4382.057857560624, 4361.193179261847, 4431.534688857671, 4452.087322098978, 4463.799129039185, 4512.819487220508, 4259.87220383389, 4384.4081049058605, 4387.802548885308, 4425.800838962255, 4505.414296141497, 4294.892627684301, 4306.332518459643, 4341.0, 4363.629091527224, 4385.079133381993, 4336.067745434715, 4338.501072376685, 4346.47842258931, 4399.054203346296, 4404.4494438195225, 4713.457952335457, 4717.481077081518, 4727.66906316558, 4730.858074257778, 4740.525947405266, 4883.267509873512, 4931.901361972777, 4935.728534930578, 4993.101241776479, 5061.569766569846, 4998.300237966688, 5014.172661510846, 5014.222795466709, 5017.247412888059, 5021.07110184617, 4672.135654903854, 4685.554872287127, 4687.906241875177, 4691.976540117345, 4701.95298047022, 5057.988402319551, 5088.796448142107, 5094.949050509522, 5103.362079740033, 5116.053530096944, 4871.2206047032305, 4900.436449808247, 4907.190313598217, 4911.115999120121, 4913.484084171182, 5001.299818025479, 5015.122353588107, 5019.498050194951, 5021.246812978083, 5022.271770593244, 4975.527324904128, 4976.676516026447, 4979.551840334388, 4980.850574482699, 4984.22744474607, 4998.0, 5000.924986125211, 5010.674306170087, 5018.924716129261, 5067.493250674903, 4169.583041695806, 4206.47419072616, 4240.660747140221, 4261.2542805009, 4295.463067116611, 3750.718696097804, 3764.9435258471144, 3768.1898391845884, 3768.773873567595, 3781.2248489059675, 4379.4087798147475, 4385.6052955233545, 4388.232059389594, 4388.495323037828, 4389.802458889294, 5072.264521644341, 5105.2086926526445, 5114.33513643224, 5133.23001549763, 5170.1727723564045, 4379.5182529921685, 4381.561843815657, 4383.123375324948, 4392.582704643054, 4443.977885086383, 4419.602235798793, 4552.772361381918, 4561.876942998826, 4568.931466028012, 4618.722876627413, 4691.272852707836, 4747.596454301354, 4773.0, 4807.254875494304, 4814.253790662453, 5121.462246464068, 5125.897482050413, 5138.8972220556125, 5148.897022059613, 5200.63595548308, 4796.872734907363, 4801.783919723551, 4805.8946442317765, 4809.831655892027, 4870.975645121752, 4845.3216549683775, 4910.484399138182, 4912.140375434356, 4953.975230123826, 5046.9747651261505, 5072.923906141485, 5123.052235336475, 5152.175651895679, 5156.355455568054, 5158.200478925773, 4938.728369939688, 4939.357883475125, 4956.8760780980765, 4960.851174464772, 4975.477574854588, 4943.579795717261, 4943.5797957174045, 4955.677880937727, 4964.354633897715, 5006.799728010838, 4795.592374648194, 4806.519348065165, 4835.226363781778, 4852.369192005158, 4858.78135483897, 4975.776090075883, 4975.975120124376, 4986.15235409974, 4986.850394488171, 4995.350604421402, 4865.026994601165, 4868.610511159028, 4878.487758785418, 4883.389576302962, 4898.069366820293], "value": 4640.540529467406, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [553.5986409852857, 562.9662220266785, 565.0478942981075, 583.9737211825468, 584.3922320786382, 37916.0, 39419.60580394195, 39434.01414964624, 39450.21099578014, 43987.0, 40861.79569102158, 41271.17457650845, 41298.587014129924, 41328.38007429891, 41417.792911035474, 7639.65621547029, 7791.337736292422, 7793.415493837985, 7794.76615701527, 7803.414743894202, 7538.547687138762, 7680.65437055331, 7680.923190768104, 7682.231776822329, 7687.385009199279, 7619.847603047936, 7660.310572048515, 7673.961630191841, 7694.076710794712, 7737.226277372274, 7579.317861392474, 7621.0, 7627.084749830056, 7632.847343053163, 7644.273793989562, 7651.387888968869, 7700.152983171846, 7721.03487064117, 7763.767086987399, 7765.922340776577, 38856.0, 39259.803700981596, 39282.41076383857, 39319.803400983095, 39332.80333598342, 2925.2394377462015, 2965.303153758865, 2969.6733359330456, 3115.5482455043893, 3465.8440370183403, 28328.575071373947, 28539.28651783722, 29021.709782902322, 30107.849460752775, 30267.545986810215, 3094.7430063076004, 3153.495440729472, 3250.4066739296027, 3259.2194398403362, 3275.197576593726, 257738.0, 258047.0, 258962.0, 259592.0, 259865.0, 51402.48597514052, 51538.0, 51817.48182518202, 51942.0, 52060.0, 32542.674573254437, 55336.72331638396, 55407.0, 55510.72244638751, 55556.72221638866, 13620.795688064687, 14291.285435728172, 14295.213763242913, 14319.856801431852, 14432.0, 11283.605073822377, 11408.885911140782, 11412.486438110305, 11413.201075924606, 11414.94292528532, 18078.5480362992, 18115.184816683282, 18138.18378172959, 18149.455516334532, 18312.26750929948, 6711.449619178425, 6777.220619628806, 6878.975799157449, 6929.203141638675, 6954.200266969363, 766.7853001159684, 881.532787622561, 894.8478758611052, 905.7418635688929, 932.6502561539422, 27485.0, 28924.566131508043, 30827.537586936214, 32640.403014644875, 32650.0, 766.8918412893315, 924.8890133183926, 944.17856464876, 948.9478078705738, 954.9856752148723, 13955.930220349037, 14621.926890365692, 15458.6135346615, 16177.433789817534, 16325.146152157788, 370958.0, 371170.0, 371481.0, 373986.0, 375811.0, 50803.49196507988, 51024.48975510272, 51103.23345149826, 51111.23333150006, 51226.48773512217, 977.1791694976254, 1087.842262871895, 1146.90251328638, 1160.14729174057, 1164.6622479480855, 24106.51786964286, 27515.17454476369, 29432.11703648894, 29509.0, 29941.556720977365, 48303.516964829905, 49039.0, 49057.2641410372, 49064.50935490742, 49069.263961041324, 336719.0, 340076.0, 340595.0, 340912.0, 341364.0, 24665.383365416008, 25228.117015904354, 25324.11365602195, 27039.45921081528, 38388.61611383851, 41245.0, 41290.38064428976, 42273.674947878164, 42430.36354454624, 42761.35857962071, 35834.0, 35924.4611330825, 35994.8200258997, 36312.4553131698, 36826.0, 35502.8224858874, 35791.105222369646, 36389.0, 36617.0, 37026.0, 34974.30051398907, 35898.0, 36211.637883620824, 36650.633493664725, 36690.0, 31207.687923121386, 31907.202319942186, 32935.835320824204, 34134.0, 34469.0, 20242.59514809666, 20304.89847550753, 20312.492187694836, 20435.693464597745, 20474.0], "value": 17482.527176731674, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [336.46502061721856, 348.8674303764571, 358.97128229741617, 359.6062311768613, 374.1768110157652, 12315.445804938778, 13341.666458338534, 15814.367425302988, 16300.918495407506, 16719.0, 15453.0, 15685.0, 16050.147964488526, 16439.91780041101, 16483.258253378597, 3932.941005884914, 4099.938500922489, 4101.91796164078, 4104.466419365478, 4104.815283312243, 4305.806238719265, 5129.897402051956, 5142.51146141116, 5147.408048074463, 5149.536541711245, 5109.156989096795, 5112.769925353368, 5118.3857937047605, 5118.564921981636, 5120.513551212629, 4907.730074845864, 5027.542012816279, 5030.396352437694, 5053.242013697938, 5056.898862022739, 4513.52607976161, 4517.0, 4518.367428560005, 4521.932171017437, 4526.388937493429, 19956.201751929904, 20624.58750824975, 20662.0, 20878.26926057596, 21255.468613284636, 1724.7585338052684, 1754.2456743600246, 1765.9646807063916, 1799.9010054447, 1816.5821860971919, 8478.703245386443, 8680.913190868074, 11984.64046078619, 12100.515979360815, 12531.624051278477, 1538.7461068923615, 1586.373382513912, 1626.211287525549, 1632.918354082303, 1691.7039518084287, 69405.0, 70548.29451705469, 71658.64170679165, 72814.27185728181, 73798.63100684516, 9311.208547273422, 9462.688059179232, 9609.47147906858, 9710.805783884283, 9722.222222222204, 13273.933630331787, 13295.401706923212, 13308.0, 13310.933445332712, 13334.533291334757, 6823.112995310578, 6885.896711549331, 7011.544249623758, 7031.261717519689, 7075.0, 6253.1245625612455, 6317.210348706411, 6388.840278993062, 6495.350464953562, 6529.347065293433, 3805.6955443565002, 3900.863469778544, 3941.6058394160355, 4216.64158546527, 4243.405923170759, 1693.1280390598852, 1693.8644908407298, 1728.9394871179447, 1742.2072956804623, 1815.7457955886186, 697.2957313113792, 723.6128671161009, 781.7928249014016, 783.295034468971, 831.9209675080857, 15239.619009524851, 15319.617009574627, 15440.691186176213, 15551.377944882079, 16178.110203938897, 737.5058710663868, 762.9694812207449, 766.6243540665146, 772.4669977715358, 773.1225059557443, 8469.491830490191, 8751.693690720795, 9080.364374493854, 9619.0, 10578.153747700166, 394555.0, 395338.0, 398738.0, 403661.0, 404416.0, 79699.60150199328, 83454.0, 84575.99999999876, 85176.57411713025, 85434.0, 907.5643691028212, 920.7191806498948, 956.8038552096942, 958.5111593087576, 959.8176346494143, 15434.691306174038, 15446.227688615749, 16027.599310017344, 16256.349746010028, 16306.836931630532, 36723.0, 37211.25577488489, 37384.252314953, 37631.81184094062, 37779.244415110996, 47362.52637473581, 48283.75858120687, 49116.0, 53400.73299633477, 54033.0, 7145.749898753519, 7280.635968201463, 7297.306755858185, 7454.552726836408, 7786.0, 7929.643166057426, 10265.58937642486, 10625.096866766411, 10789.838152427878, 10848.077913377452, 8954.820903582022, 9365.250779937453, 9410.576524056298, 9429.198518126037, 9932.652357167464, 9412.247020238228, 9545.379550329206, 9580.515827897758, 9691.757706057406, 9851.359661621971, 9528.714138575853, 9601.759956001157, 9666.854997174907, 9826.459544725109, 10050.597976080875, 7407.8148046299275, 7438.367738742268, 7584.5070070445245, 7630.885536716843, 7661.620908236571, 8665.2634526066, 9233.0, 9485.952570237381, 9800.607975681178, 9830.950845245728], "value": 7805.454413248809, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1363.924984125873, 1414.370605080739, 1475.2328789029705, 1694.0851939952427, 1703.5741064733809, 6952.2352541220425, 7216.494845360827, 7559.244075592438, 8229.794255143624, 8229.917700822998, 7464.328210461057, 7734.419918506121, 7741.612919354038, 7976.401769867269, 7990.840183196347, 2070.81362677359, 2092.2258764257244, 2092.393205970267, 2111.4826867417505, 2114.8942552872372, 1788.2399980008445, 1856.452346557762, 2035.6335859545277, 2046.2326627514683, 2048.498117961094, 1841.1254654039358, 1858.637565674694, 2020.666590012646, 2082.541840795023, 2088.634488964433, 2006.9297574584893, 2007.7389939307943, 2009.65835807913, 2010.1055030511502, 2014.5064459207588, 2057.660486019805, 2078.3972647932083, 2118.93643190703, 2120.8409369297365, 2127.702121702963, 7977.641006154737, 8060.113387527367, 8064.072631647318, 8064.274215320591, 8066.314363279128, 4510.751908645023, 4578.908421831545, 4630.282306242538, 4634.791434385461, 4672.6261899047995, 2945.5287154055463, 3081.784275100744, 3153.8423078845967, 3157.289609837791, 3165.8733650653944, 925.4447331601053, 962.0716009051229, 972.9805403891953, 975.3757595139117, 1009.6415772400766, 10906.182036347305, 10931.234813562975, 10932.56269749209, 10939.12487001038, 10949.890501094967, 4106.117184805222, 4346.217680817484, 4394.231009573312, 4460.553944605578, 4462.888427789267, 9279.211267042241, 9279.72160835176, 9288.953555232181, 9294.163525282622, 9294.72115836526, 4669.766511674403, 4681.742504162304, 4687.086018226481, 4689.226277664147, 4689.296605509201, 4114.958850411517, 4222.59885310895, 4228.069824638575, 4240.766757828349, 4245.3844192591905, 3476.800503826176, 3482.895513134559, 3554.129238336572, 3576.5529308836394, 3694.7413681042067, 1167.235460773195, 1199.5681554640323, 1204.3496511883484, 1215.0, 1222.0712258683463, 625.3340192694766, 629.0689779126826, 659.2583343738295, 746.0264355016647, 822.1860358245414, 5095.490450954875, 5121.948780512222, 5140.820071297561, 5283.07546179417, 5584.46947539983, 818.5334359415076, 843.3042739739617, 847.3856454070873, 892.2237653241722, 894.1684233662626, 3247.9675203247666, 3311.1887587540723, 3373.2916087621384, 3417.4019546579248, 3435.175557866144, 9437.433753974783, 9687.9031209687, 9837.655682051094, 9989.35069220513, 10086.596536138471, 9995.550200241007, 9999.650012249536, 10002.199824014062, 10002.199824014062, 10006.0, 7283.562986220843, 7347.375473084848, 7392.852142957111, 7477.887831682529, 7485.775426737097, 5007.574356179765, 5064.620153488429, 5125.7693403796175, 5133.614978876674, 5159.819406320761, 8371.874421883555, 8721.0, 8921.375503714937, 8967.551622418723, 8981.0, 8594.699185528476, 8755.343349248958, 8902.643894244158, 8920.509371984603, 8943.865842012245, 6630.602163870183, 6774.86450270982, 6778.796636100925, 6782.898256526255, 6786.76246331376, 7605.391568674603, 7612.581308028111, 7626.665333566714, 7671.117821450604, 7685.807854803675, 6654.168228971379, 6686.498512611476, 6739.73041078371, 6819.965900170468, 6839.316068393121, 6345.3654634538025, 6459.9031014533875, 6524.608523488606, 6551.4103730664465, 6563.671816409256, 6246.125542424155, 6358.1734374531015, 6359.20509936258, 6362.300146983735, 6400.935990640034, 4247.723897946624, 4282.528921818535, 4283.721558098714, 4311.9784401077795, 4522.683412161117, 4250.744955302692, 4313.84901528445, 4350.804213810323, 4408.7575183365225, 4520.937579668709], "value": 4091.087843430962, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [282.3435512433591, 290.6134840661919, 293.7121620811605, 297.8153544802223, 298.6431214698436, 4801.4718380978065, 4826.71039737616, 4847.321375007497, 4888.902221955559, 4929.975350123249, 4518.412606361168, 4606.3781389512405, 4700.0, 4737.810487580501, 4799.544043315879, 3742.5696044954907, 3747.2318174774105, 3748.257060466882, 3754.5119134512543, 3762.0, 3758.191988722424, 3764.3600587900123, 3768.152165762695, 3771.3023090728166, 3772.962435330279, 3566.589842168145, 3614.457831325296, 3667.688246499051, 3672.375696131651, 3724.16206353571, 3686.8525258989876, 3699.2231631357313, 3699.408094704834, 3710.777353358807, 3729.4032954727386, 3273.5580696605894, 3276.4757638777683, 3278.983605081983, 3282.2778988622463, 3282.885099021523, 4491.2603311979665, 4662.930056049162, 4681.9297710534365, 4682.133805246006, 4704.223803072489, 4170.164288283966, 4189.360702757243, 4198.979005104955, 4201.823489422966, 4211.968067823373, 4986.152354099811, 4998.775055122528, 5012.573931215815, 5014.147594908838, 5015.673981191211, 3563.750537462379, 3578.8926332210076, 3583.122135076923, 3588.766730162531, 3597.6402359764074, 5090.556532864209, 5198.4801519847715, 5200.6879587224885, 5222.843314700565, 5233.9738301308635, 3638.21778317663, 3640.3993341098953, 3642.7814331140216, 3651.3610118229203, 3655.6344365563764, 3666.7433279670167, 3670.6696397324367, 3675.9264814703556, 3683.6684698377276, 3687.3178461984617, 4023.3562629979647, 4162.0, 4185.665146788249, 4193.601607847249, 4201.6008479194425, 4987.750612469362, 4993.425756038102, 5003.3495645565845, 5007.94674183583, 5016.924746128811, 1227.4537830665267, 1285.2609749394135, 1304.6953046953047, 1306.8956731561816, 1306.9738605228033, 790.774299835253, 807.4509333653054, 808.9595520223966, 809.6720828064643, 812.1999830167281, 4395.164918665443, 4468.151051300308, 4483.887902802391, 4491.505934347219, 4498.8425405110665, 5191.195364718475, 5202.2196670499725, 5207.817726379559, 5208.609354298443, 5208.8958220835375, 4258.318669012943, 4499.482559505634, 4504.819807207675, 4506.436695413074, 4527.4340707411575, 2719.1706529508688, 2760.3651160233258, 2763.226296636945, 2764.378014946621, 2766.1286694691107, 4890.144224760653, 4895.877603059881, 4897.0, 4898.289747986522, 4920.138975679241, 5079.97460012705, 5287.339082614673, 5327.387350454747, 5339.439358867263, 5340.599455040888, 4891.239153904591, 4894.804207831647, 4900.240462728283, 4914.125236736478, 4917.483664215206, 5168.811173430057, 5175.120229560908, 5191.377034755854, 5210.713410762444, 5214.32213812202, 4963.801447942186, 5097.7706003229205, 5120.487951204998, 5124.743762811919, 5131.79472821083, 4832.8791780205775, 4846.781894814671, 4874.268859671078, 4880.853574392774, 4898.975505122452, 3254.511823226535, 3265.526498657729, 3273.3780581689402, 3329.583802024747, 3345.481450375196, 4538.6369090473345, 4643.0, 4868.344762780672, 5193.37679478465, 5201.42784293735, 5059.519345662156, 5063.215201643751, 5064.620153488577, 5066.949330506795, 5080.898382032413, 5064.898702026013, 5070.239464080418, 5075.111855425212, 5081.644284900021, 5119.87200319995, 4722.252766476426, 4762.9285560715925, 4943.382077240345, 4983.327250821238, 5000.1749711297225, 4979.584901322928, 4979.726115063561, 4992.475790042138, 5001.024800163933, 5005.674631148963, 4836.5248599177585, 4949.678270912379, 4989.201727723546, 4989.575886049726, 4990.925136123034], "value": 3759.937119714661, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [641.6438876423583, 644.3653001793233, 663.4625952978085, 728.4645785347772, 753.227941360106, 12653.240805551663, 13726.656833579153, 13732.65668358289, 13743.518976835812, 13772.311384430788, 13246.536371227008, 13256.204627722344, 13271.20372777634, 13285.667858303546, 13332.866671333284, 620.3455354600894, 637.1271358239219, 770.8458308338327, 773.6711897443578, 796.7410591557738, 791.8495485857669, 792.9524228546277, 795.0657976877175, 795.6021989005498, 796.0526972902228, 841.8989721233461, 843.2115971566574, 843.2874221283006, 843.3379796859466, 843.5782108945527, 653.1802587752388, 659.0, 837.351052933981, 837.5351679817699, 837.811492414205, 492.18297625940767, 492.3058487532562, 492.4066499867651, 601.4947444146937, 608.4736702752132, 12986.675333116653, 13044.41300141496, 13059.085863989525, 13103.86896131036, 13137.408816603276, 12603.873961260362, 12983.545575904798, 13356.732865342736, 13479.595612131652, 13550.728985420335, 10761.892381076246, 11101.888981110167, 11477.540898364055, 11488.712782180428, 11588.768224635545, 3043.421749867518, 3116.298832762633, 3151.133438304462, 3164.6677098904743, 3211.775175737699, 58680.41319586792, 59350.0, 59907.400925990616, 60478.39521604771, 60485.39514604842, 10448.738781530523, 10701.732456688645, 10839.83740243897, 10860.13118950482, 11191.384473853854, 20913.686294705592, 21173.258935937476, 21209.257675981265, 21211.575768484854, 21299.46751331229, 7137.614037540618, 7178.8205294867, 7220.422366210691, 7247.057882475245, 7510.774676759706, 3303.752218583616, 3310.4537751270773, 3357.8824741133944, 3388.9322213555592, 3423.3495635829113, 2896.6675329348313, 2951.4834903891733, 2973.8067025643263, 2984.418038482475, 3004.1888690053565, 509.6967304453844, 523.2099529710089, 528.9975496434236, 534.7700488789858, 540.9377921538995, 551.3549147497438, 570.7574280930588, 620.9844753881099, 621.5959626242978, 630.2814791138014, 7927.167647397056, 8070.878936815952, 8172.305354044973, 8257.298129658926, 8372.41393102477, 511.63929429751937, 533.6184627991005, 604.3956043956044, 606.1544145916422, 623.1991890420787, 3671.908202294964, 3813.923721525554, 3873.8450461981206, 3888.0862997195636, 3908.270018696059, 99330.0, 100147.0, 101340.49329753304, 104532.47733761283, 104818.47590761997, 49160.75419622879, 77306.65586769248, 79223.60388198022, 80528.59735701284, 80865.59567202126, 75393.62303188558, 77877.6106119477, 79114.20885791183, 81012.59493702494, 83304.58347708343, 7251.166115896739, 7304.525205861814, 7358.816029599303, 7545.0, 7649.196834332315, 29996.0, 34962.47556286607, 41230.76307710774, 41462.1707565841, 42514.93115425993, 55633.72183139058, 56314.718426407606, 56912.0, 57686.423135768106, 58725.961177957564, 11400.0, 11499.0, 11556.191066625255, 11658.18392712502, 11714.121440891797, 11929.0, 12265.754684906431, 12266.202696824677, 12319.63041108768, 13384.866151338361, 11916.712959289096, 12041.217320874115, 12114.15200935926, 12210.32443663103, 12662.240265584094, 10627.574897004033, 10751.677449676523, 10808.621698240524, 11167.944160279147, 11753.647390578297, 12045.51817927273, 12085.697857553632, 12595.87404125947, 12724.809127862904, 12732.936335318635, 9623.951880240555, 9806.901930980885, 10423.166146708094, 10566.788664226826, 10594.629187978384, 10169.644062457779, 10208.489575521045, 10257.230707696803, 10369.481525923824, 10394.740131496774], "value": 6518.686876420844, "unit": "score"}], "name": "dromaeo_css", "value": 6316.357646144115, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 115.0, 115.0, 117.0, 116.0, 116.0, 115.0, 117.0, 115.0, 115.0], "value": 114.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 128.0, 132.0, 174.0, 129.0, 135.0, 126.0, 129.0, 163.0, 127.0], "value": 139.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 163.0, 160.0, 161.0, 161.0, 163.0, 161.0, 164.0, 161.0, 160.0], "value": 161.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 78.0, 110.0, 77.0, 77.0, 76.0, 76.0, 108.0, 75.0], "value": 82.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 129.0, 85.0, 83.0, 83.0, 119.0, 84.0, 83.0, 121.0], "value": 95.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 116.0, 116.0, 117.0, 117.0, 117.0, 116.0, 118.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 148.0, 146.0, 147.0, 145.0, 146.0, 148.0, 147.0, 146.0, 147.0], "value": 146.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 84.0, 84.0, 85.0, 85.0, 84.0, 84.0, 84.0, 84.0], "value": 84.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 65.0, 64.0, 64.0, 63.0, 65.0, 65.0, 65.0, 74.0, 65.0], "value": 65.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 68.0, 68.0, 69.0, 68.0, 69.0, 68.0, 67.0, 68.0], "value": 68.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 84.0, 83.0, 91.0, 86.0, 83.0, 84.0, 92.0, 83.0], "value": 85.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 150.0, 155.0, 141.0, 144.0, 143.0, 143.0, 188.0, 161.0], "value": 151.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [179.0, 178.0, 181.0, 176.0, 181.0, 178.0, 176.0, 181.0, 186.0, 176.0], "value": 179.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 71.0, 72.0, 69.0, 71.0, 70.0, 72.0, 78.0, 72.0, 70.0], "value": 71.7, "unit": "score"}], "name": "kraken", "value": 1563.0, "alertThreshold": 2.0}]} 09:06:25 INFO - Return code: 0 09:06:25 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:06:25 INFO - # TBPL SUCCESS # 09:06:25 INFO - Running post-action listener: _resource_record_post_action 09:06:25 INFO - [mozharness: 2016-10-21 16:06:25.707987Z] Finished run-tests step (success) 09:06:25 INFO - Running post-run listener: _resource_record_post_run 09:06:25 INFO - Total resource usage - Wall time: 1203s; CPU: 13.0%; Read bytes: 4096; Write bytes: 403271680; Read time: 16; Write time: 301992 09:06:25 INFO - TinderboxPrint: CPU usage
13.0% 09:06:25 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 09:06:25 INFO - TinderboxPrint: I/O write bytes / time
403,271,680 / 301,992 09:06:25 INFO - TinderboxPrint: CPU idle
8,346.4 (86.9%) 09:06:25 INFO - TinderboxPrint: CPU user
1,203.1 (12.5%) 09:06:25 INFO - TinderboxPrint: Swap in / out
0 / 0 09:06:25 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 110845952; Read time: 0; Write time: 73492 09:06:25 INFO - run-tests - Wall time: 1188s; CPU: 13.0%; Read bytes: 0; Write bytes: 292425728; Read time: 0; Write time: 228500 09:06:26 INFO - Running post-run listener: _upload_blobber_files 09:06:26 INFO - Blob upload gear active. 09:06:26 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:06:26 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 09:06:26 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'] 09:06:26 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 09:06:26 INFO - (blobuploader) - INFO - Open directory for files ... 09:06:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:06:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:06:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:06:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:06:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:06:27 INFO - (blobuploader) - INFO - Done attempting. 09:06:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:06:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:06:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:06:31 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:06:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:06:31 INFO - (blobuploader) - INFO - Done attempting. 09:06:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:06:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:06:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:06:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:06:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:06:33 INFO - (blobuploader) - INFO - Done attempting. 09:06:33 INFO - (blobuploader) - INFO - Iteration through files over. 09:06:33 INFO - Return code: 0 09:06:33 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:06:33 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:06:33 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/850f59602261586d844f67d8bc7463d05bcbfd2c71d26742c55c6387333074267b7468043b788ce685728fa86b6aad9e7a21a8e9cbfdd881af78bce613496143", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fa021f2a7489419113dfa3aa4d9f532f08aeaa6f24769fc97795cc86151d3306833bc95c6efd7f7ee127593a23013ec1caa61f22290382130dc5a19b742ee6be", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0f3300292031d137149e6d6f68272e739f159ead391d4063d445ea5f5353fbcef332bed4bdc8f6e978669e9e17e6dfcd51dd0c86e474f9fbbea27d79af64be80"} 09:06:33 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:06:33 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:06:33 INFO - Contents: 09:06:33 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/850f59602261586d844f67d8bc7463d05bcbfd2c71d26742c55c6387333074267b7468043b788ce685728fa86b6aad9e7a21a8e9cbfdd881af78bce613496143", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fa021f2a7489419113dfa3aa4d9f532f08aeaa6f24769fc97795cc86151d3306833bc95c6efd7f7ee127593a23013ec1caa61f22290382130dc5a19b742ee6be", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0f3300292031d137149e6d6f68272e739f159ead391d4063d445ea5f5353fbcef332bed4bdc8f6e978669e9e17e6dfcd51dd0c86e474f9fbbea27d79af64be80"} 09:06:33 INFO - Running post-run listener: copy_logs_to_upload_dir 09:06:33 INFO - Copying logs to upload dir... 09:06:33 INFO - mkdir: /builds/slave/test/build/upload/logs 09:06:33 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.577917 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-10-21 09:06:32.772789) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-21 09:06:32.776314) ========= 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=a0d2d2de893abaa8702a9954000001a7-1477050688.554526-2145565656 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/850f59602261586d844f67d8bc7463d05bcbfd2c71d26742c55c6387333074267b7468043b788ce685728fa86b6aad9e7a21a8e9cbfdd881af78bce613496143", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fa021f2a7489419113dfa3aa4d9f532f08aeaa6f24769fc97795cc86151d3306833bc95c6efd7f7ee127593a23013ec1caa61f22290382130dc5a19b742ee6be", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0f3300292031d137149e6d6f68272e739f159ead391d4063d445ea5f5353fbcef332bed4bdc8f6e978669e9e17e6dfcd51dd0c86e474f9fbbea27d79af64be80"} build_url:https://queue.taskcluster.net/v1/task/ITFVFJtnTtqb_OsjRt0rww/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011280 build_url: 'https://queue.taskcluster.net/v1/task/ITFVFJtnTtqb_OsjRt0rww/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/850f59602261586d844f67d8bc7463d05bcbfd2c71d26742c55c6387333074267b7468043b788ce685728fa86b6aad9e7a21a8e9cbfdd881af78bce613496143", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fa021f2a7489419113dfa3aa4d9f532f08aeaa6f24769fc97795cc86151d3306833bc95c6efd7f7ee127593a23013ec1caa61f22290382130dc5a19b742ee6be", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0f3300292031d137149e6d6f68272e739f159ead391d4063d445ea5f5353fbcef332bed4bdc8f6e978669e9e17e6dfcd51dd0c86e474f9fbbea27d79af64be80"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-21 09:06:32.800886) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-21 09:06:32.801207) ========= 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=a0d2d2de893abaa8702a9954000001a7-1477050688.554526-2145565656 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004449 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-21 09:06:32.886718) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-21 09:06:32.887049) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-21 09:06:32.887330) ========= ========= Total master_lag: 0.20 =========