builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-033 starttime: 1476196184.12 results: success (0) buildid: 20161011043001 builduid: d927cf4c0ed840dd96990d5b01133743 revision: 7ae377917236b7e6111146aa9fb4c073c0efc7f4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-11 07:29:44.120586) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-11 07:29:44.121706) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-11 07:29:44.122055) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-11 07:29:44.137002) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-11 07:29:44.137379) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1476196183.950627-53494217 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-11 07:29: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% 38.2M=0s 2016-10-11 07:29:44 (38.2 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.154691 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-11 07:29:44.306100) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-11 07:29:44.306430) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1476196183.950627-53494217 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015395 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-11 07:29:44.356824) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-11 07:29:44.357181) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 7ae377917236b7e6111146aa9fb4c073c0efc7f4 --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 7ae377917236b7e6111146aa9fb4c073c0efc7f4 --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=edae0fb5fee9fb758e8af6d3000002a4-1476196183.950627-53494217 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-11 07:29:44,885 truncating revision to first 12 chars 2016-10-11 07:29:44,885 Setting DEBUG logging. 2016-10-11 07:29:44,885 attempt 1/10 2016-10-11 07:29:44,885 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/7ae377917236?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-11 07:29:46,301 unpacking tar archive at: mozilla-central-7ae377917236/testing/mozharness/ program finished with exit code 0 elapsedTime=1.724237 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-11 07:29:46.094921) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-11 07:29:46.095248) ========= script_repo_revision: 7ae377917236b7e6111146aa9fb4c073c0efc7f4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-11 07:29:46.095662) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-11 07:29:46.095948) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-11 07:29:46.104788) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-10-11 07:29:46.105062) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=edae0fb5fee9fb758e8af6d3000002a4-1476196183.950627-53494217 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:29:46 INFO - MultiFileLogger online at 20161011 07:29:46 in /builds/slave/test 07:29:46 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 07:29:46 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:29:46 INFO - {'append_to_log': False, 07:29:46 INFO - 'base_work_dir': '/builds/slave/test', 07:29:46 INFO - 'blob_upload_branch': 'Firefox', 07:29:46 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:29:46 INFO - 'branch': 'Firefox', 07:29:46 INFO - 'buildbot_json_path': 'buildprops.json', 07:29:46 INFO - 'config_files': ('talos/linux_config.py',), 07:29:46 INFO - 'default_actions': ('clobber', 07:29:46 INFO - 'read-buildbot-config', 07:29:46 INFO - 'download-and-extract', 07:29:46 INFO - 'populate-webroot', 07:29:46 INFO - 'create-virtualenv', 07:29:46 INFO - 'install', 07:29:46 INFO - 'run-tests'), 07:29:46 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:29:46 INFO - 'download_minidump_stackwalk': True, 07:29:46 INFO - 'download_symbols': 'ondemand', 07:29:46 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:29:46 INFO - 'tooltool.py': '/tools/tooltool.py', 07:29:46 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:29:46 INFO - '/tools/misc-python/virtualenv.py')}, 07:29:46 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:29:46 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:29:46 INFO - 'installer_path': 'installer.exe', 07:29:46 INFO - 'log_level': 'info', 07:29:46 INFO - 'log_name': 'talos', 07:29:46 INFO - 'log_to_console': True, 07:29:46 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:29:46 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:29:46 INFO - 'opt_config_files': (), 07:29:46 INFO - 'pip_index': False, 07:29:46 INFO - 'sps_profile': False, 07:29:46 INFO - 'sps_profile_interval': 0, 07:29:46 INFO - 'suite': 'dromaeojs-e10s', 07:29:46 INFO - 'system_bits': '32', 07:29:46 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:29:46 INFO - 'title': 'talos-linux64-ix-033', 07:29:46 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:29:46 INFO - 'use_talos_json': True, 07:29:46 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:29:46 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:29:46 INFO - 'work_dir': 'build'} 07:29:46 INFO - [mozharness: 2016-10-11 14:29:46.727189Z] Running clobber step. 07:29:46 INFO - Running pre-action listener: _resource_record_pre_action 07:29:46 INFO - Running main action method: clobber 07:29:46 INFO - rmtree: /builds/slave/test/build 07:29:46 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:29:47 INFO - Running post-action listener: _resource_record_post_action 07:29:47 INFO - [mozharness: 2016-10-11 14:29:47.190059Z] Finished clobber step (success) 07:29:47 INFO - [mozharness: 2016-10-11 14:29:47.190160Z] Running read-buildbot-config step. 07:29:47 INFO - Running pre-action listener: _resource_record_pre_action 07:29:47 INFO - Running main action method: read_buildbot_config 07:29:47 INFO - Using buildbot properties: 07:29:47 INFO - { 07:29:47 INFO - "project": "", 07:29:47 INFO - "product": "firefox", 07:29:47 INFO - "script_repo_revision": "production", 07:29:47 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 07:29:47 INFO - "repository": "", 07:29:47 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 07:29:47 INFO - "buildid": "20161011043001", 07:29:47 INFO - "pgo_build": "True", 07:29:47 INFO - "basedir": "/builds/slave/test", 07:29:47 INFO - "buildnumber": 190, 07:29:47 INFO - "slavename": "talos-linux64-ix-033", 07:29:47 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 07:29:47 INFO - "platform": "ubuntu64_hw", 07:29:47 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 07:29:47 INFO - "branch": "mozilla-central", 07:29:47 INFO - "repo_path": "mozilla-central", 07:29:47 INFO - "revision": "7ae377917236b7e6111146aa9fb4c073c0efc7f4", 07:29:47 INFO - "stage_platform": "linux64-pgo", 07:29:47 INFO - "builduid": "d927cf4c0ed840dd96990d5b01133743", 07:29:47 INFO - "slavebuilddir": "test" 07:29:47 INFO - } 07:29:47 INFO - Found installer url https://queue.taskcluster.net/v1/task/Z9LOcrN6R7eCPFycCeIPMA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 07:29:47 INFO - Running post-action listener: _resource_record_post_action 07:29:47 INFO - [mozharness: 2016-10-11 14:29:47.192596Z] Finished read-buildbot-config step (success) 07:29:47 INFO - [mozharness: 2016-10-11 14:29:47.192685Z] Running download-and-extract step. 07:29:47 INFO - Running pre-action listener: _resource_record_pre_action 07:29:47 INFO - Running main action method: download_and_extract 07:29:47 INFO - mkdir: /builds/slave/test/build/tests 07:29:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:29:47 INFO - trying https://queue.taskcluster.net/v1/task/Z9LOcrN6R7eCPFycCeIPMA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 07:29:47 INFO - Downloading https://queue.taskcluster.net/v1/task/Z9LOcrN6R7eCPFycCeIPMA/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 07:29:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Z9LOcrN6R7eCPFycCeIPMA/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 07:29:47 INFO - Downloaded 1361 bytes. 07:29:47 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 07:29:47 INFO - Using the following test package requirements: 07:29:47 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 07:29:47 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 07:29:47 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:29:47 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 07:29:47 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:29:47 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 07:29:47 INFO - u'jsshell-linux-x86_64.zip'], 07:29:47 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 07:29:47 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:29:47 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 07:29:47 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 07:29:47 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:29:47 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 07:29:47 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:29:47 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 07:29:47 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:29:47 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 07:29:47 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:29:47 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:29:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Z9LOcrN6R7eCPFycCeIPMA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 07:29:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Z9LOcrN6R7eCPFycCeIPMA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:29:47 INFO - Fetch https://queue.taskcluster.net/v1/task/Z9LOcrN6R7eCPFycCeIPMA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 07:29:48 INFO - Http code: 200 07:29:48 INFO - via: 1.1 455cf6ccbccc261c46d02110de1c0237.cloudfront.net (CloudFront) 07:29:48 INFO - x-amz-cf-id: cN_Me9ukm7YD4oS0Wo3NoaHrnHP8AMGMOBbNltsvj4X61sXno_5Acw== 07:29:48 INFO - x-amz-version-id: ObezX.35VoD8nBpvEWSk2OCNopDGq.gX 07:29:48 INFO - Expected file size: 22100463 07:29:48 INFO - Obtained file size: 22100463 07:29:52 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 07:29:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Z9LOcrN6R7eCPFycCeIPMA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 07:29:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Z9LOcrN6R7eCPFycCeIPMA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:29:52 INFO - Fetch https://queue.taskcluster.net/v1/task/Z9LOcrN6R7eCPFycCeIPMA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 07:29:53 INFO - Http code: 200 07:29:53 INFO - via: 1.1 11dd60d1f68e8258294f92935b53a91f.cloudfront.net (CloudFront) 07:29:53 INFO - x-amz-cf-id: jdrC3Hk17YMmONxpYCEG-rhQqseYo5qQXHcGstOVgyL8weF6sNVr-w== 07:29:53 INFO - x-amz-version-id: ObezX.35VoD8nBpvEWSk2OCNopDGq.gX 07:29:53 INFO - Expected file size: 22100463 07:29:53 INFO - Obtained file size: 22100463 07:29:58 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Z9LOcrN6R7eCPFycCeIPMA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 07:29:58 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Z9LOcrN6R7eCPFycCeIPMA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 07:29:58 INFO - Fetch https://queue.taskcluster.net/v1/task/Z9LOcrN6R7eCPFycCeIPMA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 07:29:58 INFO - Http code: 200 07:29:58 INFO - via: 1.1 a1aa00de8387e7235a256b2a5b73ede8.cloudfront.net (CloudFront) 07:29:58 INFO - x-amz-cf-id: B97JNFoUwLk3OcbckhV2Xup0JLIdZLhsdjjJszQcJ2s0hmV7BsGzFw== 07:29:58 INFO - x-amz-version-id: pSDhGxvc2hpA8RZxXydHfyv61PmGOR1w 07:29:58 INFO - Expected file size: 14409006 07:29:58 INFO - Obtained file size: 14409006 07:29:59 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')]} 07:29:59 INFO - trying https://queue.taskcluster.net/v1/task/Z9LOcrN6R7eCPFycCeIPMA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 07:29:59 INFO - Downloading https://queue.taskcluster.net/v1/task/Z9LOcrN6R7eCPFycCeIPMA/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 07:29:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Z9LOcrN6R7eCPFycCeIPMA/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 07:30:00 INFO - Downloaded 59759815 bytes. 07:30:00 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Z9LOcrN6R7eCPFycCeIPMA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 07:30:00 INFO - mkdir: /builds/slave/test/properties 07:30:00 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:30:00 INFO - Writing to file /builds/slave/test/properties/build_url 07:30:00 INFO - Contents: 07:30:00 INFO - build_url:https://queue.taskcluster.net/v1/task/Z9LOcrN6R7eCPFycCeIPMA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 07:30:01 INFO - Running post-action listener: _resource_record_post_action 07:30:01 INFO - Running post-action listener: set_extra_try_arguments 07:30:01 INFO - [mozharness: 2016-10-11 14:30:01.041073Z] Finished download-and-extract step (success) 07:30:01 INFO - [mozharness: 2016-10-11 14:30:01.041301Z] Running populate-webroot step. 07:30:01 INFO - Running pre-action listener: _resource_record_pre_action 07:30:01 INFO - Running main action method: populate_webroot 07:30:01 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:30:01 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:30:01 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:30:01 INFO - '--tppagecycles', 07:30:01 INFO - '7'], 07:30:01 INFO - 'tests': ['tsvgm']}}, 07:30:01 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:30:01 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:30:01 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:30:01 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:30:01 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:30:01 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:30:01 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:30:01 INFO - 'talos_options': ['--disable-e10s'], 07:30:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:30:01 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:30:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:30:01 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:30:01 INFO - 'talos_options': ['--disable-e10s'], 07:30:01 INFO - 'tests': ['damp', 'tps']}, 07:30:01 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:30:01 INFO - 'tests': ['damp', 'tps']}, 07:30:01 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:30:01 INFO - 'tests': ['dromaeo_dom']}, 07:30:01 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:30:01 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:30:01 INFO - 'tests': ['basic_compositor_video']}, 07:30:01 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:30:01 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:30:01 INFO - 'tests': ['a11yr', 07:30:01 INFO - 'ts_paint', 07:30:01 INFO - 'tpaint', 07:30:01 INFO - 'sessionrestore', 07:30:01 INFO - 'sessionrestore_no_auto_restore', 07:30:01 INFO - 'tabpaint']}, 07:30:01 INFO - 'other-e10s': {'tests': ['a11yr', 07:30:01 INFO - 'ts_paint', 07:30:01 INFO - 'tpaint', 07:30:01 INFO - 'sessionrestore', 07:30:01 INFO - 'sessionrestore_no_auto_restore', 07:30:01 INFO - 'tabpaint']}, 07:30:01 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:30:01 INFO - 'ts_paint', 07:30:01 INFO - 'tpaint', 07:30:01 INFO - 'sessionrestore', 07:30:01 INFO - 'sessionrestore_no_auto_restore', 07:30:01 INFO - 'tabpaint']}, 07:30:01 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:30:01 INFO - 'ts_paint', 07:30:01 INFO - 'tpaint', 07:30:01 INFO - 'sessionrestore', 07:30:01 INFO - 'sessionrestore_no_auto_restore', 07:30:01 INFO - 'tabpaint']}, 07:30:01 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:30:01 INFO - 'tests': ['a11yr', 07:30:01 INFO - 'ts_paint', 07:30:01 INFO - 'tpaint', 07:30:01 INFO - 'sessionrestore', 07:30:01 INFO - 'sessionrestore_no_auto_restore', 07:30:01 INFO - 'tabpaint']}, 07:30:01 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:30:01 INFO - 'tests': ['a11yr', 07:30:01 INFO - 'ts_paint', 07:30:01 INFO - 'tpaint', 07:30:01 INFO - 'sessionrestore', 07:30:01 INFO - 'sessionrestore_no_auto_restore', 07:30:01 INFO - 'tabpaint']}, 07:30:01 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:30:01 INFO - 'tests': ['tsvgx', 07:30:01 INFO - 'tsvgr_opacity', 07:30:01 INFO - 'tart', 07:30:01 INFO - 'tscrollx', 07:30:01 INFO - 'cart']}, 07:30:01 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:30:01 INFO - 'tsvgr_opacity', 07:30:01 INFO - 'tart', 07:30:01 INFO - 'tscrollx', 07:30:01 INFO - 'cart']}, 07:30:01 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:30:01 INFO - 'talos_options': ['--disable-e10s'], 07:30:01 INFO - 'tests': ['tp5o']}, 07:30:01 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:30:01 INFO - 'tests': ['tp5o']}, 07:30:01 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:30:01 INFO - 'talos_options': ['--disable-e10s', 07:30:01 INFO - '--xperf_path', 07:30:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:30:01 INFO - 'tests': ['tp5n']}, 07:30:01 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:30:01 INFO - 'talos_options': ['--xperf_path', 07:30:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:30:01 INFO - 'tests': ['tp5n']}}, 07:30:01 INFO - 'talos.zip': {'path': '', 07:30:01 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:30:01 INFO - Running post-action listener: _resource_record_post_action 07:30:01 INFO - [mozharness: 2016-10-11 14:30:01.060676Z] Finished populate-webroot step (success) 07:30:01 INFO - [mozharness: 2016-10-11 14:30:01.060764Z] Running create-virtualenv step. 07:30:01 INFO - Running pre-action listener: _resource_record_pre_action 07:30:01 INFO - Running main action method: create_virtualenv 07:30:01 INFO - Creating virtualenv /builds/slave/test/build/venv 07:30:01 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 07:30:01 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:30:01 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:30:01 INFO - Using real prefix '/usr' 07:30:01 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:30:01 INFO - Installing distribute.............................................................................................................................................................................................done. 07:30:03 INFO - Installing pip.................done. 07:30:03 INFO - Return code: 0 07:30:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 07:30:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 07:30:03 INFO - Reading from file tmpfile_stdout 07:30:03 INFO - Output received: 07:30:03 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) 07:30:03 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:30:03 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')]} 07:30:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:30:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:30:03 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')]} 07:30:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:30:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:30:03 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 0x7f215a21df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14527b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e1790>, '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 0x14e2690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14e2b20>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1476196183.950627-53494217', '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 07:30:03 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 07:30:03 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 07:30:03 INFO - Using env: {'DISPLAY': ':0', 07:30:03 INFO - 'HOME': '/home/cltbld', 07:30:03 INFO - 'LANG': 'en_US.UTF-8', 07:30:03 INFO - 'LANGUAGE': 'en_US:en', 07:30:03 INFO - 'LOGNAME': 'cltbld', 07:30:03 INFO - 'MAIL': '/var/mail/cltbld', 07:30:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:30:03 INFO - 'MOZ_NO_REMOTE': '1', 07:30:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:30:03 INFO - 'NO_EM_RESTART': '1', 07:30:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:30:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:30:03 INFO - 'PWD': '/builds/slave/test', 07:30:03 INFO - 'SHELL': '/bin/bash', 07:30:03 INFO - 'SHLVL': '1', 07:30:03 INFO - 'TERM': 'linux', 07:30:03 INFO - 'TMOUT': '86400', 07:30:03 INFO - 'USER': 'cltbld', 07:30:03 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1476196183.950627-53494217', 07:30:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:30:03 INFO - '_': '/tools/buildbot/bin/python'} 07:30:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:30:04 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 07:30:04 INFO - Cleaning up... 07:30:04 INFO - Return code: 0 07:30:04 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:30:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:30:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:30:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:30:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:30:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:30:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:30:04 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 0x7f215a21df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14527b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e1790>, '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 0x14e2690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14e2b20>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1476196183.950627-53494217', '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 07:30:04 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 07:30:04 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 07:30:04 INFO - Using env: {'DISPLAY': ':0', 07:30:04 INFO - 'HOME': '/home/cltbld', 07:30:04 INFO - 'LANG': 'en_US.UTF-8', 07:30:04 INFO - 'LANGUAGE': 'en_US:en', 07:30:04 INFO - 'LOGNAME': 'cltbld', 07:30:04 INFO - 'MAIL': '/var/mail/cltbld', 07:30:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:30:04 INFO - 'MOZ_NO_REMOTE': '1', 07:30:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:30:04 INFO - 'NO_EM_RESTART': '1', 07:30:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:30:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:30:04 INFO - 'PWD': '/builds/slave/test', 07:30:04 INFO - 'SHELL': '/bin/bash', 07:30:04 INFO - 'SHLVL': '1', 07:30:04 INFO - 'TERM': 'linux', 07:30:04 INFO - 'TMOUT': '86400', 07:30:04 INFO - 'USER': 'cltbld', 07:30:04 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1476196183.950627-53494217', 07:30:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:30:04 INFO - '_': '/tools/buildbot/bin/python'} 07:30:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:30:04 INFO - Downloading/unpacking psutil>=3.1.1 07:30:04 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 07:30:04 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 07:30:04 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 07:30:04 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 07:30:04 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 07:30:04 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 07:30:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:30:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:30:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:30:06 INFO - Installing collected packages: psutil 07:30:06 INFO - Running setup.py install for psutil 07:30:06 INFO - building 'psutil._psutil_linux' extension 07:30:06 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 07:30:06 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 07:30:06 INFO - building 'psutil._psutil_posix' extension 07:30:06 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 07:30:06 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 07:30:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:30:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:30:06 INFO - Successfully installed psutil 07:30:06 INFO - Cleaning up... 07:30:06 INFO - Return code: 0 07:30:06 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:30:06 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')]} 07:30:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:30:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:30:06 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')]} 07:30:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:30:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:30:06 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 0x7f215a21df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14527b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e1790>, '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 0x14e2690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14e2b20>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1476196183.950627-53494217', '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 07:30:06 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 07:30:06 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 07:30:06 INFO - Using env: {'DISPLAY': ':0', 07:30:06 INFO - 'HOME': '/home/cltbld', 07:30:06 INFO - 'LANG': 'en_US.UTF-8', 07:30:06 INFO - 'LANGUAGE': 'en_US:en', 07:30:06 INFO - 'LOGNAME': 'cltbld', 07:30:06 INFO - 'MAIL': '/var/mail/cltbld', 07:30:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:30:06 INFO - 'MOZ_NO_REMOTE': '1', 07:30:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:30:06 INFO - 'NO_EM_RESTART': '1', 07:30:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:30:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:30:06 INFO - 'PWD': '/builds/slave/test', 07:30:06 INFO - 'SHELL': '/bin/bash', 07:30:06 INFO - 'SHLVL': '1', 07:30:06 INFO - 'TERM': 'linux', 07:30:06 INFO - 'TMOUT': '86400', 07:30:06 INFO - 'USER': 'cltbld', 07:30:06 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1476196183.950627-53494217', 07:30:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:30:06 INFO - '_': '/tools/buildbot/bin/python'} 07:30:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:30:07 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:30:07 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 07:30:07 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 07:30:07 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 07:30:07 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 07:30:07 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 07:30:07 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 07:30:09 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:30:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:30:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:30:09 INFO - Installing collected packages: mozsystemmonitor 07:30:09 INFO - Running setup.py install for mozsystemmonitor 07:30:09 INFO - Successfully installed mozsystemmonitor 07:30:09 INFO - Cleaning up... 07:30:09 INFO - Return code: 0 07:30:09 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:30:09 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')]} 07:30:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:30:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:30:09 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')]} 07:30:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:30:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:30:09 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 0x7f215a21df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14527b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e1790>, '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 0x14e2690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14e2b20>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1476196183.950627-53494217', '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 07:30:09 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 07:30:09 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 07:30:09 INFO - Using env: {'DISPLAY': ':0', 07:30:09 INFO - 'HOME': '/home/cltbld', 07:30:09 INFO - 'LANG': 'en_US.UTF-8', 07:30:09 INFO - 'LANGUAGE': 'en_US:en', 07:30:09 INFO - 'LOGNAME': 'cltbld', 07:30:09 INFO - 'MAIL': '/var/mail/cltbld', 07:30:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:30:09 INFO - 'MOZ_NO_REMOTE': '1', 07:30:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:30:09 INFO - 'NO_EM_RESTART': '1', 07:30:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:30:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:30:09 INFO - 'PWD': '/builds/slave/test', 07:30:09 INFO - 'SHELL': '/bin/bash', 07:30:09 INFO - 'SHLVL': '1', 07:30:09 INFO - 'TERM': 'linux', 07:30:09 INFO - 'TMOUT': '86400', 07:30:09 INFO - 'USER': 'cltbld', 07:30:09 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1476196183.950627-53494217', 07:30:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:30:09 INFO - '_': '/tools/buildbot/bin/python'} 07:30:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:30:09 INFO - Downloading/unpacking jsonschema==2.5.1 07:30: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 07:30: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 07:30: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 07:30: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 07:30: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 07:30: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 07:30:11 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:30:11 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:30:11 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 07:30:11 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 07:30:11 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 07:30:11 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 07:30:11 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 07:30:11 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 07:30:11 INFO - Downloading functools32-3.2.3-2.tar.gz 07:30:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:30:11 INFO - warning: no files found matching '*.txt' 07:30:11 INFO - no previously-included directories found matching 'build' 07:30:11 INFO - no previously-included directories found matching 'dist' 07:30:11 INFO - no previously-included directories found matching '.git*' 07:30:11 INFO - Installing collected packages: jsonschema, functools32 07:30:11 INFO - Running setup.py install for functools32 07:30:11 INFO - warning: no files found matching '*.txt' 07:30:11 INFO - no previously-included directories found matching 'build' 07:30:11 INFO - no previously-included directories found matching 'dist' 07:30:11 INFO - no previously-included directories found matching '.git*' 07:30:11 INFO - Successfully installed jsonschema functools32 07:30:11 INFO - Cleaning up... 07:30:11 INFO - Return code: 0 07:30:11 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:30:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:30:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:30:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:30:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:30:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:30:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:30:11 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 0x7f215a21df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14527b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e1790>, '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 0x14e2690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14e2b20>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1476196183.950627-53494217', '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 07:30:11 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 07:30:11 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 07:30:11 INFO - Using env: {'DISPLAY': ':0', 07:30:11 INFO - 'HOME': '/home/cltbld', 07:30:11 INFO - 'LANG': 'en_US.UTF-8', 07:30:11 INFO - 'LANGUAGE': 'en_US:en', 07:30:11 INFO - 'LOGNAME': 'cltbld', 07:30:11 INFO - 'MAIL': '/var/mail/cltbld', 07:30:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:30:11 INFO - 'MOZ_NO_REMOTE': '1', 07:30:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:30:11 INFO - 'NO_EM_RESTART': '1', 07:30:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:30:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:30:11 INFO - 'PWD': '/builds/slave/test', 07:30:11 INFO - 'SHELL': '/bin/bash', 07:30:11 INFO - 'SHLVL': '1', 07:30:11 INFO - 'TERM': 'linux', 07:30:11 INFO - 'TMOUT': '86400', 07:30:11 INFO - 'USER': 'cltbld', 07:30:11 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1476196183.950627-53494217', 07:30:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:30:11 INFO - '_': '/tools/buildbot/bin/python'} 07:30:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:30:12 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:30:12 INFO - Cleaning up... 07:30:12 INFO - Return code: 0 07:30:12 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:30:12 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')]} 07:30:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:30:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:30:12 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')]} 07:30:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:30:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:30:12 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 0x7f215a21df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14527b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e1790>, '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 0x14e2690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14e2b20>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1476196183.950627-53494217', '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 07:30:12 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 07:30:12 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 07:30:12 INFO - Using env: {'DISPLAY': ':0', 07:30:12 INFO - 'HOME': '/home/cltbld', 07:30:12 INFO - 'LANG': 'en_US.UTF-8', 07:30:12 INFO - 'LANGUAGE': 'en_US:en', 07:30:12 INFO - 'LOGNAME': 'cltbld', 07:30:12 INFO - 'MAIL': '/var/mail/cltbld', 07:30:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:30:12 INFO - 'MOZ_NO_REMOTE': '1', 07:30:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:30:12 INFO - 'NO_EM_RESTART': '1', 07:30:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:30:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:30:12 INFO - 'PWD': '/builds/slave/test', 07:30:12 INFO - 'SHELL': '/bin/bash', 07:30:12 INFO - 'SHLVL': '1', 07:30:12 INFO - 'TERM': 'linux', 07:30:12 INFO - 'TMOUT': '86400', 07:30:12 INFO - 'USER': 'cltbld', 07:30:12 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1476196183.950627-53494217', 07:30:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:30:12 INFO - '_': '/tools/buildbot/bin/python'} 07:30:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:30:12 INFO - Downloading/unpacking blobuploader==1.2.4 07:30: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 07:30: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 07:30: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 07:30: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 07:30: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 07:30: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 07:30:14 INFO - Downloading blobuploader-1.2.4.tar.gz 07:30:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:30:14 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:30:14 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 07:30:14 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 07:30:14 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 07:30:14 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 07:30:14 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 07:30:14 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 07:30:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:30:14 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:30:14 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 07:30:14 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 07:30:14 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 07:30:14 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 07:30:14 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 07:30:14 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 07:30:14 INFO - Downloading docopt-0.6.1.tar.gz 07:30:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:30:15 INFO - Installing collected packages: blobuploader, requests, docopt 07:30:15 INFO - Running setup.py install for blobuploader 07:30:15 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:30:15 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:30:15 INFO - Running setup.py install for requests 07:30:15 INFO - Running setup.py install for docopt 07:30:15 INFO - Successfully installed blobuploader requests docopt 07:30:15 INFO - Cleaning up... 07:30:15 INFO - Return code: 0 07:30:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:30:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:30:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:30:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:30:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:30:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:30:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:30:15 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 0x7f215a21df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14527b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e1790>, '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 0x14e2690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14e2b20>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1476196183.950627-53494217', '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 07:30:15 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 07:30:15 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 07:30:15 INFO - Using env: {'DISPLAY': ':0', 07:30:15 INFO - 'HOME': '/home/cltbld', 07:30:15 INFO - 'LANG': 'en_US.UTF-8', 07:30:15 INFO - 'LANGUAGE': 'en_US:en', 07:30:15 INFO - 'LOGNAME': 'cltbld', 07:30:15 INFO - 'MAIL': '/var/mail/cltbld', 07:30:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:30:15 INFO - 'MOZ_NO_REMOTE': '1', 07:30:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:30:15 INFO - 'NO_EM_RESTART': '1', 07:30:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:30:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:30:15 INFO - 'PWD': '/builds/slave/test', 07:30:15 INFO - 'SHELL': '/bin/bash', 07:30:15 INFO - 'SHLVL': '1', 07:30:15 INFO - 'TERM': 'linux', 07:30:15 INFO - 'TMOUT': '86400', 07:30:15 INFO - 'USER': 'cltbld', 07:30:15 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1476196183.950627-53494217', 07:30:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:30:15 INFO - '_': '/tools/buildbot/bin/python'} 07:30:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:30:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:30:15 INFO - Running setup.py (path:/tmp/pip-jRBBAr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:30:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:30:15 INFO - Running setup.py (path:/tmp/pip-J1IEmi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:30:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:30:16 INFO - Running setup.py (path:/tmp/pip-D_3ie2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:30:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:30:16 INFO - Running setup.py (path:/tmp/pip-WAj__4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:30:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:30:16 INFO - Running setup.py (path:/tmp/pip-KKUewm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:30:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:30:16 INFO - Running setup.py (path:/tmp/pip-F65X5A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:30:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:30:16 INFO - Running setup.py (path:/tmp/pip-dXCbSV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:30:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:30:16 INFO - Running setup.py (path:/tmp/pip-uYQw72-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:30:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:30:16 INFO - Running setup.py (path:/tmp/pip-dChGxv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:30:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:30:16 INFO - Running setup.py (path:/tmp/pip-8lCPLJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:30:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:30:16 INFO - Running setup.py (path:/tmp/pip-Mm_f9y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:30:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:30:16 INFO - Running setup.py (path:/tmp/pip-1wCYFS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:30:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:30:16 INFO - Running setup.py (path:/tmp/pip-P6Cp54-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:30:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:30:16 INFO - Running setup.py (path:/tmp/pip-nR4DW5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:30:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:30:16 INFO - Running setup.py (path:/tmp/pip-wB4ljm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:30:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:30:16 INFO - Running setup.py (path:/tmp/pip-t_aPMn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:30:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:30:17 INFO - Running setup.py (path:/tmp/pip-N5nX_N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:30:17 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:30:17 INFO - Running setup.py install for manifestparser 07:30:17 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:30:17 INFO - Running setup.py install for mozcrash 07:30:17 INFO - Running setup.py install for mozdebug 07:30:17 INFO - Running setup.py install for mozdevice 07:30:17 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:30:17 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:30:17 INFO - Running setup.py install for mozfile 07:30:17 INFO - Running setup.py install for mozhttpd 07:30:17 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:30:17 INFO - Running setup.py install for mozinfo 07:30:17 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:30:17 INFO - Running setup.py install for mozInstall 07:30:17 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:30:17 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:30:17 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:30:17 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:30:17 INFO - Running setup.py install for mozleak 07:30:18 INFO - Running setup.py install for mozlog 07:30:18 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:30:18 INFO - Running setup.py install for moznetwork 07:30:18 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:30:18 INFO - Running setup.py install for mozprocess 07:30:18 INFO - Running setup.py install for mozprofile 07:30:18 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:30:18 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:30:18 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:30:18 INFO - Running setup.py install for mozrunner 07:30:18 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:30:18 INFO - Running setup.py install for mozscreenshot 07:30:18 INFO - Running setup.py install for moztest 07:30:18 INFO - Running setup.py install for mozversion 07:30:18 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:30:18 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:30:18 INFO - Cleaning up... 07:30:18 INFO - Return code: 0 07:30:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:30:18 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')]} 07:30:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:30:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:30:18 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')]} 07:30:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:30:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:30:18 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 0x7f215a21df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14527b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e1790>, '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 0x14e2690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14e2b20>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1476196183.950627-53494217', '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 07:30:18 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 07:30:18 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 07:30:18 INFO - Using env: {'DISPLAY': ':0', 07:30:18 INFO - 'HOME': '/home/cltbld', 07:30:18 INFO - 'LANG': 'en_US.UTF-8', 07:30:18 INFO - 'LANGUAGE': 'en_US:en', 07:30:18 INFO - 'LOGNAME': 'cltbld', 07:30:18 INFO - 'MAIL': '/var/mail/cltbld', 07:30:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:30:18 INFO - 'MOZ_NO_REMOTE': '1', 07:30:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:30:18 INFO - 'NO_EM_RESTART': '1', 07:30:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:30:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:30:18 INFO - 'PWD': '/builds/slave/test', 07:30:18 INFO - 'SHELL': '/bin/bash', 07:30:18 INFO - 'SHLVL': '1', 07:30:18 INFO - 'TERM': 'linux', 07:30:18 INFO - 'TMOUT': '86400', 07:30:18 INFO - 'USER': 'cltbld', 07:30:18 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1476196183.950627-53494217', 07:30:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:30:18 INFO - '_': '/tools/buildbot/bin/python'} 07:30:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:30:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:30:19 INFO - Running setup.py (path:/tmp/pip-30xM3B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:30:19 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)) 07:30:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:30:19 INFO - Running setup.py (path:/tmp/pip-hprz96-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:30:19 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)) 07:30:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:30:19 INFO - Running setup.py (path:/tmp/pip-tUUtw2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:30:19 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)) 07:30:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:30:19 INFO - Running setup.py (path:/tmp/pip-kQSQ8K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:30:19 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)) 07:30:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:30:19 INFO - Running setup.py (path:/tmp/pip-dp4oTb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:30:19 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)) 07:30:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:30:19 INFO - Running setup.py (path:/tmp/pip-moQZK8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:30:19 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)) 07:30:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:30:19 INFO - Running setup.py (path:/tmp/pip-S9Z0yS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:30:19 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)) 07:30:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:30:19 INFO - Running setup.py (path:/tmp/pip-9BTq2S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:30:19 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)) 07:30:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:30:19 INFO - Running setup.py (path:/tmp/pip-CY1Fal-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:30:19 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)) 07:30:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:30:19 INFO - Running setup.py (path:/tmp/pip-wxdncz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:30:19 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)) 07:30:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:30:19 INFO - Running setup.py (path:/tmp/pip-k3KhnH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:30:19 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)) 07:30:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:30:19 INFO - Running setup.py (path:/tmp/pip-BWVpMb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:30:20 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)) 07:30:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:30:20 INFO - Running setup.py (path:/tmp/pip-lvAnYU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:30:20 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)) 07:30:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:30:20 INFO - Running setup.py (path:/tmp/pip-QU02TB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:30:20 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)) 07:30:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:30:20 INFO - Running setup.py (path:/tmp/pip-crWyj2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:30:20 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)) 07:30:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:30:20 INFO - Running setup.py (path:/tmp/pip-a7rGnz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:30:20 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)) 07:30:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:30:20 INFO - Running setup.py (path:/tmp/pip-qQVjl1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:30:20 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)) 07:30:20 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)) 07:30:20 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)) 07:30:20 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)) 07:30:20 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)) 07:30:20 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)) 07:30:20 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:30:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:30:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:30:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:30:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:30:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:30:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:30:22 INFO - Downloading blessings-1.6.tar.gz 07:30:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:30:22 INFO - Installing collected packages: blessings 07:30:22 INFO - Running setup.py install for blessings 07:30:22 INFO - Successfully installed blessings 07:30:22 INFO - Cleaning up... 07:30:22 INFO - Return code: 0 07:30:22 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:30:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:30:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:30:22 INFO - Reading from file tmpfile_stdout 07:30:22 INFO - Current package versions: 07:30:22 INFO - argparse == 1.2.1 07:30:22 INFO - blessings == 1.6 07:30:22 INFO - blobuploader == 1.2.4 07:30:22 INFO - docopt == 0.6.1 07:30:22 INFO - functools32 == 3.2.3-2 07:30:22 INFO - jsonschema == 2.5.1 07:30:22 INFO - manifestparser == 1.1 07:30:22 INFO - mozInstall == 1.12 07:30:22 INFO - mozcrash == 0.17 07:30:22 INFO - mozdebug == 0.1 07:30:22 INFO - mozdevice == 0.48 07:30:22 INFO - mozfile == 1.2 07:30:22 INFO - mozhttpd == 0.7 07:30:22 INFO - mozinfo == 0.9 07:30:22 INFO - mozleak == 0.1 07:30:22 INFO - mozlog == 3.4 07:30:22 INFO - moznetwork == 0.27 07:30:22 INFO - mozprocess == 0.23 07:30:22 INFO - mozprofile == 0.28 07:30:22 INFO - mozrunner == 6.12 07:30:22 INFO - mozscreenshot == 0.1 07:30:22 INFO - mozsystemmonitor == 0.3 07:30:22 INFO - moztest == 0.7 07:30:22 INFO - mozversion == 1.4 07:30:22 INFO - psutil == 3.1.1 07:30:22 INFO - requests == 1.2.3 07:30:22 INFO - wsgiref == 0.1.2 07:30:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:30:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:30:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:30:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:30:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:30:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:30:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:30:22 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 0x7f215a21df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14527b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e1790>, '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 0x14e2690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14e2b20>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1476196183.950627-53494217', '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 07:30:22 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 07:30:22 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 07:30:22 INFO - Using env: {'DISPLAY': ':0', 07:30:22 INFO - 'HOME': '/home/cltbld', 07:30:22 INFO - 'LANG': 'en_US.UTF-8', 07:30:22 INFO - 'LANGUAGE': 'en_US:en', 07:30:22 INFO - 'LOGNAME': 'cltbld', 07:30:22 INFO - 'MAIL': '/var/mail/cltbld', 07:30:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:30:22 INFO - 'MOZ_NO_REMOTE': '1', 07:30:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:30:22 INFO - 'NO_EM_RESTART': '1', 07:30:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:30:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:30:22 INFO - 'PWD': '/builds/slave/test', 07:30:22 INFO - 'SHELL': '/bin/bash', 07:30:22 INFO - 'SHLVL': '1', 07:30:22 INFO - 'TERM': 'linux', 07:30:22 INFO - 'TMOUT': '86400', 07:30:22 INFO - 'USER': 'cltbld', 07:30:22 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1476196183.950627-53494217', 07:30:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:30:22 INFO - '_': '/tools/buildbot/bin/python'} 07:30:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:30:23 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)) 07:30:23 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)) 07:30:23 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)) 07:30:23 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)) 07:30:23 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)) 07:30:23 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)) 07:30:23 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)) 07:30:23 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)) 07:30:23 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)) 07:30:23 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)) 07:30:23 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)) 07:30:23 INFO - Cleaning up... 07:30:23 INFO - Return code: 0 07:30:23 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:30:23 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')]} 07:30:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:30:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:30:23 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')]} 07:30:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:30:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:30:23 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 0x7f215a21df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14527b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e1790>, '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 0x14e2690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14e2b20>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1476196183.950627-53494217', '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 07:30:23 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 07:30:23 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 07:30:23 INFO - Using env: {'DISPLAY': ':0', 07:30:23 INFO - 'HOME': '/home/cltbld', 07:30:23 INFO - 'LANG': 'en_US.UTF-8', 07:30:23 INFO - 'LANGUAGE': 'en_US:en', 07:30:23 INFO - 'LOGNAME': 'cltbld', 07:30:23 INFO - 'MAIL': '/var/mail/cltbld', 07:30:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:30:23 INFO - 'MOZ_NO_REMOTE': '1', 07:30:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:30:23 INFO - 'NO_EM_RESTART': '1', 07:30:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:30:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:30:23 INFO - 'PWD': '/builds/slave/test', 07:30:23 INFO - 'SHELL': '/bin/bash', 07:30:23 INFO - 'SHLVL': '1', 07:30:23 INFO - 'TERM': 'linux', 07:30:23 INFO - 'TMOUT': '86400', 07:30:23 INFO - 'USER': 'cltbld', 07:30:23 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1476196183.950627-53494217', 07:30:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:30:23 INFO - '_': '/tools/buildbot/bin/python'} 07:30:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:30:23 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:30:23 INFO - Cleaning up... 07:30:23 INFO - Return code: 0 07:30:23 INFO - Running post-action listener: _resource_record_post_action 07:30:23 INFO - Running post-action listener: _start_resource_monitoring 07:30:23 INFO - Starting resource monitoring. 07:30:23 INFO - [mozharness: 2016-10-11 14:30:23.485429Z] Finished create-virtualenv step (success) 07:30:23 INFO - [mozharness: 2016-10-11 14:30:23.485946Z] Running install step. 07:30:23 INFO - Running pre-action listener: _resource_record_pre_action 07:30:23 INFO - Running main action method: install 07:30:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:30:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:30:23 INFO - Reading from file tmpfile_stdout 07:30:23 INFO - Detecting whether we're running mozinstall >=1.0... 07:30:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:30:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:30:23 INFO - Reading from file tmpfile_stdout 07:30:23 INFO - Output received: 07:30:23 INFO - Usage: mozinstall [options] installer 07:30:23 INFO - Options: 07:30:23 INFO - -h, --help show this help message and exit 07:30:23 INFO - -d DEST, --destination=DEST 07:30:23 INFO - Directory to install application into. [default: 07:30:23 INFO - "/builds/slave/test"] 07:30:23 INFO - --app=APP Application being installed. [default: firefox] 07:30:23 INFO - mkdir: /builds/slave/test/build/application 07:30:23 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'] 07:30:23 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 07:30:40 INFO - Reading from file tmpfile_stdout 07:30:40 INFO - Output received: 07:30:40 INFO - /builds/slave/test/build/application/firefox/firefox 07:30:40 INFO - Running post-action listener: _resource_record_post_action 07:30:40 INFO - [mozharness: 2016-10-11 14:30:40.814441Z] Finished install step (success) 07:30:40 INFO - [mozharness: 2016-10-11 14:30:40.814686Z] Running run-tests step. 07:30:40 INFO - Running pre-action listener: _resource_record_pre_action 07:30:40 INFO - Running main action method: run_tests 07:30:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:30:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:30:40 INFO - Python 2.7.3 07:30:40 INFO - Return code: 0 07:30:40 INFO - grabbing minidump binary from tooltool 07:30:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:30:40 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 0x14e1790>, '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 0x14e2690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14e2b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:30:40 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 07:30:40 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 07:30:40 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 07:30:40 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:30:40 INFO - Return code: 0 07:30:40 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:30:40 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:30:40 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:30:40 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:30:40 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:30:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Z9LOcrN6R7eCPFycCeIPMA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-033', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 07:30:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Z9LOcrN6R7eCPFycCeIPMA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-033 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 07:30:40 INFO - Using env: {'DISPLAY': ':0', 07:30:40 INFO - 'HOME': '/home/cltbld', 07:30:40 INFO - 'LANG': 'en_US.UTF-8', 07:30:40 INFO - 'LANGUAGE': 'en_US:en', 07:30:40 INFO - 'LOGNAME': 'cltbld', 07:30:40 INFO - 'MAIL': '/var/mail/cltbld', 07:30:40 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:30:40 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:30:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:30:40 INFO - 'MOZ_NO_REMOTE': '1', 07:30:40 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:30:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:30:40 INFO - 'NO_EM_RESTART': '1', 07:30:40 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:30:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:30:40 INFO - 'PWD': '/builds/slave/test', 07:30:40 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:30:40 INFO - 'SHELL': '/bin/bash', 07:30:40 INFO - 'SHLVL': '1', 07:30:40 INFO - 'TERM': 'linux', 07:30:40 INFO - 'TMOUT': '86400', 07:30:40 INFO - 'USER': 'cltbld', 07:30:40 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1476196183.950627-53494217', 07:30:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:30:40 INFO - '_': '/tools/buildbot/bin/python'} 07:30:40 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Z9LOcrN6R7eCPFycCeIPMA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-033', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 07:30:41 INFO - mozversion application_buildid: 20161011043001 07:30:41 INFO - mozversion application_changeset: 7ae377917236b7e6111146aa9fb4c073c0efc7f4 07:30:41 INFO - mozversion application_display_name: Nightly 07:30:41 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:30:41 INFO - mozversion application_name: Firefox 07:30:41 INFO - mozversion application_remotingname: firefox 07:30:41 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 07:30:41 INFO - mozversion application_vendor: Mozilla 07:30:41 INFO - mozversion application_version: 52.0a1 07:30:41 INFO - mozversion platform_buildid: 20161011043001 07:30:41 INFO - mozversion platform_changeset: 7ae377917236b7e6111146aa9fb4c073c0efc7f4 07:30:41 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 07:30:41 INFO - mozversion platform_version: 52.0a1 07:30:41 INFO - using testdate: 1476196241 07:30:41 INFO - actual date: 1476196241 07:30:41 INFO - starting webserver on 'localhost:56906' 07:30:41 INFO - SUITE-START | Running 2 tests 07:30:41 INFO - TEST-START | dromaeo_css 07:30:41 INFO - operating with platform_type : linux_ 07:30:41 INFO - Initialising browser for dromaeo_css test... 07:30:41 INFO - TEST-INFO | started process 19165 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMy_9zr/profile http://localhost:56906/getInfo.html) 07:30:46 INFO - PROCESS | 19165 | __metrics Screen width/height:1600/1200 07:30:46 INFO - PROCESS | 19165 | colorDepth:24 07:30:46 INFO - PROCESS | 19165 | Browser inner width/height: 1024/697 07:30:46 INFO - PROCESS | 19165 | __metrics 07:30:47 ERROR - PROCESS | 19165 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3083: TypeError: this.tabs is undefined 07:30:48 INFO - TEST-INFO | 19165: exit 0 07:30:48 INFO - Browser initialized. 07:30:48 INFO - Running cycle 1/1 for dromaeo_css test... 07:30:48 INFO - TEST-INFO | started process 19290 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMy_9zr/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:31:00 INFO - PROCESS | 19290 | RSS: Main: 185008128 07:31:00 INFO - PROCESS | 19290 | 07:31:49 INFO - PROCESS | 19290 | 1476196309836 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] 07:34:01 INFO - PROCESS | 19290 | Cycle 1(1): loaded http://localhost:56906/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56906/tests/dromaeo/cssquery-ext.html) 07:34:02 INFO - PROCESS | 19290 | RSS: Main: 199720960 07:34:02 INFO - PROCESS | 19290 | 07:37:04 INFO - PROCESS | 19290 | Cycle 1(1): loaded http://localhost:56906/tests/dromaeo/cssquery-ext.html (next: http://localhost:56906/tests/dromaeo/cssquery-jquery.html) 07:37:05 INFO - PROCESS | 19290 | RSS: Main: 198483968 07:37:05 INFO - PROCESS | 19290 | 07:40:07 INFO - PROCESS | 19290 | Cycle 1(1): loaded http://localhost:56906/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56906/tests/dromaeo/cssquery-mootools.html) 07:40:07 INFO - PROCESS | 19290 | RSS: Main: 199536640 07:40:07 INFO - PROCESS | 19290 | 07:43:09 INFO - PROCESS | 19290 | Cycle 1(1): loaded http://localhost:56906/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56906/tests/dromaeo/cssquery-prototype.html) 07:43:10 INFO - PROCESS | 19290 | RSS: Main: 194437120 07:43:10 INFO - PROCESS | 19290 | 07:46:12 INFO - PROCESS | 19290 | Cycle 1(1): loaded http://localhost:56906/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56906/tests/dromaeo/cssquery-yui.html) 07:46:13 INFO - PROCESS | 19290 | RSS: Main: 198184960 07:46:13 INFO - PROCESS | 19290 | 07:49:16 INFO - PROCESS | 19290 | Cycle 1(1): loaded http://localhost:56906/tests/dromaeo/cssquery-yui.html (next: http://localhost:56906/tests/dromaeo/cssquery-dojo.html) 07:49:16 INFO - PROCESS | 19290 | RSS: Main: 199372800 07:49:16 INFO - PROCESS | 19290 | 07:49:16 INFO - PROCESS | 19290 | __start_tp_report 07:49:16 INFO - PROCESS | 19290 | _x_x_mozilla_page_load 07:49:16 INFO - PROCESS | 19290 | _x_x_mozilla_page_load_details 07:49:16 INFO - PROCESS | 19290 | |i|pagename|runs| 07:49:16 INFO - PROCESS | 19290 | |0;dojo.html;3067.2791893904914;3067.4018566379555;3075.015994881638;3076.4308602908463;3092.3969825883946;5334.706591137486;5388.595855310853;5395.352557693082;5434.646747961379;5535.972320138404;5359.5712343012565;5368.32895888014;5411.945880541193;5507.669539827613;5514.035043867328;4844.903101937959;4873.731944743037;4943.416920085743;4952.603791696655;4953.702777833341;4986.725730084844;5050.520200580957;5104.157813960692;5116.565091967187;5139.254808052849;4706.435227772655;4741.668083234175;4972.651914365996;5006.349174607314;5043.36957880265;4766.998930224657;4789.95210047902;4812.711237325771;4842.903141937177;4857.441394239672;4798.7840547175465;4817.060673168733;4821.783019764119;4837.516248375169;4864.927026094611;5152.252923326134;5266.131088370415;5285.497877701612;5305.1776974569;5355.98236335095;5607.635503692288;5616.382197958222;5651.0675738503505;5655.208270842086;5720.942790572082;5690.630109042899;5712.000399929995;5722.055860782966;5789.797357092481;5802.82591522255;5381.4349493303425;5395.433479484597;5396.028714831329;5398.676079435247;5444;5709.486146246858;5768.7980920668415;5803.042497987784;5813.767449302065;5843.766249350064;5510.366307874646;5541.113421852484;5568;5570.3315602128005;5574.498295153456;5521.089020311684;5652.74562644682;5670.829875103754;5685;5687.9431205687415;5594.9720251398485;5636.070048442043;5645.858853528694;5646.830595082154;5732.16883551891;5660.094384898396;5667.093265077568;5681.261436013292;5681.886362272731;5684.573656975744;4346.9347959780625;4379.912401751947;4387.583179597933;4392.121575684876;4439.067795762926;3923.097687531884;3924.6860251179837;3929.626685464876;3937.7637341759587;3966.5835087315995;5487.5884308677005;5539.41836107211;5542.584306177053;5547;5590.329160500684;5791.436312195768;5826.359100498942;5839.9124013139835;5840.3575606683235;5868.23712917318;5290.735463226823;5301.310829592128;5312.282841816383;5425.159100339453;5502.0921547944945;4912.533309335608;4918.458969513351;4922.827701030446;4959.132151873408;4978.0292842896015;5833.154192642128;5859.472647461664;5859.912101318484;5862.706864656835;5862.970685146547;5531.8893622128135;5594.608377413542;5624.690642014729;5636.239107720406;5707.714614269353;5960.5827592068135;5980.611260268069;5984.970075149597;6048.395160484092;6058.303295121117;5629.240052593012;5712.6001179917;5720.3421606515785;5725.255716756795;5738.512226460798;5526.668399896019;5591.04952158126;5746;5790.623609465371;5820.73806678692;5466.535344495763;5504.889902201853;5516.255305533701;5524.14375771756;5616.38219795814;5519.69641669712;5521.171824226398;5529.502344788988;5539.279893613804;5557.5553955682635;5500.779968801203;5514.338279406497;5521.585881059017;5522.641028333145;5542.861428464321;5662.8301150965535;5697.487226149667;5714.971425142848;5770.0190967536455;5777.45114214149;5519.779208831602;5554.2779438672715;5555.805546805843;5574.665520068809;5587.776488940397 07:49:16 INFO - PROCESS | 19290 | |1;ext.html;572.0760971031783;576.3919065386019;586.7242396073843;595.9314678811938;603.7381871887753;38078.23843523132;42583.574164258345;42716;42740.358894616606;42858.571414285885;41714;42064.57935420645;42104.368519462834;42224.78887605565;42233.155336893244;8589.484630922134;8745.912540874573;8767.342449316295;8776.122387761237;8812.779680507974;8661.350398720122;8743.95628021859;8746.650133994632;8761.649534018663;8780.868286975701;8674.262687671555;8779.692710755126;8806.559672016405;8828.382013259074;8864.911350886505;8652.567371631425;8744.825103497926;8752.081031491698;8755.474671519729;8755.562221888944;8654.091320411391;8689.956550217272;8714.389992700513;8758.167974042455;8786.64853405863;39784.60215397867;40105.79947100246;40163.7991810042;40518.18963620711;40550.39174412386;3331.3670402623425;3522.6829585337186;3522.7181825453904;3568.4290513517712;3577.409727394977;30608;30793.538096928565;30799.384012319853;30834.383312333626;31082.22294442657;3849.8075096245075;4044.2315959967805;4160.646345060673;4217.97891010546;4301.333293339538;351676;355016;355108;355182;357514;53699.73150134224;54387;54399.45600543944;54406;54425.45574544283;58255.70872145612;58846.41153588495;58850.705746470994;59170.70414647985;59276;15415.460458883885;15508.689826203412;15561;15583.688326233638;15599.610009749847;12384.690382740504;12469.064820138527;12477.376131193585;12513;12565.18326308787;15725.921370393304;15904.204789760697;15991.200439977954;16002.919985399998;16582.668346633;5820.88358232833;5912.3496415394275;5970.194023806731;6027.876816891211;6046.909296360558;918.4489306416231;990.4255531791543;1001.6694490818013;1018.5721996761378;1104.845321654969;30885.845570772002;31483.212919677193;31595;31672;32106.35787284288;944.244604316544;1088.4938503595865;1100.3287994323457;1150.286822170243;1234.660468371205;14915;16376.181190940406;16553.751693724604;16755.41356052532;17015.23431445588;496236;504255;510988;511654;760310;55877.44122558722;56700.43299567034;56811.71594142003;56829.71585142048;56834.14748778772;1319.366703982094;1334.426196735413;1337.3513845784787;1354.9661258468618;1358.898082643786;29528.704712952596;31323.373532528767;31395.215119622193;31718;32224.355512889142;49146;49481.752591236815;49816;50102;50186.247206291206;390683;393079;394334;394494;394852;27091.458170836868;27094;27423.177304680892;27439.176824695292;28153;43323.35014974841;43849.780751097314;44149.779251104825;45263.09473810571;47234.29148562706;38048.239035219696;39117.022074447224;39319.41020884746;39549.40675889922;40350.1929961405;38290.80854595821;39172;39795.60204397919;40590.79704601458;40710.1857962845;39420;40680.79659601683;41003.66952296183;41173;43226;30168.24579385533;34474.482882756274;35515.82242088773;36207.818960905024;36304.63695363013;27439.862800685867;27916.720832791412;28028.57957130604;28109.71890281071;28161.57757633596 07:49:16 INFO - PROCESS | 19290 | |2;jquery.html;398.08639173097737;399.42283400486275;406.1896516449683;412.6410023279746;417.4635593262656;14980.550583482485;17881.64236715265;18769.530761730963;19564.706529402054;19712;18244.543886402847;18356.35752748654;19629;19662.410127696156;19824.70262946057;5481.808136715225;5490.725463726818;5613.943860561403;5678.205051292823;5683.687397193153;5515.09001014832;5573.191887176357;5579.553635709154;5594.0769772987405;5595.664260144384;5418.268533747933;5643.520300774439;5663.122216056518;5669.9433005670035;5676.290463692038;5390.6226564140525;5588.972055139699;5603.2715746953045;5634;5651.660900345972;4955.851324460272;4995.075910956485;5005.724685142316;5017.54842064216;5030.84907452777;22704.88647556768;23089.76910230893;23335;23575.292741217792;23613.409664758346;2205.878676672782;2376.988115059431;2393.9281821545383;2431.0761910474084;2432.1487479382254;14383.568492945124;14683.48607798722;15064.548063558112;15160;15262.084274943429;1841.484384372378;1877.3804644467293;1925.913333899978;1954.1499447740277;1981.73246611707;83405;85938.5703071487;86205.56897215536;88097.55951220203;88650;10850.737392364697;11137.164712646583;11171.16216283782;11259.718507037389;12264.938675306745;13894.791578126336;16016.279267432994;16072.517824465285;16092.67814643724;16134.193290335672;7169.749058783022;7662.310392064741;7996.24035716606;8044.155363686846;8111.95944020288;7779.649915753805;7845.921540784633;8055.516668999879;8112.837743245102;8120.066192387832;4806.8077276909235;4842.903141937141;4875.7074575525585;4886.853394398174;5002.949970500321;1928.7299778031088;1999.3701983875033;2026.1591439552421;2073.8340932725346;2077.574097310048;904.9547522623842;938.591712605019;994.1847684898314;1006.2503434941016;1006.884208316053;18134.279858021404;19784.60430791376;19938.800611993986;20005.499862503264;20031.298904538562;990.0594435286507;1008.1128606825946;1008.9445080520495;1046.2048842879467;1081.194510089988;10388.37669739803;11013.163023597346;11027.338359698284;11141.275817071864;11157.493738345382;434202;444971;469673;470383;472046;92075;93433;93731;94126;95204;965.1940629574384;981.3719219699398;995.5520015992832;1000.7147962830559;1026.6663334416344;16560.420385286456;16600.169991500134;17616.383426580007;17758.11209439549;17992.190351433954;41732.58267417408;41871.79064104782;42744.35883461813;43513;43796.56203438052;59703.402965969784;60173.39826601678;60396.39603603908;61166.69416652888;62523.6873815628;7514.624268786648;7855.960720196363;7935.920640793749;8213.589320534069;8747.956260218658;12810.935945320214;13461.259630720404;13511.594652160451;13881.930590346983;13985.300734963415;11585.246958947642;11721.12091593117;11843.28940263587;12005.219660722025;12109.939450302692;11294.887051129384;11331.32012079278;11369;11456.541738330707;12200.084993625336;11335;11359.602413915472;11560.826587601361;11605.76788464243;12124.151309408257;7796;7918.287354138155;8057.758267251992;8114.107448180577;8424.157584241526;10038.053075334967;11511.19421640477;11644.475998580254;11832.585859494877;11945.104117191418 07:49:16 INFO - PROCESS | 19290 | |3;mootools.html;1470.6617477980064;1474.6313421644588;1607.4695350534325;1714.7942246930354;1729.8097209306975;7843.529388236696;8186.631601577928;8591.226789588936;9171.449713017224;9269.721908342744;8647.092055334178;8953.104689531043;8976.730698079067;9253.120953509422;9257.722268331943;2312.8843557822124;2360.5632957902844;2370.146747171017;2373.1100837186054;2390.497995420964;2290.7480177180496;2330.9650355244685;2334.9182778602753;2335.3577766114367;2342.2973108067595;2277.7152855893014;2291.0034135151263;2305.5043165719367;2326.7086766844395;2331.2889568681544;2275.5676421479866;2282.440802003503;2292.518571100071;2293.8623682579014;2305.0664480885266;2270.2394697776263;2277.5331057133412;2292.403974966504;2297.184499502686;2337.742848286687;9089.454632722058;9109.18017378439;9246.768830779218;9247.075292470767;9259.351845370828;5160.767765450564;5282.471752824726;5290.153575427913;5297.390800058004;5301.151815709468;3270.787398819093;3377.666874610106;3491.4064609016527;3524.207053412987;3577.588577313616;1112.2936935046305;1164.3363282928733;1169.4094482286475;1190.9404529773476;1191.487660306068;12875.67810804728;12877.742445151045;12881.098323117385;12901.483940642363;12940.35298235094;4700.55344742249;4738.597219236334;4777.314103033395;4852.369192005087;4884.7069175849565;10645.84031239532;10652.62715804943;10673.35959842412;10676.62631807883;10688.732781680521;5317.308749862493;5320.308359913187;5320.654157479751;5327.733613319396;5357.919631205457;4214.620684138442;4343.19650864591;4692.7653617319;4799.248274379896;4868.075065737569;3883.9611603884164;4044.9797751011056;4123.340265557496;4128.649064829463;4170.541240463546;1314.723907979335;1320.795276732108;1328.8272524571744;1343.368616750126;1344.5764584155959;909.9044600317004;920.4707293306376;929.4794914847707;933.9999999999864;953.2945620241111;5535.446455354432;6027.517798576104;6113.510919126459;6162.168107305546;6375.171227740457;927.5547737086237;947.696737044153;950.3300173377752;963.4845357733578;988.4859872866214;3748.4564738113368;3964.900877478086;3993.9001524961527;4049.7570145791346;4075.2257071156387;11235.157363197794;11518.53925842957;11522.827157592643;11537.538498460135;11565.19043666952;11306.491207895664;11365.204435689588;11386.658400248005;11494.942525287488;11502.654920352403;7942.285194332538;8317.584120793936;8325;8416.452930559493;8471.788205294793;6000.679850433073;6097.298810636834;6350.364963503613;6377.107204991397;6420.6789660517725;10142.645007424704;10340.638077667245;10517.10604598587;10621;10668.30656007357;10255.7436064099;10450.738731531468;10526.947365263124;10576.947115264375;10680.198985075995;7174.713011479483;7396.445266604918;7840.490368126054;7937.2459616336355;7956.880646790419;8677;8814.691485797966;8818.07410221943;8825.117488251124;8887.73336799897;7712.845743084995;7729;7901.249381308767;8025.03699556057;8045.477043992122;7504.362129219077;7641.1212710539;7654.578998155155;7706.807329816799;7725.845483090419;7237.131544214728;7404.074490688664;7410.147832999059;7430.3684186842565;7445.143808461879;5144.356955380577;5238.633295669419;5340.893182136413;5397.649152805055;5504.559635229252;5263.210518422115;5289.100852855101;5367.624266301322;5380;5510.752016159363 07:49:16 INFO - PROCESS | 19290 | |4;prototype.html;334.24127231185213;338.1242581713363;349.8250874562719;350.5968136642862;351.39033776397963;5291.1798671205925;5453.127499600065;5483.780648774049;5553.555715542757;5578.191162281471;5299.443558426367;5369.677819330843;5380.515753582177;5435.157550579656;5446.7276636168135;4266.594673506028;4276.893077673068;4280.550542193072;4282.807273672693;4315.913681726363;4214.894627634303;4278.2940814765525;4313.374560688699;4328;4329.1558146161515;4259.659227261812;4303.24693178694;4310.07333423314;4314.072474418;4314.460692413449;4249.490061192661;4253.1706317268145;4275.722078064916;4276.315789473685;4286.121345124242;3701.444783282529;3861.942070868939;3863.729538932276;3876.4379165020914;3877.282702699981;5273.472652734734;5294.470552944713;5298.549623282026;5345.572354211693;5350.30446042016;4944.33251511045;4946.183879659852;4956.058348913695;4959;4964.865108003557;5457.508824205841;5679.943200567983;5680.857978550528;5685.8009969651275;5721.170430287585;4128.710990230685;4131.586841315874;4141.6065473779945;4154;4165.812538435747;5919.644821310735;5921.940780592182;5953.732082056318;5958.493528050164;5982.880342393171;4186.937195942063;4247.405363249148;4254.42565253693;4285.5358169052915;4299.505556860939;4260.573942605776;4265.957340426556;4283.164782867373;4283.593058659422;4311.8490852820005;4908.754562271872;4924.507549245119;4928.20120655958;4929.137400954819;4961.70229786214;5654.971725141348;5786.189933409326;5814.215080964016;5818.243628328375;5834.620749651259;1485.18314926792;1497.2513743128436;1498.116111494202;1499.475183685723;1507.6457032597332;927.3832901120679;963.9589243616877;970.8932017478072;981.9149839427473;995.9542480395555;4740.5733483986605;4772.427308722906;4811.711297322172;4821.9035619287415;4852.830150944771;5144.9742751286;5158.561522270574;5193.5585475234275;5222.328854766438;5270.077736396115;4607.9308810367875;4828.517148285214;4834.709917404967;4878.682885612424;4905.2151655734915;2736.233854520737;2751.284665986858;2769.62610047645;2813.9598790876453;2820.4782115308735;5305.920411193835;5345.358556973188;5387.730613469389;5402.324709411324;5409.702466364309;5241.895162096813;5306.575473962073;5604.243427137366;5995.250593675791;6047.606905551125;6103.314541601681;6121.816345509642;6152.16945712332;6161.537884658579;6199.163112979871;5627.212190293444;5898.380670029756;5903.881922361615;5926.703664816828;5939.138824870456;5835.824925252249;5838.963738855856;5878.823635290948;5897.823065308047;5899.911501327398;6119.479844213113;6176.876462470816;6188.288346840171;6208.578654324727;6222.377762223922;3984.362501999666;4101.569335219879;4183.372494125905;4210.894727631834;4225.492940847118;5765.509931655689;5813.6221145625395;5870.917768171744;5885.205497257986;5906;5541.833744987657;5741.971290143522;5762.971185144047;5766.481016708516;5768.798092066925;5612.849365879903;5631.408702086222;5645.471580262336;5650.26546548946;5673;5683.857903552279;5701.287339082614;5717.714114294352;5735.426457354231;5739.311282646109;5519.806806761744;5675.177099320493;5677.205191273142;5731.8567035824435;5733.541316694738;5648.5763567731765;5673.971630141988;5684.63049901755;5709.68596727184;5713.257276554022 07:49:16 INFO - PROCESS | 19290 | |5;yui.html;743.2084829656419;748.6743266678993;791.1613689489142;831.2477208126647;834.5660256666533;15395.307211175495;15642.765358519631;15740.921295393535;15885.84114158858;15994.920025399872;14989.400423983028;15237.69524609507;15268.312925918333;15298.617534561641;15314.846851531482;783.7021931665973;801.1747899663327;803.4335793265734;805.569020573993;806.6289506826866;790.1387487638473;793.6507936507946;795.5028107432854;796.2873228460525;797.972070977516;849.3587341557115;850.421713235;850.5704619167312;851.0128251228576;851.7572491839827;839.3746658739278;839.7270886961732;841.2134654098408;841.4488510025943;841.9452735572169;598.2940130645836;621.9720112594944;623.8627501949609;624.4192900602438;625.9843503912439;12734.80897786534;12850.614481565568;12892.935535322356;12921.095523313372;12959.028072894476;12944.805827912589;13116.213027218397;13220.735585288241;13223.338833058404;13357.66605834862;11333.716657083556;11606.187566870323;11756.23584467007;11884.346360950145;11909.821352679717;4397.164538737662;4425.424694789656;4432.889177770581;4668.299755036738;4673.509281525459;75404.24595754081;76512;77019.22980770176;77100.61449692772;79289.60355198245;10997.780044399067;11055;11055.834162487568;11387.886121138848;11389.601363952223;19881.60236795256;19897.900510497355;19909.303174388828;19923.402297931087;19974.50063748389;7711.730089446843;8041.276285134366;8259.21537453941;8309;8638.265747411415;4422.823087076546;4545.454545454567;4571.9085618287445;4606.516315786794;4669.182892993713;3464.9133771655406;3588.6052534221217;3589.4974703541525;3590;3595.802230877327;631.88626047311;660.8777376185325;667.6995352091578;681.2131987554383;722.9566226026456;717.3543810570528;724.4457989637931;734.2217249715319;750.4784174998324;757.4205732614444;9766.755831104138;10190.89177800763;10210.540525676362;10785.83821242682;10858.185636077167;603.2399177036878;661.0678942690782;707.6461769115442;714.125196634119;776.4991580430591;4620.283856002325;5058.747062646853;5155.922661160085;5171.456997015259;5205.167173252262;94390.52804735933;96491.90343110492;98813;111165;130804;94389;94444.52777736068;94491.52754236184;94625;97029.51485242529;53796.73101634467;65899.34100659029;72671;77305.61347193229;81296;9436.764080898032;10100.949495252476;10205.864877145059;10219.335743176669;10505.68482945513;49935;50276.748616256686;50405.49594504155;50812.74593627008;51900.22149667682;68871;69408;72586;75903.24096758962;76970.61514692391;12517.248965062125;12571.245725256147;13222.801657974946;13293.20240785556;13378;14688.77966830477;14703.03115099767;14855.331510081856;15172.620684482976;15352.769708454158;14303.213323266904;14370.3533341002;14424.206668632905;14558.781618275523;15088.321025553656;13364;13859.445622175;14014.882621883162;14326.426942922166;14352.784708229176;13159.210447373189;13488.93255533716;13679.726405471636;13710.451581936612;13801.723965520834;10500.632477863544;10564;10590.205734569783;11004.944975275072;11257.887421125684;11566.966913048142;11852.70368240801;12134.75730485403;12178.45196966121;12373.195742276723 07:49:16 INFO - PROCESS | 19290 | __end_tp_report 07:49:16 INFO - PROCESS | 19290 | __start_cc_report 07:49:16 INFO - PROCESS | 19290 | _x_x_mozilla_cycle_collect,315 07:49:16 INFO - PROCESS | 19290 | __end_cc_report 07:49:16 INFO - PROCESS | 19290 | __startTimestamp1476197356413__endTimestamp 07:49:16 INFO - PROCESS | 19290 | 07:49:16 INFO - PROCESS | 19290 | ------- Summary: start ------- 07:49:16 INFO - PROCESS | 19290 | Number of tests: 6 07:49:16 INFO - PROCESS | 19290 | 07:49:16 INFO - PROCESS | 19290 | [#0] dojo.html Cycles:165 Average:5320.72 Median:5524.14 stddev:596.93 (10.8%) stddev-sans-first:571.98 07:49:16 INFO - PROCESS | 19290 | Values: 3067.3 3067.4 3075.0 3076.4 3092.4 5334.7 5388.6 5395.4 5434.6 5536.0 5359.6 5368.3 5411.9 5507.7 5514.0 4844.9 4873.7 4943.4 4952.6 4953.7 4986.7 5050.5 5104.2 5116.6 5139.3 4706.4 4741.7 4972.7 5006.3 5043.4 4767.0 4790.0 4812.7 4842.9 4857.4 4798.8 4817.1 4821.8 4837.5 4864.9 5152.3 5266.1 5285.5 5305.2 5356.0 5607.6 5616.4 5651.1 5655.2 5720.9 5690.6 5712.0 5722.1 5789.8 5802.8 5381.4 5395.4 5396.0 5398.7 5444.0 5709.5 5768.8 5803.0 5813.8 5843.8 5510.4 5541.1 5568.0 5570.3 5574.5 5521.1 5652.7 5670.8 5685.0 5687.9 5595.0 5636.1 5645.9 5646.8 5732.2 5660.1 5667.1 5681.3 5681.9 5684.6 4346.9 4379.9 4387.6 4392.1 4439.1 3923.1 3924.7 3929.6 3937.8 3966.6 5487.6 5539.4 5542.6 5547.0 5590.3 5791.4 5826.4 5839.9 5840.4 5868.2 5290.7 5301.3 5312.3 5425.2 5502.1 4912.5 4918.5 4922.8 4959.1 4978.0 5833.2 5859.5 5859.9 5862.7 5863.0 5531.9 5594.6 5624.7 5636.2 5707.7 5960.6 5980.6 5985.0 6048.4 6058.3 5629.2 5712.6 5720.3 5725.3 5738.5 5526.7 5591.0 5746.0 5790.6 5820.7 5466.5 5504.9 5516.3 5524.1 5616.4 5519.7 5521.2 5529.5 5539.3 5557.6 5500.8 5514.3 5521.6 5522.6 5542.9 5662.8 5697.5 5715.0 5770.0 5777.5 5519.8 5554.3 5555.8 5574.7 5587.8 07:49:16 INFO - PROCESS | 19290 | 07:49:16 INFO - PROCESS | 19290 | [#1] ext.html Cycles:180 Average:58854.11 Median:22197.21 stddev:119059.08 (536.4%) stddev-sans-first:119312.66 07:49:16 INFO - PROCESS | 19290 | Values: 572.1 576.4 586.7 595.9 603.7 38078.2 42583.6 42716.0 42740.4 42858.6 41714.0 42064.6 42104.4 42224.8 42233.2 8589.5 8745.9 8767.3 8776.1 8812.8 8661.4 8744.0 8746.7 8761.6 8780.9 8674.3 8779.7 8806.6 8828.4 8864.9 8652.6 8744.8 8752.1 8755.5 8755.6 8654.1 8690.0 8714.4 8758.2 8786.6 39784.6 40105.8 40163.8 40518.2 40550.4 3331.4 3522.7 3522.7 3568.4 3577.4 30608.0 30793.5 30799.4 30834.4 31082.2 3849.8 4044.2 4160.6 4218.0 4301.3 351676.0 355016.0 355108.0 355182.0 357514.0 53699.7 54387.0 54399.5 54406.0 54425.5 58255.7 58846.4 58850.7 59170.7 59276.0 15415.5 15508.7 15561.0 15583.7 15599.6 12384.7 12469.1 12477.4 12513.0 12565.2 15725.9 15904.2 15991.2 16002.9 16582.7 5820.9 5912.3 5970.2 6027.9 6046.9 918.4 990.4 1001.7 1018.6 1104.8 30885.8 31483.2 31595.0 31672.0 32106.4 944.2 1088.5 1100.3 1150.3 1234.7 14915.0 16376.2 16553.8 16755.4 17015.2 496236.0 504255.0 510988.0 511654.0 760310.0 55877.4 56700.4 56811.7 56829.7 56834.1 1319.4 1334.4 1337.4 1355.0 1358.9 29528.7 31323.4 31395.2 31718.0 32224.4 49146.0 49481.8 49816.0 50102.0 50186.2 390683.0 393079.0 394334.0 394494.0 394852.0 27091.5 27094.0 27423.2 27439.2 28153.0 43323.4 43849.8 44149.8 45263.1 47234.3 38048.2 39117.0 39319.4 39549.4 40350.2 38290.8 39172.0 39795.6 40590.8 40710.2 39420.0 40680.8 41003.7 41173.0 43226.0 30168.2 34474.5 35515.8 36207.8 36304.6 27439.9 27916.7 28028.6 28109.7 28161.6 07:49:16 INFO - PROCESS | 19290 | 07:49:16 INFO - PROCESS | 19290 | [#2] jquery.html Cycles:180 Average:28499.92 Median:2412.50 stddev:75965.94 (3148.8%) stddev-sans-first:76149.74 07:49:16 INFO - PROCESS | 19290 | Values: 398.1 399.4 406.2 412.6 417.5 14980.6 17881.6 18769.5 19564.7 19712.0 18244.5 18356.4 19629.0 19662.4 19824.7 5481.8 5490.7 5613.9 5678.2 5683.7 5515.1 5573.2 5579.6 5594.1 5595.7 5418.3 5643.5 5663.1 5669.9 5676.3 5390.6 5589.0 5603.3 5634.0 5651.7 4955.9 4995.1 5005.7 5017.5 5030.8 22704.9 23089.8 23335.0 23575.3 23613.4 2205.9 2377.0 2393.9 2431.1 2432.1 14383.6 14683.5 15064.5 15160.0 15262.1 1841.5 1877.4 1925.9 1954.1 1981.7 83405.0 85938.6 86205.6 88097.6 88650.0 10850.7 11137.2 11171.2 11259.7 12264.9 13894.8 16016.3 16072.5 16092.7 16134.2 7169.7 7662.3 7996.2 8044.2 8112.0 7779.6 7845.9 8055.5 8112.8 8120.1 4806.8 4842.9 4875.7 4886.9 5002.9 1928.7 1999.4 2026.2 2073.8 2077.6 905.0 938.6 994.2 1006.3 1006.9 18134.3 19784.6 19938.8 20005.5 20031.3 990.1 1008.1 1008.9 1046.2 1081.2 10388.4 11013.2 11027.3 11141.3 11157.5 434202.0 444971.0 469673.0 470383.0 472046.0 92075.0 93433.0 93731.0 94126.0 95204.0 965.2 981.4 995.6 1000.7 1026.7 16560.4 16600.2 17616.4 17758.1 17992.2 41732.6 41871.8 42744.4 43513.0 43796.6 59703.4 60173.4 60396.4 61166.7 62523.7 7514.6 7856.0 7935.9 8213.6 8748.0 12810.9 13461.3 13511.6 13881.9 13985.3 11585.2 11721.1 11843.3 12005.2 12109.9 11294.9 11331.3 11369.0 11456.5 12200.1 11335.0 11359.6 11560.8 11605.8 12124.2 7796.0 7918.3 8057.8 8114.1 8424.2 10038.1 11511.2 11644.5 11832.6 11945.1 07:49:16 INFO - PROCESS | 19290 | 07:49:16 INFO - PROCESS | 19290 | [#3] mootools.html Cycles:180 Average:5941.54 Median:4788.28 stddev:3437.13 (71.8%) stddev-sans-first:3430.35 07:49:16 INFO - PROCESS | 19290 | Values: 1470.7 1474.6 1607.5 1714.8 1729.8 7843.5 8186.6 8591.2 9171.4 9269.7 8647.1 8953.1 8976.7 9253.1 9257.7 2312.9 2360.6 2370.1 2373.1 2390.5 2290.7 2331.0 2334.9 2335.4 2342.3 2277.7 2291.0 2305.5 2326.7 2331.3 2275.6 2282.4 2292.5 2293.9 2305.1 2270.2 2277.5 2292.4 2297.2 2337.7 9089.5 9109.2 9246.8 9247.1 9259.4 5160.8 5282.5 5290.2 5297.4 5301.2 3270.8 3377.7 3491.4 3524.2 3577.6 1112.3 1164.3 1169.4 1190.9 1191.5 12875.7 12877.7 12881.1 12901.5 12940.4 4700.6 4738.6 4777.3 4852.4 4884.7 10645.8 10652.6 10673.4 10676.6 10688.7 5317.3 5320.3 5320.7 5327.7 5357.9 4214.6 4343.2 4692.8 4799.2 4868.1 3884.0 4045.0 4123.3 4128.6 4170.5 1314.7 1320.8 1328.8 1343.4 1344.6 909.9 920.5 929.5 934.0 953.3 5535.4 6027.5 6113.5 6162.2 6375.2 927.6 947.7 950.3 963.5 988.5 3748.5 3964.9 3993.9 4049.8 4075.2 11235.2 11518.5 11522.8 11537.5 11565.2 11306.5 11365.2 11386.7 11494.9 11502.7 7942.3 8317.6 8325.0 8416.5 8471.8 6000.7 6097.3 6350.4 6377.1 6420.7 10142.6 10340.6 10517.1 10621.0 10668.3 10255.7 10450.7 10526.9 10576.9 10680.2 7174.7 7396.4 7840.5 7937.2 7956.9 8677.0 8814.7 8818.1 8825.1 8887.7 7712.8 7729.0 7901.2 8025.0 8045.5 7504.4 7641.1 7654.6 7706.8 7725.8 7237.1 7404.1 7410.1 7430.4 7445.1 5144.4 5238.6 5340.9 5397.6 5504.6 5263.2 5289.1 5367.6 5380.0 5510.8 07:49:16 INFO - PROCESS | 19290 | 07:49:16 INFO - PROCESS | 19290 | [#4] prototype.html Cycles:180 Average:4749.33 Median:5302.68 stddev:1391.92 (26.2%) stddev-sans-first:1355.81 07:49:16 INFO - PROCESS | 19290 | Values: 334.2 338.1 349.8 350.6 351.4 5291.2 5453.1 5483.8 5553.6 5578.2 5299.4 5369.7 5380.5 5435.2 5446.7 4266.6 4276.9 4280.6 4282.8 4315.9 4214.9 4278.3 4313.4 4328.0 4329.2 4259.7 4303.2 4310.1 4314.1 4314.5 4249.5 4253.2 4275.7 4276.3 4286.1 3701.4 3861.9 3863.7 3876.4 3877.3 5273.5 5294.5 5298.5 5345.6 5350.3 4944.3 4946.2 4956.1 4959.0 4964.9 5457.5 5679.9 5680.9 5685.8 5721.2 4128.7 4131.6 4141.6 4154.0 4165.8 5919.6 5921.9 5953.7 5958.5 5982.9 4186.9 4247.4 4254.4 4285.5 4299.5 4260.6 4266.0 4283.2 4283.6 4311.8 4908.8 4924.5 4928.2 4929.1 4961.7 5655.0 5786.2 5814.2 5818.2 5834.6 1485.2 1497.3 1498.1 1499.5 1507.6 927.4 964.0 970.9 981.9 996.0 4740.6 4772.4 4811.7 4821.9 4852.8 5145.0 5158.6 5193.6 5222.3 5270.1 4607.9 4828.5 4834.7 4878.7 4905.2 2736.2 2751.3 2769.6 2814.0 2820.5 5305.9 5345.4 5387.7 5402.3 5409.7 5241.9 5306.6 5604.2 5995.3 6047.6 6103.3 6121.8 6152.2 6161.5 6199.2 5627.2 5898.4 5903.9 5926.7 5939.1 5835.8 5839.0 5878.8 5897.8 5899.9 6119.5 6176.9 6188.3 6208.6 6222.4 3984.4 4101.6 4183.4 4210.9 4225.5 5765.5 5813.6 5870.9 5885.2 5906.0 5541.8 5742.0 5763.0 5766.5 5768.8 5612.8 5631.4 5645.5 5650.3 5673.0 5683.9 5701.3 5717.7 5735.4 5739.3 5519.8 5675.2 5677.2 5731.9 5733.5 5648.6 5674.0 5684.6 5709.7 5713.3 07:49:16 INFO - PROCESS | 19290 | 07:49:16 INFO - PROCESS | 19290 | [#5] yui.html Cycles:180 Average:19938.45 Median:4589.21 stddev:28026.12 (610.7%) stddev-sans-first:28067.68 07:49:16 INFO - PROCESS | 19290 | Values: 743.2 748.7 791.2 831.2 834.6 15395.3 15642.8 15740.9 15885.8 15994.9 14989.4 15237.7 15268.3 15298.6 15314.8 783.7 801.2 803.4 805.6 806.6 790.1 793.7 795.5 796.3 798.0 849.4 850.4 850.6 851.0 851.8 839.4 839.7 841.2 841.4 841.9 598.3 622.0 623.9 624.4 626.0 12734.8 12850.6 12892.9 12921.1 12959.0 12944.8 13116.2 13220.7 13223.3 13357.7 11333.7 11606.2 11756.2 11884.3 11909.8 4397.2 4425.4 4432.9 4668.3 4673.5 75404.2 76512.0 77019.2 77100.6 79289.6 10997.8 11055.0 11055.8 11387.9 11389.6 19881.6 19897.9 19909.3 19923.4 19974.5 7711.7 8041.3 8259.2 8309.0 8638.3 4422.8 4545.5 4571.9 4606.5 4669.2 3464.9 3588.6 3589.5 3590.0 3595.8 631.9 660.9 667.7 681.2 723.0 717.4 724.4 734.2 750.5 757.4 9766.8 10190.9 10210.5 10785.8 10858.2 603.2 661.1 707.6 714.1 776.5 4620.3 5058.7 5155.9 5171.5 5205.2 94390.5 96491.9 98813.0 111165.0 130804.0 94389.0 94444.5 94491.5 94625.0 97029.5 53796.7 65899.3 72671.0 77305.6 81296.0 9436.8 10100.9 10205.9 10219.3 10505.7 49935.0 50276.7 50405.5 50812.7 51900.2 68871.0 69408.0 72586.0 75903.2 76970.6 12517.2 12571.2 13222.8 13293.2 13378.0 14688.8 14703.0 14855.3 15172.6 15352.8 14303.2 14370.4 14424.2 14558.8 15088.3 13364.0 13859.4 14014.9 14326.4 14352.8 13159.2 13488.9 13679.7 13710.5 13801.7 10500.6 10564.0 10590.2 11004.9 11257.9 11567.0 11852.7 12134.8 12178.5 12373.2 07:49:16 INFO - PROCESS | 19290 | -------- Summary: end -------- 07:49:16 INFO - PROCESS | 19290 | 07:49:17 INFO - TEST-INFO | 19290: exit 0 07:49:17 INFO - TEST-OK | dromaeo_css | took 1116464ms 07:49:17 INFO - TEST-START | kraken 07:49:17 INFO - operating with platform_type : linux_ 07:49:17 INFO - Initialising browser for kraken test... 07:49:17 INFO - TEST-INFO | started process 19670 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcbXR0h/profile http://localhost:56906/getInfo.html) 07:49:22 INFO - PROCESS | 19670 | __metrics Screen width/height:1600/1200 07:49:22 INFO - PROCESS | 19670 | colorDepth:24 07:49:22 INFO - PROCESS | 19670 | Browser inner width/height: 1024/697 07:49:22 INFO - PROCESS | 19670 | __metrics 07:49:23 ERROR - PROCESS | 19670 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3083: TypeError: this.tabs is undefined 07:49:24 INFO - TEST-INFO | 19670: exit 0 07:49:24 INFO - Browser initialized. 07:49:24 INFO - Running cycle 1/1 for kraken test... 07:49:24 INFO - TEST-INFO | started process 19796 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcbXR0h/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:49:36 INFO - PROCESS | 19796 | RSS: Main: 184729600 07:49:36 INFO - PROCESS | 19796 | 07:49:39 INFO - PROCESS | 19796 | Cycle 1(1): loaded http://localhost:56906/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56906/tests/kraken/driver.html?testName=audio-beat-detection) 07:49:40 INFO - PROCESS | 19796 | RSS: Main: 194523136 07:49:40 INFO - PROCESS | 19796 | 07:49:42 INFO - PROCESS | 19796 | Cycle 1(1): loaded http://localhost:56906/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56906/tests/kraken/driver.html?testName=audio-dft) 07:49:43 INFO - PROCESS | 19796 | RSS: Main: 196530176 07:49:43 INFO - PROCESS | 19796 | 07:49:46 INFO - PROCESS | 19796 | Cycle 1(1): loaded http://localhost:56906/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56906/tests/kraken/driver.html?testName=audio-fft) 07:49:47 INFO - PROCESS | 19796 | RSS: Main: 192057344 07:49:47 INFO - PROCESS | 19796 | 07:49:49 INFO - PROCESS | 19796 | Cycle 1(1): loaded http://localhost:56906/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56906/tests/kraken/driver.html?testName=audio-oscillator) 07:49:49 INFO - PROCESS | 19796 | RSS: Main: 192651264 07:49:49 INFO - PROCESS | 19796 | 07:49:51 INFO - PROCESS | 19796 | Cycle 1(1): loaded http://localhost:56906/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56906/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:49:52 INFO - PROCESS | 19796 | RSS: Main: 193273856 07:49:52 INFO - PROCESS | 19796 | 07:49:55 INFO - PROCESS | 19796 | Cycle 1(1): loaded http://localhost:56906/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56906/tests/kraken/driver.html?testName=imaging-darkroom) 07:49:56 INFO - PROCESS | 19796 | RSS: Main: 193585152 07:49:56 INFO - PROCESS | 19796 | 07:49:59 INFO - PROCESS | 19796 | Cycle 1(1): loaded http://localhost:56906/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56906/tests/kraken/driver.html?testName=imaging-desaturate) 07:50:00 INFO - PROCESS | 19796 | RSS: Main: 192045056 07:50:00 INFO - PROCESS | 19796 | 07:50:03 INFO - PROCESS | 19796 | Cycle 1(1): loaded http://localhost:56906/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56906/tests/kraken/driver.html?testName=json-parse-financial) 07:50:03 INFO - PROCESS | 19796 | RSS: Main: 193355776 07:50:03 INFO - PROCESS | 19796 | 07:50:05 INFO - PROCESS | 19796 | Cycle 1(1): loaded http://localhost:56906/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56906/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:50:06 INFO - PROCESS | 19796 | RSS: Main: 193466368 07:50:06 INFO - PROCESS | 19796 | 07:50:07 INFO - PROCESS | 19796 | Cycle 1(1): loaded http://localhost:56906/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56906/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:50:08 INFO - PROCESS | 19796 | RSS: Main: 193433600 07:50:08 INFO - PROCESS | 19796 | 07:50:10 INFO - PROCESS | 19796 | Cycle 1(1): loaded http://localhost:56906/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56906/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:50:11 INFO - PROCESS | 19796 | RSS: Main: 193421312 07:50:11 INFO - PROCESS | 19796 | 07:50:13 INFO - PROCESS | 19796 | Cycle 1(1): loaded http://localhost:56906/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56906/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:50:14 INFO - PROCESS | 19796 | RSS: Main: 193892352 07:50:14 INFO - PROCESS | 19796 | 07:50:17 INFO - PROCESS | 19796 | Cycle 1(1): loaded http://localhost:56906/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56906/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:50:18 INFO - PROCESS | 19796 | RSS: Main: 194199552 07:50:18 INFO - PROCESS | 19796 | 07:50:19 INFO - PROCESS | 19796 | Cycle 1(1): loaded http://localhost:56906/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56906/tests/kraken/driver.html?testName=ai-astar) 07:50:20 INFO - PROCESS | 19796 | RSS: Main: 195780608 07:50:20 INFO - PROCESS | 19796 | 07:50:20 INFO - PROCESS | 19796 | __start_tp_report 07:50:20 INFO - PROCESS | 19796 | _x_x_mozilla_page_load 07:50:20 INFO - PROCESS | 19796 | _x_x_mozilla_page_load_details 07:50:20 INFO - PROCESS | 19796 | |i|pagename|runs| 07:50:20 INFO - PROCESS | 19796 | |0;ai-astar;106;112;111;111;115;112;113;114;113;113 07:50:20 INFO - PROCESS | 19796 | |1;audio-beat-detection;156;130;126;168;128;123;123;123;149;126 07:50:20 INFO - PROCESS | 19796 | |2;audio-dft;164;163;162;168;167;164;162;163;162;164 07:50:20 INFO - PROCESS | 19796 | |3;audio-fft;76;74;77;114;78;78;77;77;102;76 07:50:20 INFO - PROCESS | 19796 | |4;audio-oscillator;81;83;115;84;84;82;104;83;82;120 07:50:20 INFO - PROCESS | 19796 | |5;imaging-gaussian-blur;117;118;117;118;119;119;117;118;118;118 07:50:20 INFO - PROCESS | 19796 | |6;imaging-darkroom;147;146;146;148;146;147;148;148;148;147 07:50:20 INFO - PROCESS | 19796 | |7;imaging-desaturate;97;96;95;95;97;96;96;97;97;96 07:50:20 INFO - PROCESS | 19796 | |8;json-parse-financial;54;53;53;54;56;55;54;55;55;55 07:50:20 INFO - PROCESS | 19796 | |9;json-stringify-tinderbox;61;62;61;61;63;61;61;62;62;62 07:50:20 INFO - PROCESS | 19796 | |10;stanford-crypto-aes;81;80;84;90;81;83;81;89;83;82 07:50:20 INFO - PROCESS | 19796 | |11;stanford-crypto-ccm;135;145;135;130;143;140;143;136;178;141 07:50:20 INFO - PROCESS | 19796 | |12;stanford-crypto-pbkdf2;170;173;166;168;169;165;167;169;168;173 07:50:20 INFO - PROCESS | 19796 | |13;stanford-crypto-sha256-iterative;68;68;65;67;73;66;66;67;66;65 07:50:20 INFO - PROCESS | 19796 | __end_tp_report 07:50:20 INFO - PROCESS | 19796 | __start_cc_report 07:50:20 INFO - PROCESS | 19796 | _x_x_mozilla_cycle_collect,776 07:50:20 INFO - PROCESS | 19796 | __end_cc_report 07:50:20 INFO - PROCESS | 19796 | __startTimestamp1476197420202__endTimestamp 07:50:20 INFO - PROCESS | 19796 | 07:50:20 INFO - PROCESS | 19796 | ------- Summary: start ------- 07:50:20 INFO - PROCESS | 19796 | Number of tests: 14 07:50:20 INFO - PROCESS | 19796 | 07:50:20 INFO - PROCESS | 19796 | [#0] ai-astar Cycles:10 Average:112.00 Median:113.00 stddev:2.45 (2.2%) stddev-sans-first:1.32 07:50:20 INFO - PROCESS | 19796 | Values: 106.0 112.0 111.0 111.0 115.0 112.0 113.0 114.0 113.0 113.0 07:50:20 INFO - PROCESS | 19796 | 07:50:20 INFO - PROCESS | 19796 | [#1] audio-beat-detection Cycles:10 Average:135.20 Median:129.00 stddev:16.31 (12.6%) stddev-sans-first:15.46 07:50:20 INFO - PROCESS | 19796 | Values: 156.0 130.0 126.0 168.0 128.0 123.0 123.0 123.0 149.0 126.0 07:50:20 INFO - PROCESS | 19796 | 07:50:20 INFO - PROCESS | 19796 | [#2] audio-dft Cycles:10 Average:163.90 Median:164.00 stddev:2.08 (1.3%) stddev-sans-first:2.20 07:50:20 INFO - PROCESS | 19796 | Values: 164.0 163.0 162.0 168.0 167.0 164.0 162.0 163.0 162.0 164.0 07:50:20 INFO - PROCESS | 19796 | 07:50:20 INFO - PROCESS | 19796 | [#3] audio-fft Cycles:10 Average:82.90 Median:77.00 stddev:13.58 (17.6%) stddev-sans-first:14.17 07:50:20 INFO - PROCESS | 19796 | Values: 76.0 74.0 77.0 114.0 78.0 78.0 77.0 77.0 102.0 76.0 07:50:20 INFO - PROCESS | 19796 | 07:50:20 INFO - PROCESS | 19796 | [#4] audio-oscillator Cycles:10 Average:91.80 Median:82.50 stddev:15.16 (18.4%) stddev-sans-first:15.56 07:50:20 INFO - PROCESS | 19796 | Values: 81.0 83.0 115.0 84.0 84.0 82.0 104.0 83.0 82.0 120.0 07:50:20 INFO - PROCESS | 19796 | 07:50:20 INFO - PROCESS | 19796 | [#5] imaging-gaussian-blur Cycles:10 Average:117.90 Median:118.00 stddev:0.74 (0.6%) stddev-sans-first:0.71 07:50:20 INFO - PROCESS | 19796 | Values: 117.0 118.0 117.0 118.0 119.0 119.0 117.0 118.0 118.0 118.0 07:50:20 INFO - PROCESS | 19796 | 07:50:20 INFO - PROCESS | 19796 | [#6] imaging-darkroom Cycles:10 Average:147.10 Median:147.50 stddev:0.88 (0.6%) stddev-sans-first:0.93 07:50:20 INFO - PROCESS | 19796 | Values: 147.0 146.0 146.0 148.0 146.0 147.0 148.0 148.0 148.0 147.0 07:50:20 INFO - PROCESS | 19796 | 07:50:20 INFO - PROCESS | 19796 | [#7] imaging-desaturate Cycles:10 Average:96.20 Median:96.50 stddev:0.79 (0.8%) stddev-sans-first:0.78 07:50:20 INFO - PROCESS | 19796 | Values: 97.0 96.0 95.0 95.0 97.0 96.0 96.0 97.0 97.0 96.0 07:50:20 INFO - PROCESS | 19796 | 07:50:20 INFO - PROCESS | 19796 | [#8] json-parse-financial Cycles:10 Average:54.40 Median:55.00 stddev:0.97 (1.8%) stddev-sans-first:1.01 07:50:20 INFO - PROCESS | 19796 | Values: 54.0 53.0 53.0 54.0 56.0 55.0 54.0 55.0 55.0 55.0 07:50:20 INFO - PROCESS | 19796 | 07:50:20 INFO - PROCESS | 19796 | [#9] json-stringify-tinderbox Cycles:10 Average:61.60 Median:62.00 stddev:0.70 (1.1%) stddev-sans-first:0.71 07:50:20 INFO - PROCESS | 19796 | Values: 61.0 62.0 61.0 61.0 63.0 61.0 61.0 62.0 62.0 62.0 07:50:20 INFO - PROCESS | 19796 | 07:50:20 INFO - PROCESS | 19796 | [#10] stanford-crypto-aes Cycles:10 Average:83.40 Median:83.00 stddev:3.44 (4.1%) stddev-sans-first:3.54 07:50:20 INFO - PROCESS | 19796 | Values: 81.0 80.0 84.0 90.0 81.0 83.0 81.0 89.0 83.0 82.0 07:50:20 INFO - PROCESS | 19796 | 07:50:20 INFO - PROCESS | 19796 | [#11] stanford-crypto-ccm Cycles:10 Average:142.60 Median:142.00 stddev:13.28 (9.3%) stddev-sans-first:13.79 07:50:20 INFO - PROCESS | 19796 | Values: 135.0 145.0 135.0 130.0 143.0 140.0 143.0 136.0 178.0 141.0 07:50:20 INFO - PROCESS | 19796 | 07:50:20 INFO - PROCESS | 19796 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.80 Median:169.00 stddev:2.66 (1.6%) stddev-sans-first:2.78 07:50:20 INFO - PROCESS | 19796 | Values: 170.0 173.0 166.0 168.0 169.0 165.0 167.0 169.0 168.0 173.0 07:50:20 INFO - PROCESS | 19796 | 07:50:20 INFO - PROCESS | 19796 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.10 Median:67.00 stddev:2.33 (3.5%) stddev-sans-first:2.45 07:50:20 INFO - PROCESS | 19796 | Values: 68.0 68.0 65.0 67.0 73.0 66.0 66.0 67.0 66.0 65.0 07:50:20 INFO - PROCESS | 19796 | -------- Summary: end -------- 07:50:20 INFO - PROCESS | 19796 | 07:50:20 INFO - PROCESS | 19796 | 07:50:20 INFO - PROCESS | 19796 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 07:50:20 INFO - PROCESS | 19796 | 07:50:20 INFO - PROCESS | 19796 | 07:50:20 INFO - PROCESS | 19796 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 07:50:20 INFO - PROCESS | 19796 | 07:50:20 INFO - PROCESS | 19796 | 07:50:20 INFO - PROCESS | 19796 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 07:50:20 INFO - PROCESS | 19796 | 07:50:20 INFO - PROCESS | 19796 | 07:50:20 INFO - PROCESS | 19796 | ###!!! [Parent][MessageChannel] Error: (msgtype=0x2000A,name=PAPZ::Msg_Destroy) Channel error: cannot send/recv 07:50:20 INFO - PROCESS | 19796 | 07:50:20 INFO - PROCESS | 19796 | 07:50:20 INFO - PROCESS | 19796 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 07:50:20 INFO - PROCESS | 19796 | 07:50:21 INFO - TEST-INFO | 19796: exit 0 07:50:21 INFO - TEST-OK | kraken | took 63923ms 07:50:21 INFO - SUITE-END | took 1180s 07:50:21 INFO - Completed test suite (00:19:40) 07:50:21 INFO - javascript benchmark 07:50:21 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7253.1217861994055, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3067.2791893904914, 3067.4018566379555, 3075.015994881638, 3076.4308602908463, 3092.3969825883946, 5334.706591137486, 5388.595855310853, 5395.352557693082, 5434.646747961379, 5535.972320138404, 5359.5712343012565, 5368.32895888014, 5411.945880541193, 5507.669539827613, 5514.035043867328, 4844.903101937959, 4873.731944743037, 4943.416920085743, 4952.603791696655, 4953.702777833341, 4986.725730084844, 5050.520200580957, 5104.157813960692, 5116.565091967187, 5139.254808052849, 4706.435227772655, 4741.668083234175, 4972.651914365996, 5006.349174607314, 5043.36957880265, 4766.998930224657, 4789.95210047902, 4812.711237325771, 4842.903141937177, 4857.441394239672, 4798.7840547175465, 4817.060673168733, 4821.783019764119, 4837.516248375169, 4864.927026094611, 5152.252923326134, 5266.131088370415, 5285.497877701612, 5305.1776974569, 5355.98236335095, 5607.635503692288, 5616.382197958222, 5651.0675738503505, 5655.208270842086, 5720.942790572082, 5690.630109042899, 5712.000399929995, 5722.055860782966, 5789.797357092481, 5802.82591522255, 5381.4349493303425, 5395.433479484597, 5396.028714831329, 5398.676079435247, 5444.0, 5709.486146246858, 5768.7980920668415, 5803.042497987784, 5813.767449302065, 5843.766249350064, 5510.366307874646, 5541.113421852484, 5568.0, 5570.3315602128005, 5574.498295153456, 5521.089020311684, 5652.74562644682, 5670.829875103754, 5685.0, 5687.9431205687415, 5594.9720251398485, 5636.070048442043, 5645.858853528694, 5646.830595082154, 5732.16883551891, 5660.094384898396, 5667.093265077568, 5681.261436013292, 5681.886362272731, 5684.573656975744, 4346.9347959780625, 4379.912401751947, 4387.583179597933, 4392.121575684876, 4439.067795762926, 3923.097687531884, 3924.6860251179837, 3929.626685464876, 3937.7637341759587, 3966.5835087315995, 5487.5884308677005, 5539.41836107211, 5542.584306177053, 5547.0, 5590.329160500684, 5791.436312195768, 5826.359100498942, 5839.9124013139835, 5840.3575606683235, 5868.23712917318, 5290.735463226823, 5301.310829592128, 5312.282841816383, 5425.159100339453, 5502.0921547944945, 4912.533309335608, 4918.458969513351, 4922.827701030446, 4959.132151873408, 4978.0292842896015, 5833.154192642128, 5859.472647461664, 5859.912101318484, 5862.706864656835, 5862.970685146547, 5531.8893622128135, 5594.608377413542, 5624.690642014729, 5636.239107720406, 5707.714614269353, 5960.5827592068135, 5980.611260268069, 5984.970075149597, 6048.395160484092, 6058.303295121117, 5629.240052593012, 5712.6001179917, 5720.3421606515785, 5725.255716756795, 5738.512226460798, 5526.668399896019, 5591.04952158126, 5746.0, 5790.623609465371, 5820.73806678692, 5466.535344495763, 5504.889902201853, 5516.255305533701, 5524.14375771756, 5616.38219795814, 5519.69641669712, 5521.171824226398, 5529.502344788988, 5539.279893613804, 5557.5553955682635, 5500.779968801203, 5514.338279406497, 5521.585881059017, 5522.641028333145, 5542.861428464321, 5662.8301150965535, 5697.487226149667, 5714.971425142848, 5770.0190967536455, 5777.45114214149, 5519.779208831602, 5554.2779438672715, 5555.805546805843, 5574.665520068809, 5587.776488940397], "value": 5280.582018826924, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [572.0760971031783, 576.3919065386019, 586.7242396073843, 595.9314678811938, 603.7381871887753, 38078.23843523132, 42583.574164258345, 42716.0, 42740.358894616606, 42858.571414285885, 41714.0, 42064.57935420645, 42104.368519462834, 42224.78887605565, 42233.155336893244, 8589.484630922134, 8745.912540874573, 8767.342449316295, 8776.122387761237, 8812.779680507974, 8661.350398720122, 8743.95628021859, 8746.650133994632, 8761.649534018663, 8780.868286975701, 8674.262687671555, 8779.692710755126, 8806.559672016405, 8828.382013259074, 8864.911350886505, 8652.567371631425, 8744.825103497926, 8752.081031491698, 8755.474671519729, 8755.562221888944, 8654.091320411391, 8689.956550217272, 8714.389992700513, 8758.167974042455, 8786.64853405863, 39784.60215397867, 40105.79947100246, 40163.7991810042, 40518.18963620711, 40550.39174412386, 3331.3670402623425, 3522.6829585337186, 3522.7181825453904, 3568.4290513517712, 3577.409727394977, 30608.0, 30793.538096928565, 30799.384012319853, 30834.383312333626, 31082.22294442657, 3849.8075096245075, 4044.2315959967805, 4160.646345060673, 4217.97891010546, 4301.333293339538, 351676.0, 355016.0, 355108.0, 355182.0, 357514.0, 53699.73150134224, 54387.0, 54399.45600543944, 54406.0, 54425.45574544283, 58255.70872145612, 58846.41153588495, 58850.705746470994, 59170.70414647985, 59276.0, 15415.460458883885, 15508.689826203412, 15561.0, 15583.688326233638, 15599.610009749847, 12384.690382740504, 12469.064820138527, 12477.376131193585, 12513.0, 12565.18326308787, 15725.921370393304, 15904.204789760697, 15991.200439977954, 16002.919985399998, 16582.668346633, 5820.88358232833, 5912.3496415394275, 5970.194023806731, 6027.876816891211, 6046.909296360558, 918.4489306416231, 990.4255531791543, 1001.6694490818013, 1018.5721996761378, 1104.845321654969, 30885.845570772002, 31483.212919677193, 31595.0, 31672.0, 32106.35787284288, 944.244604316544, 1088.4938503595865, 1100.3287994323457, 1150.286822170243, 1234.660468371205, 14915.0, 16376.181190940406, 16553.751693724604, 16755.41356052532, 17015.23431445588, 496236.0, 504255.0, 510988.0, 511654.0, 760310.0, 55877.44122558722, 56700.43299567034, 56811.71594142003, 56829.71585142048, 56834.14748778772, 1319.366703982094, 1334.426196735413, 1337.3513845784787, 1354.9661258468618, 1358.898082643786, 29528.704712952596, 31323.373532528767, 31395.215119622193, 31718.0, 32224.355512889142, 49146.0, 49481.752591236815, 49816.0, 50102.0, 50186.247206291206, 390683.0, 393079.0, 394334.0, 394494.0, 394852.0, 27091.458170836868, 27094.0, 27423.177304680892, 27439.176824695292, 28153.0, 43323.35014974841, 43849.780751097314, 44149.779251104825, 45263.09473810571, 47234.29148562706, 38048.239035219696, 39117.022074447224, 39319.41020884746, 39549.40675889922, 40350.1929961405, 38290.80854595821, 39172.0, 39795.60204397919, 40590.79704601458, 40710.1857962845, 39420.0, 40680.79659601683, 41003.66952296183, 41173.0, 43226.0, 30168.24579385533, 34474.482882756274, 35515.82242088773, 36207.818960905024, 36304.63695363013, 27439.862800685867, 27916.720832791412, 28028.57957130604, 28109.71890281071, 28161.57757633596], "value": 19385.645128981807, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [398.08639173097737, 399.42283400486275, 406.1896516449683, 412.6410023279746, 417.4635593262656, 14980.550583482485, 17881.64236715265, 18769.530761730963, 19564.706529402054, 19712.0, 18244.543886402847, 18356.35752748654, 19629.0, 19662.410127696156, 19824.70262946057, 5481.808136715225, 5490.725463726818, 5613.943860561403, 5678.205051292823, 5683.687397193153, 5515.09001014832, 5573.191887176357, 5579.553635709154, 5594.0769772987405, 5595.664260144384, 5418.268533747933, 5643.520300774439, 5663.122216056518, 5669.9433005670035, 5676.290463692038, 5390.6226564140525, 5588.972055139699, 5603.2715746953045, 5634.0, 5651.660900345972, 4955.851324460272, 4995.075910956485, 5005.724685142316, 5017.54842064216, 5030.84907452777, 22704.88647556768, 23089.76910230893, 23335.0, 23575.292741217792, 23613.409664758346, 2205.878676672782, 2376.988115059431, 2393.9281821545383, 2431.0761910474084, 2432.1487479382254, 14383.568492945124, 14683.48607798722, 15064.548063558112, 15160.0, 15262.084274943429, 1841.484384372378, 1877.3804644467293, 1925.913333899978, 1954.1499447740277, 1981.73246611707, 83405.0, 85938.5703071487, 86205.56897215536, 88097.55951220203, 88650.0, 10850.737392364697, 11137.164712646583, 11171.16216283782, 11259.718507037389, 12264.938675306745, 13894.791578126336, 16016.279267432994, 16072.517824465285, 16092.67814643724, 16134.193290335672, 7169.749058783022, 7662.310392064741, 7996.24035716606, 8044.155363686846, 8111.95944020288, 7779.649915753805, 7845.921540784633, 8055.516668999879, 8112.837743245102, 8120.066192387832, 4806.8077276909235, 4842.903141937141, 4875.7074575525585, 4886.853394398174, 5002.949970500321, 1928.7299778031088, 1999.3701983875033, 2026.1591439552421, 2073.8340932725346, 2077.574097310048, 904.9547522623842, 938.591712605019, 994.1847684898314, 1006.2503434941016, 1006.884208316053, 18134.279858021404, 19784.60430791376, 19938.800611993986, 20005.499862503264, 20031.298904538562, 990.0594435286507, 1008.1128606825946, 1008.9445080520495, 1046.2048842879467, 1081.194510089988, 10388.37669739803, 11013.163023597346, 11027.338359698284, 11141.275817071864, 11157.493738345382, 434202.0, 444971.0, 469673.0, 470383.0, 472046.0, 92075.0, 93433.0, 93731.0, 94126.0, 95204.0, 965.1940629574384, 981.3719219699398, 995.5520015992832, 1000.7147962830559, 1026.6663334416344, 16560.420385286456, 16600.169991500134, 17616.383426580007, 17758.11209439549, 17992.190351433954, 41732.58267417408, 41871.79064104782, 42744.35883461813, 43513.0, 43796.56203438052, 59703.402965969784, 60173.39826601678, 60396.39603603908, 61166.69416652888, 62523.6873815628, 7514.624268786648, 7855.960720196363, 7935.920640793749, 8213.589320534069, 8747.956260218658, 12810.935945320214, 13461.259630720404, 13511.594652160451, 13881.930590346983, 13985.300734963415, 11585.246958947642, 11721.12091593117, 11843.28940263587, 12005.219660722025, 12109.939450302692, 11294.887051129384, 11331.32012079278, 11369.0, 11456.541738330707, 12200.084993625336, 11335.0, 11359.602413915472, 11560.826587601361, 11605.76788464243, 12124.151309408257, 7796.0, 7918.287354138155, 8057.758267251992, 8114.107448180577, 8424.157584241526, 10038.053075334967, 11511.19421640477, 11644.475998580254, 11832.585859494877, 11945.104117191418], "value": 9276.09600863635, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1470.6617477980064, 1474.6313421644588, 1607.4695350534325, 1714.7942246930354, 1729.8097209306975, 7843.529388236696, 8186.631601577928, 8591.226789588936, 9171.449713017224, 9269.721908342744, 8647.092055334178, 8953.104689531043, 8976.730698079067, 9253.120953509422, 9257.722268331943, 2312.8843557822124, 2360.5632957902844, 2370.146747171017, 2373.1100837186054, 2390.497995420964, 2290.7480177180496, 2330.9650355244685, 2334.9182778602753, 2335.3577766114367, 2342.2973108067595, 2277.7152855893014, 2291.0034135151263, 2305.5043165719367, 2326.7086766844395, 2331.2889568681544, 2275.5676421479866, 2282.440802003503, 2292.518571100071, 2293.8623682579014, 2305.0664480885266, 2270.2394697776263, 2277.5331057133412, 2292.403974966504, 2297.184499502686, 2337.742848286687, 9089.454632722058, 9109.18017378439, 9246.768830779218, 9247.075292470767, 9259.351845370828, 5160.767765450564, 5282.471752824726, 5290.153575427913, 5297.390800058004, 5301.151815709468, 3270.787398819093, 3377.666874610106, 3491.4064609016527, 3524.207053412987, 3577.588577313616, 1112.2936935046305, 1164.3363282928733, 1169.4094482286475, 1190.9404529773476, 1191.487660306068, 12875.67810804728, 12877.742445151045, 12881.098323117385, 12901.483940642363, 12940.35298235094, 4700.55344742249, 4738.597219236334, 4777.314103033395, 4852.369192005087, 4884.7069175849565, 10645.84031239532, 10652.62715804943, 10673.35959842412, 10676.62631807883, 10688.732781680521, 5317.308749862493, 5320.308359913187, 5320.654157479751, 5327.733613319396, 5357.919631205457, 4214.620684138442, 4343.19650864591, 4692.7653617319, 4799.248274379896, 4868.075065737569, 3883.9611603884164, 4044.9797751011056, 4123.340265557496, 4128.649064829463, 4170.541240463546, 1314.723907979335, 1320.795276732108, 1328.8272524571744, 1343.368616750126, 1344.5764584155959, 909.9044600317004, 920.4707293306376, 929.4794914847707, 933.9999999999864, 953.2945620241111, 5535.446455354432, 6027.517798576104, 6113.510919126459, 6162.168107305546, 6375.171227740457, 927.5547737086237, 947.696737044153, 950.3300173377752, 963.4845357733578, 988.4859872866214, 3748.4564738113368, 3964.900877478086, 3993.9001524961527, 4049.7570145791346, 4075.2257071156387, 11235.157363197794, 11518.53925842957, 11522.827157592643, 11537.538498460135, 11565.19043666952, 11306.491207895664, 11365.204435689588, 11386.658400248005, 11494.942525287488, 11502.654920352403, 7942.285194332538, 8317.584120793936, 8325.0, 8416.452930559493, 8471.788205294793, 6000.679850433073, 6097.298810636834, 6350.364963503613, 6377.107204991397, 6420.6789660517725, 10142.645007424704, 10340.638077667245, 10517.10604598587, 10621.0, 10668.30656007357, 10255.7436064099, 10450.738731531468, 10526.947365263124, 10576.947115264375, 10680.198985075995, 7174.713011479483, 7396.445266604918, 7840.490368126054, 7937.2459616336355, 7956.880646790419, 8677.0, 8814.691485797966, 8818.07410221943, 8825.117488251124, 8887.73336799897, 7712.845743084995, 7729.0, 7901.249381308767, 8025.03699556057, 8045.477043992122, 7504.362129219077, 7641.1212710539, 7654.578998155155, 7706.807329816799, 7725.845483090419, 7237.131544214728, 7404.074490688664, 7410.147832999059, 7430.3684186842565, 7445.143808461879, 5144.356955380577, 5238.633295669419, 5340.893182136413, 5397.649152805055, 5504.559635229252, 5263.210518422115, 5289.100852855101, 5367.624266301322, 5380.0, 5510.752016159363], "value": 4726.030715419083, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [334.24127231185213, 338.1242581713363, 349.8250874562719, 350.5968136642862, 351.39033776397963, 5291.1798671205925, 5453.127499600065, 5483.780648774049, 5553.555715542757, 5578.191162281471, 5299.443558426367, 5369.677819330843, 5380.515753582177, 5435.157550579656, 5446.7276636168135, 4266.594673506028, 4276.893077673068, 4280.550542193072, 4282.807273672693, 4315.913681726363, 4214.894627634303, 4278.2940814765525, 4313.374560688699, 4328.0, 4329.1558146161515, 4259.659227261812, 4303.24693178694, 4310.07333423314, 4314.072474418, 4314.460692413449, 4249.490061192661, 4253.1706317268145, 4275.722078064916, 4276.315789473685, 4286.121345124242, 3701.444783282529, 3861.942070868939, 3863.729538932276, 3876.4379165020914, 3877.282702699981, 5273.472652734734, 5294.470552944713, 5298.549623282026, 5345.572354211693, 5350.30446042016, 4944.33251511045, 4946.183879659852, 4956.058348913695, 4959.0, 4964.865108003557, 5457.508824205841, 5679.943200567983, 5680.857978550528, 5685.8009969651275, 5721.170430287585, 4128.710990230685, 4131.586841315874, 4141.6065473779945, 4154.0, 4165.812538435747, 5919.644821310735, 5921.940780592182, 5953.732082056318, 5958.493528050164, 5982.880342393171, 4186.937195942063, 4247.405363249148, 4254.42565253693, 4285.5358169052915, 4299.505556860939, 4260.573942605776, 4265.957340426556, 4283.164782867373, 4283.593058659422, 4311.8490852820005, 4908.754562271872, 4924.507549245119, 4928.20120655958, 4929.137400954819, 4961.70229786214, 5654.971725141348, 5786.189933409326, 5814.215080964016, 5818.243628328375, 5834.620749651259, 1485.18314926792, 1497.2513743128436, 1498.116111494202, 1499.475183685723, 1507.6457032597332, 927.3832901120679, 963.9589243616877, 970.8932017478072, 981.9149839427473, 995.9542480395555, 4740.5733483986605, 4772.427308722906, 4811.711297322172, 4821.9035619287415, 4852.830150944771, 5144.9742751286, 5158.561522270574, 5193.5585475234275, 5222.328854766438, 5270.077736396115, 4607.9308810367875, 4828.517148285214, 4834.709917404967, 4878.682885612424, 4905.2151655734915, 2736.233854520737, 2751.284665986858, 2769.62610047645, 2813.9598790876453, 2820.4782115308735, 5305.920411193835, 5345.358556973188, 5387.730613469389, 5402.324709411324, 5409.702466364309, 5241.895162096813, 5306.575473962073, 5604.243427137366, 5995.250593675791, 6047.606905551125, 6103.314541601681, 6121.816345509642, 6152.16945712332, 6161.537884658579, 6199.163112979871, 5627.212190293444, 5898.380670029756, 5903.881922361615, 5926.703664816828, 5939.138824870456, 5835.824925252249, 5838.963738855856, 5878.823635290948, 5897.823065308047, 5899.911501327398, 6119.479844213113, 6176.876462470816, 6188.288346840171, 6208.578654324727, 6222.377762223922, 3984.362501999666, 4101.569335219879, 4183.372494125905, 4210.894727631834, 4225.492940847118, 5765.509931655689, 5813.6221145625395, 5870.917768171744, 5885.205497257986, 5906.0, 5541.833744987657, 5741.971290143522, 5762.971185144047, 5766.481016708516, 5768.798092066925, 5612.849365879903, 5631.408702086222, 5645.471580262336, 5650.26546548946, 5673.0, 5683.857903552279, 5701.287339082614, 5717.714114294352, 5735.426457354231, 5739.311282646109, 5519.806806761744, 5675.177099320493, 5677.205191273142, 5731.8567035824435, 5733.541316694738, 5648.5763567731765, 5673.971630141988, 5684.63049901755, 5709.68596727184, 5713.257276554022], "value": 4309.565663174314, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [743.2084829656419, 748.6743266678993, 791.1613689489142, 831.2477208126647, 834.5660256666533, 15395.307211175495, 15642.765358519631, 15740.921295393535, 15885.84114158858, 15994.920025399872, 14989.400423983028, 15237.69524609507, 15268.312925918333, 15298.617534561641, 15314.846851531482, 783.7021931665973, 801.1747899663327, 803.4335793265734, 805.569020573993, 806.6289506826866, 790.1387487638473, 793.6507936507946, 795.5028107432854, 796.2873228460525, 797.972070977516, 849.3587341557115, 850.421713235, 850.5704619167312, 851.0128251228576, 851.7572491839827, 839.3746658739278, 839.7270886961732, 841.2134654098408, 841.4488510025943, 841.9452735572169, 598.2940130645836, 621.9720112594944, 623.8627501949609, 624.4192900602438, 625.9843503912439, 12734.80897786534, 12850.614481565568, 12892.935535322356, 12921.095523313372, 12959.028072894476, 12944.805827912589, 13116.213027218397, 13220.735585288241, 13223.338833058404, 13357.66605834862, 11333.716657083556, 11606.187566870323, 11756.23584467007, 11884.346360950145, 11909.821352679717, 4397.164538737662, 4425.424694789656, 4432.889177770581, 4668.299755036738, 4673.509281525459, 75404.24595754081, 76512.0, 77019.22980770176, 77100.61449692772, 79289.60355198245, 10997.780044399067, 11055.0, 11055.834162487568, 11387.886121138848, 11389.601363952223, 19881.60236795256, 19897.900510497355, 19909.303174388828, 19923.402297931087, 19974.50063748389, 7711.730089446843, 8041.276285134366, 8259.21537453941, 8309.0, 8638.265747411415, 4422.823087076546, 4545.454545454567, 4571.9085618287445, 4606.516315786794, 4669.182892993713, 3464.9133771655406, 3588.6052534221217, 3589.4974703541525, 3590.0, 3595.802230877327, 631.88626047311, 660.8777376185325, 667.6995352091578, 681.2131987554383, 722.9566226026456, 717.3543810570528, 724.4457989637931, 734.2217249715319, 750.4784174998324, 757.4205732614444, 9766.755831104138, 10190.89177800763, 10210.540525676362, 10785.83821242682, 10858.185636077167, 603.2399177036878, 661.0678942690782, 707.6461769115442, 714.125196634119, 776.4991580430591, 4620.283856002325, 5058.747062646853, 5155.922661160085, 5171.456997015259, 5205.167173252262, 94390.52804735933, 96491.90343110492, 98813.0, 111165.0, 130804.0, 94389.0, 94444.52777736068, 94491.52754236184, 94625.0, 97029.51485242529, 53796.73101634467, 65899.34100659029, 72671.0, 77305.61347193229, 81296.0, 9436.764080898032, 10100.949495252476, 10205.864877145059, 10219.335743176669, 10505.68482945513, 49935.0, 50276.748616256686, 50405.49594504155, 50812.74593627008, 51900.22149667682, 68871.0, 69408.0, 72586.0, 75903.24096758962, 76970.61514692391, 12517.248965062125, 12571.245725256147, 13222.801657974946, 13293.20240785556, 13378.0, 14688.77966830477, 14703.03115099767, 14855.331510081856, 15172.620684482976, 15352.769708454158, 14303.213323266904, 14370.3533341002, 14424.206668632905, 14558.781618275523, 15088.321025553656, 13364.0, 13859.445622175, 14014.882621883162, 14326.426942922166, 14352.784708229176, 13159.210447373189, 13488.93255533716, 13679.726405471636, 13710.451581936612, 13801.723965520834, 10500.632477863544, 10564.0, 10590.205734569783, 11004.944975275072, 11257.887421125684, 11566.966913048142, 11852.70368240801, 12134.75730485403, 12178.45196966121, 12373.195742276723], "value": 7527.485621185178, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1524.8999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 112.0, 111.0, 111.0, 115.0, 112.0, 113.0, 114.0, 113.0, 113.0], "value": 112.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 130.0, 126.0, 168.0, 128.0, 123.0, 123.0, 123.0, 149.0, 126.0], "value": 135.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 163.0, 162.0, 168.0, 167.0, 164.0, 162.0, 163.0, 162.0, 164.0], "value": 163.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 74.0, 77.0, 114.0, 78.0, 78.0, 77.0, 77.0, 102.0, 76.0], "value": 82.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 83.0, 115.0, 84.0, 84.0, 82.0, 104.0, 83.0, 82.0, 120.0], "value": 91.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 118.0, 119.0, 119.0, 117.0, 118.0, 118.0, 118.0], "value": 117.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 146.0, 148.0, 146.0, 147.0, 148.0, 148.0, 148.0, 147.0], "value": 147.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 96.0, 95.0, 95.0, 97.0, 96.0, 96.0, 97.0, 97.0, 96.0], "value": 96.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 53.0, 54.0, 56.0, 55.0, 54.0, 55.0, 55.0, 55.0], "value": 54.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 61.0, 61.0, 63.0, 61.0, 61.0, 62.0, 62.0, 62.0], "value": 61.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 80.0, 84.0, 90.0, 81.0, 83.0, 81.0, 89.0, 83.0, 82.0], "value": 83.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 145.0, 135.0, 130.0, 143.0, 140.0, 143.0, 136.0, 178.0, 141.0], "value": 142.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 173.0, 166.0, 168.0, 169.0, 165.0, 167.0, 169.0, 168.0, 173.0], "value": 168.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 65.0, 67.0, 73.0, 66.0, 66.0, 67.0, 66.0, 65.0], "value": 67.1, "unit": "score"}]}]} 07:50:21 INFO - Return code: 0 07:50:22 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:50:22 ERROR - # TBPL SUCCESS # 07:50:22 INFO - Running post-action listener: _resource_record_post_action 07:50:22 INFO - [mozharness: 2016-10-11 14:50:22.020842Z] Finished run-tests step (success) 07:50:22 INFO - Running post-run listener: _resource_record_post_run 07:50:22 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 122880; Write bytes: 403230720; Read time: 56; Write time: 735460 07:50:22 INFO - TinderboxPrint: CPU usage
13.5% 07:50:22 INFO - TinderboxPrint: I/O read bytes / time
122,880 / 56 07:50:22 INFO - TinderboxPrint: I/O write bytes / time
403,230,720 / 735,460 07:50:22 INFO - TinderboxPrint: CPU idle
8,266.7 (86.5%) 07:50:22 INFO - TinderboxPrint: CPU user
1,219.8 (12.8%) 07:50:22 INFO - TinderboxPrint: Swap in / out
0 / 0 07:50:22 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 103956480; Read time: 0; Write time: 133124 07:50:22 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 118784; Write bytes: 299274240; Read time: 44; Write time: 602336 07:50:22 INFO - Running post-run listener: _upload_blobber_files 07:50:22 INFO - Blob upload gear active. 07:50:22 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:50:22 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 07:50:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:50:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:50:23 INFO - (blobuploader) - INFO - Open directory for files ... 07:50:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 07:50:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:50:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:50:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 07:50:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:50:23 INFO - (blobuploader) - INFO - Done attempting. 07:50:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:50:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:50:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:50:26 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:50:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:50:26 INFO - (blobuploader) - INFO - Done attempting. 07:50:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 07:50:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:50:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:50:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 07:50:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:50:27 INFO - (blobuploader) - INFO - Done attempting. 07:50:27 INFO - (blobuploader) - INFO - Iteration through files over. 07:50:27 INFO - Return code: 0 07:50:27 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:50:27 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:50:27 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/62d677a2f7077cbecab5c3f917ffb2985e3855ca086873de38428dc226ad5f185d9b0ffe6728dd3583b57e08fba7efba7b487b07b0e6147b33ec9cbbbe8bfa57", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ff606969e6d5a29645911a45ecaea791d10df0a74e8c3297289d2fd57ac239c99726a949623d2839381d8831b72698f38aca201215b864c8749ec4315f6e6f29", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6bcb61e7c95632e8409a1e0fe6ac68884ddaf38ecdd9c50db582c65abe94bc472b354caaebc7f317db993e5e6917af5e8c971aef61a56c73b2a8c1326b0426e4"} 07:50:27 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:50:27 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:50:27 INFO - Contents: 07:50:27 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/62d677a2f7077cbecab5c3f917ffb2985e3855ca086873de38428dc226ad5f185d9b0ffe6728dd3583b57e08fba7efba7b487b07b0e6147b33ec9cbbbe8bfa57", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ff606969e6d5a29645911a45ecaea791d10df0a74e8c3297289d2fd57ac239c99726a949623d2839381d8831b72698f38aca201215b864c8749ec4315f6e6f29", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6bcb61e7c95632e8409a1e0fe6ac68884ddaf38ecdd9c50db582c65abe94bc472b354caaebc7f317db993e5e6917af5e8c971aef61a56c73b2a8c1326b0426e4"} 07:50:27 INFO - Running post-run listener: copy_logs_to_upload_dir 07:50:27 INFO - Copying logs to upload dir... 07:50:27 INFO - mkdir: /builds/slave/test/build/upload/logs 07:50:27 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1241.295339 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-10-11 07:50:27.436147) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-11 07:50:27.444174) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1476196183.950627-53494217 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/62d677a2f7077cbecab5c3f917ffb2985e3855ca086873de38428dc226ad5f185d9b0ffe6728dd3583b57e08fba7efba7b487b07b0e6147b33ec9cbbbe8bfa57", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ff606969e6d5a29645911a45ecaea791d10df0a74e8c3297289d2fd57ac239c99726a949623d2839381d8831b72698f38aca201215b864c8749ec4315f6e6f29", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6bcb61e7c95632e8409a1e0fe6ac68884ddaf38ecdd9c50db582c65abe94bc472b354caaebc7f317db993e5e6917af5e8c971aef61a56c73b2a8c1326b0426e4"} build_url:https://queue.taskcluster.net/v1/task/Z9LOcrN6R7eCPFycCeIPMA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011262 build_url: 'https://queue.taskcluster.net/v1/task/Z9LOcrN6R7eCPFycCeIPMA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/62d677a2f7077cbecab5c3f917ffb2985e3855ca086873de38428dc226ad5f185d9b0ffe6728dd3583b57e08fba7efba7b487b07b0e6147b33ec9cbbbe8bfa57", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ff606969e6d5a29645911a45ecaea791d10df0a74e8c3297289d2fd57ac239c99726a949623d2839381d8831b72698f38aca201215b864c8749ec4315f6e6f29", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6bcb61e7c95632e8409a1e0fe6ac68884ddaf38ecdd9c50db582c65abe94bc472b354caaebc7f317db993e5e6917af5e8c971aef61a56c73b2a8c1326b0426e4"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-11 07:50:27.472720) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-11 07:50:27.473057) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1476196183.950627-53494217 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004598 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-11 07:50:27.555540) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-11 07:50:27.555860) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-11 07:50:27.556152) ========= ========= Total master_lag: 0.19 =========