builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-035 starttime: 1475679984.13 results: success (0) buildid: 20161005064400 builduid: d1d328e664484416baeb562142a7cc48 revision: e8fa13708c070d1fadf488ed9d951464745b4e17 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-05 08:06:24.128011) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-05 08:06:24.128496) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-05 08:06:24.128843) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-05 08:06:24.143700) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-05 08:06:24.144025) ========= 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=ed14279e38b05397cf4aa391000001a4-1475679984.343718-1477131147 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-05 08:06:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 50.7M=0s 2016-10-05 08:06:25 (50.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.116457 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-05 08:06:24.274168) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-05 08:06:24.274480) ========= 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=ed14279e38b05397cf4aa391000001a4-1475679984.343718-1477131147 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020372 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-05 08:06:24.324582) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-05 08:06:24.324948) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev e8fa13708c070d1fadf488ed9d951464745b4e17 --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 e8fa13708c070d1fadf488ed9d951464745b4e17 --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=ed14279e38b05397cf4aa391000001a4-1475679984.343718-1477131147 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-05 08:06:25,403 truncating revision to first 12 chars 2016-10-05 08:06:25,403 Setting DEBUG logging. 2016-10-05 08:06:25,403 attempt 1/10 2016-10-05 08:06:25,403 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/e8fa13708c07?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-05 08:06:26,692 unpacking tar archive at: mozilla-central-e8fa13708c07/testing/mozharness/ program finished with exit code 0 elapsedTime=1.644840 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-05 08:06:25.983571) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-05 08:06:25.983907) ========= script_repo_revision: e8fa13708c070d1fadf488ed9d951464745b4e17 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-05 08:06:25.984345) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-05 08:06:25.984620) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-05 08:06:25.995410) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-10-05 08:06:25.995815) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=ed14279e38b05397cf4aa391000001a4-1475679984.343718-1477131147 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:06:27 INFO - MultiFileLogger online at 20161005 08:06:27 in /builds/slave/test 08:06:27 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 08:06:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:06:27 INFO - {'append_to_log': False, 08:06:27 INFO - 'base_work_dir': '/builds/slave/test', 08:06:27 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 08:06:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:06:27 INFO - 'branch': 'Firefox-Non-PGO', 08:06:27 INFO - 'buildbot_json_path': 'buildprops.json', 08:06:27 INFO - 'config_files': ('talos/linux_config.py',), 08:06:27 INFO - 'default_actions': ('clobber', 08:06:27 INFO - 'read-buildbot-config', 08:06:27 INFO - 'download-and-extract', 08:06:27 INFO - 'populate-webroot', 08:06:27 INFO - 'create-virtualenv', 08:06:27 INFO - 'install', 08:06:27 INFO - 'run-tests'), 08:06:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:06:27 INFO - 'download_minidump_stackwalk': True, 08:06:27 INFO - 'download_symbols': 'ondemand', 08:06:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:06:27 INFO - 'tooltool.py': '/tools/tooltool.py', 08:06:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:06:27 INFO - '/tools/misc-python/virtualenv.py')}, 08:06:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:06:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:06:27 INFO - 'installer_path': 'installer.exe', 08:06:27 INFO - 'log_level': 'info', 08:06:27 INFO - 'log_name': 'talos', 08:06:27 INFO - 'log_to_console': True, 08:06:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:06:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:06:27 INFO - 'opt_config_files': (), 08:06:27 INFO - 'pip_index': False, 08:06:27 INFO - 'sps_profile': False, 08:06:27 INFO - 'sps_profile_interval': 0, 08:06:27 INFO - 'suite': 'dromaeojs', 08:06:27 INFO - 'system_bits': '32', 08:06:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:06:27 INFO - 'title': 'talos-linux64-ix-035', 08:06:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:06:27 INFO - 'use_talos_json': True, 08:06:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:06:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:06:27 INFO - 'work_dir': 'build'} 08:06:27 INFO - [mozharness: 2016-10-05 15:06:27.172032Z] Running clobber step. 08:06:27 INFO - Running pre-action listener: _resource_record_pre_action 08:06:27 INFO - Running main action method: clobber 08:06:27 INFO - rmtree: /builds/slave/test/build 08:06:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:06:27 INFO - Running post-action listener: _resource_record_post_action 08:06:27 INFO - [mozharness: 2016-10-05 15:06:27.632190Z] Finished clobber step (success) 08:06:27 INFO - [mozharness: 2016-10-05 15:06:27.632601Z] Running read-buildbot-config step. 08:06:27 INFO - Running pre-action listener: _resource_record_pre_action 08:06:27 INFO - Running main action method: read_buildbot_config 08:06:27 INFO - Using buildbot properties: 08:06:27 INFO - { 08:06:27 INFO - "project": "", 08:06:27 INFO - "product": "firefox", 08:06:27 INFO - "script_repo_revision": "production", 08:06:27 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 08:06:27 INFO - "repository": "", 08:06:27 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 08:06:27 INFO - "buildid": "20161005064400", 08:06:27 INFO - "pgo_build": "False", 08:06:27 INFO - "basedir": "/builds/slave/test", 08:06:27 INFO - "buildnumber": 767, 08:06:27 INFO - "slavename": "talos-linux64-ix-035", 08:06:27 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 08:06:27 INFO - "platform": "ubuntu64_hw", 08:06:27 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 08:06:27 INFO - "branch": "mozilla-central", 08:06:27 INFO - "repo_path": "mozilla-central", 08:06:27 INFO - "revision": "e8fa13708c070d1fadf488ed9d951464745b4e17", 08:06:27 INFO - "stage_platform": "linux64", 08:06:27 INFO - "builduid": "d1d328e664484416baeb562142a7cc48", 08:06:27 INFO - "slavebuilddir": "test" 08:06:27 INFO - } 08:06:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/fuPdWzMHSm2wndZevS6uaQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 08:06:27 INFO - Running post-action listener: _resource_record_post_action 08:06:27 INFO - [mozharness: 2016-10-05 15:06:27.635029Z] Finished read-buildbot-config step (success) 08:06:27 INFO - [mozharness: 2016-10-05 15:06:27.635118Z] Running download-and-extract step. 08:06:27 INFO - Running pre-action listener: _resource_record_pre_action 08:06:27 INFO - Running main action method: download_and_extract 08:06:27 INFO - mkdir: /builds/slave/test/build/tests 08:06:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:06:27 INFO - trying https://queue.taskcluster.net/v1/task/fuPdWzMHSm2wndZevS6uaQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 08:06:27 INFO - Downloading https://queue.taskcluster.net/v1/task/fuPdWzMHSm2wndZevS6uaQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 08:06:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fuPdWzMHSm2wndZevS6uaQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 08:06:28 INFO - Downloaded 1361 bytes. 08:06:28 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 08:06:28 INFO - Using the following test package requirements: 08:06:28 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 08:06:28 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 08:06:28 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:06:28 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 08:06:28 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:06:28 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 08:06:28 INFO - u'jsshell-linux-x86_64.zip'], 08:06:28 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 08:06:28 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:06:28 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 08:06:28 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 08:06:28 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:06:28 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 08:06:28 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:06:28 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 08:06:28 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:06:28 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 08:06:28 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:06:28 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:06:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fuPdWzMHSm2wndZevS6uaQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 08:06:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fuPdWzMHSm2wndZevS6uaQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:06:28 INFO - Fetch https://queue.taskcluster.net/v1/task/fuPdWzMHSm2wndZevS6uaQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 08:06:28 INFO - Http code: 200 08:06:28 INFO - via: 1.1 423912f2b1c5569e2fa5017167c61fa0.cloudfront.net (CloudFront) 08:06:28 INFO - x-amz-cf-id: sCzDCGgVuVdtfx1RomP-H9Y9EQ3OKkWwFL_Dp58hDrCuVd_TBWZfqQ== 08:06:28 INFO - x-amz-version-id: oC4QSm3n9GrGCSsSwTlTobml4yoAzsoQ 08:06:29 INFO - Expected file size: 20421139 08:06:29 INFO - Obtained file size: 20421139 08:06:33 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 08:06:33 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fuPdWzMHSm2wndZevS6uaQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 08:06:33 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fuPdWzMHSm2wndZevS6uaQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:06:33 INFO - Fetch https://queue.taskcluster.net/v1/task/fuPdWzMHSm2wndZevS6uaQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 08:06:33 INFO - Http code: 200 08:06:33 INFO - via: 1.1 93ab344e1a3fa44edbf3f1bc5729427a.cloudfront.net (CloudFront) 08:06:33 INFO - x-amz-cf-id: Pe3_ewm-sT1vtFe4Qvyy0goz_6tpVitBNYTmhlYQTon78lY1jG5YtQ== 08:06:33 INFO - x-amz-version-id: oC4QSm3n9GrGCSsSwTlTobml4yoAzsoQ 08:06:33 INFO - Expected file size: 20421139 08:06:33 INFO - Obtained file size: 20421139 08:06:38 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fuPdWzMHSm2wndZevS6uaQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 08:06:38 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fuPdWzMHSm2wndZevS6uaQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 08:06:38 INFO - Fetch https://queue.taskcluster.net/v1/task/fuPdWzMHSm2wndZevS6uaQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 08:06:38 INFO - Http code: 200 08:06:38 INFO - via: 1.1 b9a8ce441329f20cea895e08f19f1ec8.cloudfront.net (CloudFront) 08:06:38 INFO - x-amz-cf-id: iMB5G9Efz5BYEde1a8_W82_PlQee03Om6EcnImT4SXq1E__eGgzVOw== 08:06:38 INFO - x-amz-version-id: HadMmKGKt641gYaMsK4KJb5gBSDI_9wF 08:06:39 INFO - Expected file size: 14409006 08:06:39 INFO - Obtained file size: 14409006 08:06:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:06:39 INFO - trying https://queue.taskcluster.net/v1/task/fuPdWzMHSm2wndZevS6uaQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 08:06:39 INFO - Downloading https://queue.taskcluster.net/v1/task/fuPdWzMHSm2wndZevS6uaQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 08:06:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fuPdWzMHSm2wndZevS6uaQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 08:06:40 INFO - Downloaded 55810477 bytes. 08:06:40 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/fuPdWzMHSm2wndZevS6uaQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 08:06:40 INFO - mkdir: /builds/slave/test/properties 08:06:40 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:06:40 INFO - Writing to file /builds/slave/test/properties/build_url 08:06:40 INFO - Contents: 08:06:40 INFO - build_url:https://queue.taskcluster.net/v1/task/fuPdWzMHSm2wndZevS6uaQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 08:06:41 INFO - Running post-action listener: _resource_record_post_action 08:06:41 INFO - Running post-action listener: set_extra_try_arguments 08:06:41 INFO - [mozharness: 2016-10-05 15:06:41.122738Z] Finished download-and-extract step (success) 08:06:41 INFO - [mozharness: 2016-10-05 15:06:41.122965Z] Running populate-webroot step. 08:06:41 INFO - Running pre-action listener: _resource_record_pre_action 08:06:41 INFO - Running main action method: populate_webroot 08:06:41 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:06:41 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:06:41 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:06:41 INFO - '--tppagecycles', 08:06:41 INFO - '7'], 08:06:41 INFO - 'tests': ['tsvgm']}}, 08:06:41 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:06:41 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:06:41 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:06:41 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:06:41 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:06:41 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:06:41 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:06:41 INFO - 'talos_options': ['--disable-e10s'], 08:06:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:06:41 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:06:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:06:41 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:06:41 INFO - 'talos_options': ['--disable-e10s'], 08:06:41 INFO - 'tests': ['damp', 'tps']}, 08:06:41 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:06:41 INFO - 'tests': ['damp', 'tps']}, 08:06:41 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:06:41 INFO - 'tests': ['dromaeo_dom']}, 08:06:41 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:06:41 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:06:41 INFO - 'tests': ['basic_compositor_video']}, 08:06:41 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:06:41 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:06:41 INFO - 'tests': ['a11yr', 08:06:41 INFO - 'ts_paint', 08:06:41 INFO - 'tpaint', 08:06:41 INFO - 'sessionrestore', 08:06:41 INFO - 'sessionrestore_no_auto_restore', 08:06:41 INFO - 'tabpaint']}, 08:06:41 INFO - 'other-e10s': {'tests': ['a11yr', 08:06:41 INFO - 'ts_paint', 08:06:41 INFO - 'tpaint', 08:06:41 INFO - 'sessionrestore', 08:06:41 INFO - 'sessionrestore_no_auto_restore', 08:06:41 INFO - 'tabpaint']}, 08:06:41 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:06:41 INFO - 'ts_paint', 08:06:41 INFO - 'tpaint', 08:06:41 INFO - 'sessionrestore', 08:06:41 INFO - 'sessionrestore_no_auto_restore', 08:06:41 INFO - 'tabpaint']}, 08:06:41 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:06:41 INFO - 'ts_paint', 08:06:41 INFO - 'tpaint', 08:06:41 INFO - 'sessionrestore', 08:06:41 INFO - 'sessionrestore_no_auto_restore', 08:06:41 INFO - 'tabpaint']}, 08:06:41 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:06:41 INFO - 'tests': ['a11yr', 08:06:41 INFO - 'ts_paint', 08:06:41 INFO - 'tpaint', 08:06:41 INFO - 'sessionrestore', 08:06:41 INFO - 'sessionrestore_no_auto_restore', 08:06:41 INFO - 'tabpaint']}, 08:06:41 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:06:41 INFO - 'tests': ['a11yr', 08:06:41 INFO - 'ts_paint', 08:06:41 INFO - 'tpaint', 08:06:41 INFO - 'sessionrestore', 08:06:41 INFO - 'sessionrestore_no_auto_restore', 08:06:41 INFO - 'tabpaint']}, 08:06:41 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:06:41 INFO - 'tests': ['tsvgx', 08:06:41 INFO - 'tsvgr_opacity', 08:06:41 INFO - 'tart', 08:06:41 INFO - 'tscrollx', 08:06:41 INFO - 'cart']}, 08:06:41 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:06:41 INFO - 'tsvgr_opacity', 08:06:41 INFO - 'tart', 08:06:41 INFO - 'tscrollx', 08:06:41 INFO - 'cart']}, 08:06:41 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:06:41 INFO - 'talos_options': ['--disable-e10s'], 08:06:41 INFO - 'tests': ['tp5o']}, 08:06:41 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:06:41 INFO - 'tests': ['tp5o']}, 08:06:41 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:06:41 INFO - 'talos_options': ['--disable-e10s', 08:06:41 INFO - '--xperf_path', 08:06:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:06:41 INFO - 'tests': ['tp5n']}, 08:06:41 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:06:41 INFO - 'talos_options': ['--xperf_path', 08:06:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:06:41 INFO - 'tests': ['tp5n']}}, 08:06:41 INFO - 'talos.zip': {'path': '', 08:06:41 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:06:41 INFO - Running post-action listener: _resource_record_post_action 08:06:41 INFO - [mozharness: 2016-10-05 15:06:41.144602Z] Finished populate-webroot step (success) 08:06:41 INFO - [mozharness: 2016-10-05 15:06:41.144691Z] Running create-virtualenv step. 08:06:41 INFO - Running pre-action listener: _resource_record_pre_action 08:06:41 INFO - Running main action method: create_virtualenv 08:06:41 INFO - Creating virtualenv /builds/slave/test/build/venv 08:06:41 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 08:06:41 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:06:41 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:06:41 INFO - Using real prefix '/usr' 08:06:41 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:06:41 INFO - Installing distribute.............................................................................................................................................................................................done. 08:06:43 INFO - Installing pip.................done. 08:06:43 INFO - Return code: 0 08:06:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:06:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:06:43 INFO - Reading from file tmpfile_stdout 08:06:43 INFO - Output received: 08:06:43 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 08:06:43 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:06:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:06:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:06:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:06:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:06:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:06:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:06:43 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 0x7ff99d7f1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2956ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2953f60>, '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 0x2954d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29551d0>, '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': 'ed14279e38b05397cf4aa391000001a4-1475679984.343718-1477131147', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:06:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:06:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:06:43 INFO - Using env: {'DISPLAY': ':0', 08:06:43 INFO - 'HOME': '/home/cltbld', 08:06:43 INFO - 'LANG': 'en_US.UTF-8', 08:06:43 INFO - 'LANGUAGE': 'en_US:en', 08:06:43 INFO - 'LOGNAME': 'cltbld', 08:06:43 INFO - 'MAIL': '/var/mail/cltbld', 08:06:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:06:43 INFO - 'MOZ_NO_REMOTE': '1', 08:06:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:06:43 INFO - 'NO_EM_RESTART': '1', 08:06:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:06:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:06:43 INFO - 'PWD': '/builds/slave/test', 08:06:43 INFO - 'SHELL': '/bin/bash', 08:06:43 INFO - 'SHLVL': '1', 08:06:43 INFO - 'TERM': 'linux', 08:06:43 INFO - 'TMOUT': '86400', 08:06:43 INFO - 'USER': 'cltbld', 08:06:43 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1475679984.343718-1477131147', 08:06:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:06:43 INFO - '_': '/tools/buildbot/bin/python'} 08:06:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:06:44 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 08:06:44 INFO - Cleaning up... 08:06:44 INFO - Return code: 0 08:06:44 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:06:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:06:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:06:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:06:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:06:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:06:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:06:44 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 0x7ff99d7f1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2956ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2953f60>, '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 0x2954d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29551d0>, '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': 'ed14279e38b05397cf4aa391000001a4-1475679984.343718-1477131147', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:06:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:06:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:06:44 INFO - Using env: {'DISPLAY': ':0', 08:06:44 INFO - 'HOME': '/home/cltbld', 08:06:44 INFO - 'LANG': 'en_US.UTF-8', 08:06:44 INFO - 'LANGUAGE': 'en_US:en', 08:06:44 INFO - 'LOGNAME': 'cltbld', 08:06:44 INFO - 'MAIL': '/var/mail/cltbld', 08:06:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:06:44 INFO - 'MOZ_NO_REMOTE': '1', 08:06:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:06:44 INFO - 'NO_EM_RESTART': '1', 08:06:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:06:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:06:44 INFO - 'PWD': '/builds/slave/test', 08:06:44 INFO - 'SHELL': '/bin/bash', 08:06:44 INFO - 'SHLVL': '1', 08:06:44 INFO - 'TERM': 'linux', 08:06:44 INFO - 'TMOUT': '86400', 08:06:44 INFO - 'USER': 'cltbld', 08:06:44 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1475679984.343718-1477131147', 08:06:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:06:44 INFO - '_': '/tools/buildbot/bin/python'} 08:06:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:06:44 INFO - Downloading/unpacking psutil>=3.1.1 08:06:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:06:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:06:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:06:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:06:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:06:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:06:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:06:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:06:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:06:46 INFO - Installing collected packages: psutil 08:06:46 INFO - Running setup.py install for psutil 08:06:46 INFO - building 'psutil._psutil_linux' extension 08:06:46 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 08:06:46 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 08:06:46 INFO - building 'psutil._psutil_posix' extension 08:06:46 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 08:06:46 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 08:06:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:06:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:06:46 INFO - Successfully installed psutil 08:06:46 INFO - Cleaning up... 08:06:46 INFO - Return code: 0 08:06:46 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:06:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:06:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:06:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:06:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:06:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:06:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:06:46 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 0x7ff99d7f1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2956ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2953f60>, '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 0x2954d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29551d0>, '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': 'ed14279e38b05397cf4aa391000001a4-1475679984.343718-1477131147', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:06:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:06:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:06:46 INFO - Using env: {'DISPLAY': ':0', 08:06:46 INFO - 'HOME': '/home/cltbld', 08:06:46 INFO - 'LANG': 'en_US.UTF-8', 08:06:46 INFO - 'LANGUAGE': 'en_US:en', 08:06:46 INFO - 'LOGNAME': 'cltbld', 08:06:46 INFO - 'MAIL': '/var/mail/cltbld', 08:06:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:06:46 INFO - 'MOZ_NO_REMOTE': '1', 08:06:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:06:46 INFO - 'NO_EM_RESTART': '1', 08:06:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:06:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:06:46 INFO - 'PWD': '/builds/slave/test', 08:06:46 INFO - 'SHELL': '/bin/bash', 08:06:46 INFO - 'SHLVL': '1', 08:06:46 INFO - 'TERM': 'linux', 08:06:46 INFO - 'TMOUT': '86400', 08:06:46 INFO - 'USER': 'cltbld', 08:06:46 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1475679984.343718-1477131147', 08:06:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:06:46 INFO - '_': '/tools/buildbot/bin/python'} 08:06:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:06:47 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:06:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:06:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:06:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:06:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:06:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:06:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:06:49 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:06:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:06:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:06:49 INFO - Installing collected packages: mozsystemmonitor 08:06:49 INFO - Running setup.py install for mozsystemmonitor 08:06:49 INFO - Successfully installed mozsystemmonitor 08:06:49 INFO - Cleaning up... 08:06:49 INFO - Return code: 0 08:06:49 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:06:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:06:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:06:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:06:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:06:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:06:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:06:49 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 0x7ff99d7f1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2956ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2953f60>, '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 0x2954d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29551d0>, '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': 'ed14279e38b05397cf4aa391000001a4-1475679984.343718-1477131147', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:06:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:06:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 08:06:49 INFO - Using env: {'DISPLAY': ':0', 08:06:49 INFO - 'HOME': '/home/cltbld', 08:06:49 INFO - 'LANG': 'en_US.UTF-8', 08:06:49 INFO - 'LANGUAGE': 'en_US:en', 08:06:49 INFO - 'LOGNAME': 'cltbld', 08:06:49 INFO - 'MAIL': '/var/mail/cltbld', 08:06:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:06:49 INFO - 'MOZ_NO_REMOTE': '1', 08:06:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:06:49 INFO - 'NO_EM_RESTART': '1', 08:06:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:06:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:06:49 INFO - 'PWD': '/builds/slave/test', 08:06:49 INFO - 'SHELL': '/bin/bash', 08:06:49 INFO - 'SHLVL': '1', 08:06:49 INFO - 'TERM': 'linux', 08:06:49 INFO - 'TMOUT': '86400', 08:06:49 INFO - 'USER': 'cltbld', 08:06:49 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1475679984.343718-1477131147', 08:06:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:06:49 INFO - '_': '/tools/buildbot/bin/python'} 08:06:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:06:49 INFO - Downloading/unpacking jsonschema==2.5.1 08:06:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:06:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:06:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:06:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:06:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:06:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:06:51 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:06:51 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:06:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:06:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:06:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:06:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:06:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:06:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:06:51 INFO - Downloading functools32-3.2.3-2.tar.gz 08:06:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:06:51 INFO - warning: no files found matching '*.txt' 08:06:51 INFO - no previously-included directories found matching 'build' 08:06:51 INFO - no previously-included directories found matching 'dist' 08:06:51 INFO - no previously-included directories found matching '.git*' 08:06:51 INFO - Installing collected packages: jsonschema, functools32 08:06:51 INFO - Running setup.py install for functools32 08:06:51 INFO - warning: no files found matching '*.txt' 08:06:51 INFO - no previously-included directories found matching 'build' 08:06:51 INFO - no previously-included directories found matching 'dist' 08:06:51 INFO - no previously-included directories found matching '.git*' 08:06:51 INFO - Successfully installed jsonschema functools32 08:06:51 INFO - Cleaning up... 08:06:51 INFO - Return code: 0 08:06:51 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:06:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:06:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:06:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:06:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:06:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:06:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:06:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7ff99d7f1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2956ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2953f60>, '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 0x2954d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29551d0>, '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': 'ed14279e38b05397cf4aa391000001a4-1475679984.343718-1477131147', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:06:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 08:06:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 08:06:51 INFO - Using env: {'DISPLAY': ':0', 08:06:51 INFO - 'HOME': '/home/cltbld', 08:06:51 INFO - 'LANG': 'en_US.UTF-8', 08:06:51 INFO - 'LANGUAGE': 'en_US:en', 08:06:51 INFO - 'LOGNAME': 'cltbld', 08:06:51 INFO - 'MAIL': '/var/mail/cltbld', 08:06:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:06:51 INFO - 'MOZ_NO_REMOTE': '1', 08:06:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:06:51 INFO - 'NO_EM_RESTART': '1', 08:06:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:06:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:06:51 INFO - 'PWD': '/builds/slave/test', 08:06:51 INFO - 'SHELL': '/bin/bash', 08:06:51 INFO - 'SHLVL': '1', 08:06:51 INFO - 'TERM': 'linux', 08:06:51 INFO - 'TMOUT': '86400', 08:06:51 INFO - 'USER': 'cltbld', 08:06:51 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1475679984.343718-1477131147', 08:06:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:06:51 INFO - '_': '/tools/buildbot/bin/python'} 08:06:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:06:52 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:06:52 INFO - Cleaning up... 08:06:52 INFO - Return code: 0 08:06:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:06:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:06:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:06:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:06:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:06:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:06:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:06:52 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 0x7ff99d7f1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2956ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2953f60>, '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 0x2954d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29551d0>, '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': 'ed14279e38b05397cf4aa391000001a4-1475679984.343718-1477131147', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:06:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:06:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:06:52 INFO - Using env: {'DISPLAY': ':0', 08:06:52 INFO - 'HOME': '/home/cltbld', 08:06:52 INFO - 'LANG': 'en_US.UTF-8', 08:06:52 INFO - 'LANGUAGE': 'en_US:en', 08:06:52 INFO - 'LOGNAME': 'cltbld', 08:06:52 INFO - 'MAIL': '/var/mail/cltbld', 08:06:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:06:52 INFO - 'MOZ_NO_REMOTE': '1', 08:06:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:06:52 INFO - 'NO_EM_RESTART': '1', 08:06:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:06:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:06:52 INFO - 'PWD': '/builds/slave/test', 08:06:52 INFO - 'SHELL': '/bin/bash', 08:06:52 INFO - 'SHLVL': '1', 08:06:52 INFO - 'TERM': 'linux', 08:06:52 INFO - 'TMOUT': '86400', 08:06:52 INFO - 'USER': 'cltbld', 08:06:52 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1475679984.343718-1477131147', 08:06:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:06:52 INFO - '_': '/tools/buildbot/bin/python'} 08:06:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:06:52 INFO - Downloading/unpacking blobuploader==1.2.4 08:06:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:06:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:06:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:06:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:06:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:06:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:06:54 INFO - Downloading blobuploader-1.2.4.tar.gz 08:06:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:06:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:06:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:06:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:06:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:06:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:06:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:06:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:06:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:06:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:06:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:06:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:06:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:06:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:06:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:06:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:06:54 INFO - Downloading docopt-0.6.1.tar.gz 08:06:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:06:54 INFO - Installing collected packages: blobuploader, requests, docopt 08:06:54 INFO - Running setup.py install for blobuploader 08:06:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:06:55 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:06:55 INFO - Running setup.py install for requests 08:06:55 INFO - Running setup.py install for docopt 08:06:55 INFO - Successfully installed blobuploader requests docopt 08:06:55 INFO - Cleaning up... 08:06:55 INFO - Return code: 0 08:06:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:06:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:06:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:06:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:06:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:06:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:06:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:06:55 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 0x7ff99d7f1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2956ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2953f60>, '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 0x2954d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29551d0>, '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': 'ed14279e38b05397cf4aa391000001a4-1475679984.343718-1477131147', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:06:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:06:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:06:55 INFO - Using env: {'DISPLAY': ':0', 08:06:55 INFO - 'HOME': '/home/cltbld', 08:06:55 INFO - 'LANG': 'en_US.UTF-8', 08:06:55 INFO - 'LANGUAGE': 'en_US:en', 08:06:55 INFO - 'LOGNAME': 'cltbld', 08:06:55 INFO - 'MAIL': '/var/mail/cltbld', 08:06:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:06:55 INFO - 'MOZ_NO_REMOTE': '1', 08:06:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:06:55 INFO - 'NO_EM_RESTART': '1', 08:06:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:06:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:06:55 INFO - 'PWD': '/builds/slave/test', 08:06:55 INFO - 'SHELL': '/bin/bash', 08:06:55 INFO - 'SHLVL': '1', 08:06:55 INFO - 'TERM': 'linux', 08:06:55 INFO - 'TMOUT': '86400', 08:06:55 INFO - 'USER': 'cltbld', 08:06:55 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1475679984.343718-1477131147', 08:06:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:06:55 INFO - '_': '/tools/buildbot/bin/python'} 08:06:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:06:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:06:55 INFO - Running setup.py (path:/tmp/pip-tm4xBt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:06:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:06:55 INFO - Running setup.py (path:/tmp/pip-09nMaP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:06:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:06:55 INFO - Running setup.py (path:/tmp/pip-Q8xDu_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:06:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:06:56 INFO - Running setup.py (path:/tmp/pip-DLCpIe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:06:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:06:56 INFO - Running setup.py (path:/tmp/pip-bqBZBp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:06:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:06:56 INFO - Running setup.py (path:/tmp/pip-EOGKsZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:06:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:06:56 INFO - Running setup.py (path:/tmp/pip-Vbclyk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:06:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:06:56 INFO - Running setup.py (path:/tmp/pip-xrkxke-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:06:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:06:56 INFO - Running setup.py (path:/tmp/pip-1jEfXW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:06:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:06:56 INFO - Running setup.py (path:/tmp/pip-OVr9Nc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:06:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:06:56 INFO - Running setup.py (path:/tmp/pip-XXxYYA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:06:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:06:56 INFO - Running setup.py (path:/tmp/pip-dV8YtX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:06:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:06:56 INFO - Running setup.py (path:/tmp/pip-2VZVsC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:06:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:06:56 INFO - Running setup.py (path:/tmp/pip-SArolO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:06:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:06:56 INFO - Running setup.py (path:/tmp/pip-BEc3r6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:06:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:06:56 INFO - Running setup.py (path:/tmp/pip-saeb1Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:06:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:06:56 INFO - Running setup.py (path:/tmp/pip-0bfjIn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:06:57 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:06:57 INFO - Running setup.py install for manifestparser 08:06:57 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:06:57 INFO - Running setup.py install for mozcrash 08:06:57 INFO - Running setup.py install for mozdebug 08:06:57 INFO - Running setup.py install for mozdevice 08:06:57 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:06:57 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:06:57 INFO - Running setup.py install for mozfile 08:06:57 INFO - Running setup.py install for mozhttpd 08:06:57 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:06:57 INFO - Running setup.py install for mozinfo 08:06:57 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:06:57 INFO - Running setup.py install for mozInstall 08:06:57 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:06:57 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:06:57 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:06:57 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:06:57 INFO - Running setup.py install for mozleak 08:06:57 INFO - Running setup.py install for mozlog 08:06:58 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:06:58 INFO - Running setup.py install for moznetwork 08:06:58 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:06:58 INFO - Running setup.py install for mozprocess 08:06:58 INFO - Running setup.py install for mozprofile 08:06:58 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:06:58 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:06:58 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:06:58 INFO - Running setup.py install for mozrunner 08:06:58 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:06:58 INFO - Running setup.py install for mozscreenshot 08:06:58 INFO - Running setup.py install for moztest 08:06:58 INFO - Running setup.py install for mozversion 08:06:58 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:06:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:06:58 INFO - Cleaning up... 08:06:58 INFO - Return code: 0 08:06:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:06:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:06:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:06:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:06:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:06:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:06:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:06:58 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 0x7ff99d7f1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2956ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2953f60>, '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 0x2954d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29551d0>, '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': 'ed14279e38b05397cf4aa391000001a4-1475679984.343718-1477131147', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:06:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:06:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:06:58 INFO - Using env: {'DISPLAY': ':0', 08:06:58 INFO - 'HOME': '/home/cltbld', 08:06:58 INFO - 'LANG': 'en_US.UTF-8', 08:06:58 INFO - 'LANGUAGE': 'en_US:en', 08:06:58 INFO - 'LOGNAME': 'cltbld', 08:06:58 INFO - 'MAIL': '/var/mail/cltbld', 08:06:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:06:58 INFO - 'MOZ_NO_REMOTE': '1', 08:06:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:06:58 INFO - 'NO_EM_RESTART': '1', 08:06:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:06:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:06:58 INFO - 'PWD': '/builds/slave/test', 08:06:58 INFO - 'SHELL': '/bin/bash', 08:06:58 INFO - 'SHLVL': '1', 08:06:58 INFO - 'TERM': 'linux', 08:06:58 INFO - 'TMOUT': '86400', 08:06:58 INFO - 'USER': 'cltbld', 08:06:58 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1475679984.343718-1477131147', 08:06:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:06:58 INFO - '_': '/tools/buildbot/bin/python'} 08:06:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:06:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:06:59 INFO - Running setup.py (path:/tmp/pip-vAK8nA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:06:59 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 08:06:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:06:59 INFO - Running setup.py (path:/tmp/pip-MN3pQv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:06:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:06:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:06:59 INFO - Running setup.py (path:/tmp/pip-cy3SD3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:06:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:06:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:06:59 INFO - Running setup.py (path:/tmp/pip-C2_qqm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:06:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:06:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:06:59 INFO - Running setup.py (path:/tmp/pip-kDLpz7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:06:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 08:06:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:06:59 INFO - Running setup.py (path:/tmp/pip-CErWs2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:06:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 08:06:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:06:59 INFO - Running setup.py (path:/tmp/pip-7b2xDU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:06:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 08:06:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:06:59 INFO - Running setup.py (path:/tmp/pip-vJhXHH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:06:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 08:06:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:06:59 INFO - Running setup.py (path:/tmp/pip-OMew9K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:06:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 08:06:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:06:59 INFO - Running setup.py (path:/tmp/pip-8b2NkB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:06:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:06:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:06:59 INFO - Running setup.py (path:/tmp/pip-gFZQnW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:06:59 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 08:06:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:06:59 INFO - Running setup.py (path:/tmp/pip-9t0HXI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:06:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 08:06:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:06:59 INFO - Running setup.py (path:/tmp/pip-K08h9X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:06:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 08:06:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:07:00 INFO - Running setup.py (path:/tmp/pip-trOoPS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:07:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 08:07:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:07:00 INFO - Running setup.py (path:/tmp/pip-Hm71uG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:07:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 08:07:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:07:00 INFO - Running setup.py (path:/tmp/pip-OYCVWR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:07:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 08:07:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:07:00 INFO - Running setup.py (path:/tmp/pip-sMXJue-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:07:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 08:07:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:07:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:07:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:07:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:07:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:07:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:07:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:07:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:07:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:07:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:07:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:07:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:07:02 INFO - Downloading blessings-1.6.tar.gz 08:07:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:07:02 INFO - Installing collected packages: blessings 08:07:02 INFO - Running setup.py install for blessings 08:07:02 INFO - Successfully installed blessings 08:07:02 INFO - Cleaning up... 08:07:02 INFO - Return code: 0 08:07:02 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:07:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:07:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:07:02 INFO - Reading from file tmpfile_stdout 08:07:02 INFO - Current package versions: 08:07:02 INFO - argparse == 1.2.1 08:07:02 INFO - blessings == 1.6 08:07:02 INFO - blobuploader == 1.2.4 08:07:02 INFO - docopt == 0.6.1 08:07:02 INFO - functools32 == 3.2.3-2 08:07:02 INFO - jsonschema == 2.5.1 08:07:02 INFO - manifestparser == 1.1 08:07:02 INFO - mozInstall == 1.12 08:07:02 INFO - mozcrash == 0.17 08:07:02 INFO - mozdebug == 0.1 08:07:02 INFO - mozdevice == 0.48 08:07:02 INFO - mozfile == 1.2 08:07:02 INFO - mozhttpd == 0.7 08:07:02 INFO - mozinfo == 0.9 08:07:02 INFO - mozleak == 0.1 08:07:02 INFO - mozlog == 3.4 08:07:02 INFO - moznetwork == 0.27 08:07:02 INFO - mozprocess == 0.23 08:07:02 INFO - mozprofile == 0.28 08:07:02 INFO - mozrunner == 6.12 08:07:02 INFO - mozscreenshot == 0.1 08:07:02 INFO - mozsystemmonitor == 0.3 08:07:02 INFO - moztest == 0.7 08:07:02 INFO - mozversion == 1.4 08:07:02 INFO - psutil == 3.1.1 08:07:02 INFO - requests == 1.2.3 08:07:02 INFO - wsgiref == 0.1.2 08:07:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:07:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:07:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:07:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:07:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:07:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:07:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:07:02 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 0x7ff99d7f1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2956ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2953f60>, '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 0x2954d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29551d0>, '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': 'ed14279e38b05397cf4aa391000001a4-1475679984.343718-1477131147', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:07:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 08:07:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:07:02 INFO - Using env: {'DISPLAY': ':0', 08:07:02 INFO - 'HOME': '/home/cltbld', 08:07:02 INFO - 'LANG': 'en_US.UTF-8', 08:07:02 INFO - 'LANGUAGE': 'en_US:en', 08:07:02 INFO - 'LOGNAME': 'cltbld', 08:07:02 INFO - 'MAIL': '/var/mail/cltbld', 08:07:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:07:02 INFO - 'MOZ_NO_REMOTE': '1', 08:07:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:07:02 INFO - 'NO_EM_RESTART': '1', 08:07:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:07:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:07:02 INFO - 'PWD': '/builds/slave/test', 08:07:02 INFO - 'SHELL': '/bin/bash', 08:07:02 INFO - 'SHLVL': '1', 08:07:02 INFO - 'TERM': 'linux', 08:07:02 INFO - 'TMOUT': '86400', 08:07:02 INFO - 'USER': 'cltbld', 08:07:02 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1475679984.343718-1477131147', 08:07:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:07:02 INFO - '_': '/tools/buildbot/bin/python'} 08:07:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:07:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:07:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 08:07:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 08:07:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:07:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 08:07:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 08:07:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 08:07:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 08:07:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 08:07:02 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:07:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:07:02 INFO - Cleaning up... 08:07:02 INFO - Return code: 0 08:07:02 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:07:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:07:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:07:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:07:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:07:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:07:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:07:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff99d7f1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2956ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2953f60>, '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 0x2954d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29551d0>, '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': 'ed14279e38b05397cf4aa391000001a4-1475679984.343718-1477131147', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:07:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:07:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:07:02 INFO - Using env: {'DISPLAY': ':0', 08:07:02 INFO - 'HOME': '/home/cltbld', 08:07:02 INFO - 'LANG': 'en_US.UTF-8', 08:07:02 INFO - 'LANGUAGE': 'en_US:en', 08:07:02 INFO - 'LOGNAME': 'cltbld', 08:07:02 INFO - 'MAIL': '/var/mail/cltbld', 08:07:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:07:02 INFO - 'MOZ_NO_REMOTE': '1', 08:07:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:07:02 INFO - 'NO_EM_RESTART': '1', 08:07:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:07:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:07:02 INFO - 'PWD': '/builds/slave/test', 08:07:02 INFO - 'SHELL': '/bin/bash', 08:07:02 INFO - 'SHLVL': '1', 08:07:02 INFO - 'TERM': 'linux', 08:07:02 INFO - 'TMOUT': '86400', 08:07:02 INFO - 'USER': 'cltbld', 08:07:02 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1475679984.343718-1477131147', 08:07:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:07:02 INFO - '_': '/tools/buildbot/bin/python'} 08:07:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:07:03 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:07:03 INFO - Cleaning up... 08:07:03 INFO - Return code: 0 08:07:03 INFO - Running post-action listener: _resource_record_post_action 08:07:03 INFO - Running post-action listener: _start_resource_monitoring 08:07:03 INFO - Starting resource monitoring. 08:07:03 INFO - [mozharness: 2016-10-05 15:07:03.149504Z] Finished create-virtualenv step (success) 08:07:03 INFO - [mozharness: 2016-10-05 15:07:03.149962Z] Running install step. 08:07:03 INFO - Running pre-action listener: _resource_record_pre_action 08:07:03 INFO - Running main action method: install 08:07:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:07:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:07:03 INFO - Reading from file tmpfile_stdout 08:07:03 INFO - Detecting whether we're running mozinstall >=1.0... 08:07:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:07:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:07:03 INFO - Reading from file tmpfile_stdout 08:07:03 INFO - Output received: 08:07:03 INFO - Usage: mozinstall [options] installer 08:07:03 INFO - Options: 08:07:03 INFO - -h, --help show this help message and exit 08:07:03 INFO - -d DEST, --destination=DEST 08:07:03 INFO - Directory to install application into. [default: 08:07:03 INFO - "/builds/slave/test"] 08:07:03 INFO - --app=APP Application being installed. [default: firefox] 08:07:03 INFO - mkdir: /builds/slave/test/build/application 08:07:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 08:07:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 08:07:19 INFO - Reading from file tmpfile_stdout 08:07:19 INFO - Output received: 08:07:19 INFO - /builds/slave/test/build/application/firefox/firefox 08:07:19 INFO - Running post-action listener: _resource_record_post_action 08:07:19 INFO - [mozharness: 2016-10-05 15:07:19.585786Z] Finished install step (success) 08:07:19 INFO - [mozharness: 2016-10-05 15:07:19.586030Z] Running run-tests step. 08:07:19 INFO - Running pre-action listener: _resource_record_pre_action 08:07:19 INFO - Running main action method: run_tests 08:07:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:07:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:07:19 INFO - Python 2.7.3 08:07:19 INFO - Return code: 0 08:07:19 INFO - grabbing minidump binary from tooltool 08:07:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:07:19 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 0x2953f60>, '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 0x2954d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29551d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:07:19 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 08:07:19 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 08:07:19 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 08:07:19 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:07:19 INFO - Return code: 0 08:07:19 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:07:19 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:07:19 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:07:19 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:07:19 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:07:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fuPdWzMHSm2wndZevS6uaQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 08:07:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/fuPdWzMHSm2wndZevS6uaQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-035 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 08:07:19 INFO - Using env: {'DISPLAY': ':0', 08:07:19 INFO - 'HOME': '/home/cltbld', 08:07:19 INFO - 'LANG': 'en_US.UTF-8', 08:07:19 INFO - 'LANGUAGE': 'en_US:en', 08:07:19 INFO - 'LOGNAME': 'cltbld', 08:07:19 INFO - 'MAIL': '/var/mail/cltbld', 08:07:19 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:07:19 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:07:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:07:19 INFO - 'MOZ_NO_REMOTE': '1', 08:07:19 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:07:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:07:19 INFO - 'NO_EM_RESTART': '1', 08:07:19 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:07:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:07:19 INFO - 'PWD': '/builds/slave/test', 08:07:19 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:07:19 INFO - 'SHELL': '/bin/bash', 08:07:19 INFO - 'SHLVL': '1', 08:07:19 INFO - 'TERM': 'linux', 08:07:19 INFO - 'TMOUT': '86400', 08:07:19 INFO - 'USER': 'cltbld', 08:07:19 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1475679984.343718-1477131147', 08:07:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:07:19 INFO - '_': '/tools/buildbot/bin/python'} 08:07:19 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fuPdWzMHSm2wndZevS6uaQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 08:07:19 INFO - mozversion application_buildid: 20161005064400 08:07:19 INFO - mozversion application_changeset: e8fa13708c070d1fadf488ed9d951464745b4e17 08:07:19 INFO - mozversion application_display_name: Nightly 08:07:19 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:07:19 INFO - mozversion application_name: Firefox 08:07:19 INFO - mozversion application_remotingname: firefox 08:07:19 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 08:07:19 INFO - mozversion application_vendor: Mozilla 08:07:19 INFO - mozversion application_version: 52.0a1 08:07:19 INFO - mozversion platform_buildid: 20161005064400 08:07:19 INFO - mozversion platform_changeset: e8fa13708c070d1fadf488ed9d951464745b4e17 08:07:19 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 08:07:19 INFO - mozversion platform_version: 52.0a1 08:07:19 INFO - using testdate: 1475680039 08:07:19 INFO - actual date: 1475680039 08:07:19 INFO - starting webserver on 'localhost:50109' 08:07:19 INFO - SUITE-START | Running 2 tests 08:07:19 INFO - TEST-START | dromaeo_css 08:07:19 INFO - operating with platform_type : linux_ 08:07:19 INFO - Initialising browser for dromaeo_css test... 08:07:19 INFO - TEST-INFO | started process 3008 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoB0fGS/profile http://localhost:50109/getInfo.html) 08:07:24 INFO - PROCESS | 3008 | __metrics Screen width/height:1600/1200 08:07:24 INFO - PROCESS | 3008 | colorDepth:24 08:07:24 INFO - PROCESS | 3008 | Browser inner width/height: 1024/697 08:07:24 INFO - PROCESS | 3008 | __metrics 08:07:24 INFO - PROCESS | 3008 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:07:24 INFO - PROCESS | 3008 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:07:25 INFO - PROCESS | 3008 | console.error: PushService: 08:07:25 INFO - PROCESS | 3008 | stateChangeProcessEnqueue: Error transitioning state 08:07:25 INFO - PROCESS | 3008 | UnknownError 08:07:25 INFO - TEST-INFO | 3008: exit 0 08:07:25 INFO - Browser initialized. 08:07:25 INFO - Running cycle 1/1 for dromaeo_css test... 08:07:25 INFO - TEST-INFO | started process 3093 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoB0fGS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:07:38 INFO - PROCESS | 3093 | RSS: Main: 175931392 08:07:38 INFO - PROCESS | 3093 | 08:08:29 INFO - PROCESS | 3093 | 1475680109951 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 08:10:43 INFO - PROCESS | 3093 | Cycle 1(1): loaded http://localhost:50109/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50109/tests/dromaeo/cssquery-ext.html) 08:10:44 INFO - PROCESS | 3093 | RSS: Main: 301731840 08:10:44 INFO - PROCESS | 3093 | 08:13:47 INFO - PROCESS | 3093 | Cycle 1(1): loaded http://localhost:50109/tests/dromaeo/cssquery-ext.html (next: http://localhost:50109/tests/dromaeo/cssquery-jquery.html) 08:13:47 INFO - PROCESS | 3093 | RSS: Main: 278302720 08:13:47 INFO - PROCESS | 3093 | 08:16:49 INFO - PROCESS | 3093 | Cycle 1(1): loaded http://localhost:50109/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50109/tests/dromaeo/cssquery-mootools.html) 08:16:50 INFO - PROCESS | 3093 | RSS: Main: 220672000 08:16:50 INFO - PROCESS | 3093 | 08:19:52 INFO - PROCESS | 3093 | Cycle 1(1): loaded http://localhost:50109/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50109/tests/dromaeo/cssquery-prototype.html) 08:19:53 INFO - PROCESS | 3093 | RSS: Main: 219140096 08:19:53 INFO - PROCESS | 3093 | 08:22:56 INFO - PROCESS | 3093 | Cycle 1(1): loaded http://localhost:50109/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50109/tests/dromaeo/cssquery-yui.html) 08:22:57 INFO - PROCESS | 3093 | RSS: Main: 220401664 08:22:57 INFO - PROCESS | 3093 | 08:26:00 INFO - PROCESS | 3093 | Cycle 1(1): loaded http://localhost:50109/tests/dromaeo/cssquery-yui.html (next: http://localhost:50109/tests/dromaeo/cssquery-dojo.html) 08:26:00 INFO - PROCESS | 3093 | RSS: Main: 311275520 08:26:00 INFO - PROCESS | 3093 | 08:26:00 INFO - PROCESS | 3093 | __start_tp_report 08:26:00 INFO - PROCESS | 3093 | _x_x_mozilla_page_load 08:26:00 INFO - PROCESS | 3093 | _x_x_mozilla_page_load_details 08:26:00 INFO - PROCESS | 3093 | |i|pagename|runs| 08:26:00 INFO - PROCESS | 3093 | |0;dojo.html;2575.8583277919715;2595.5198288316665;2600.5189040027594;2625.645537852389;2632.6051092336147;4542.704724192933;4613.630909527238;4643.210654188788;4705.411823522059;4769.284607308901;4603.7237765734;4634.513376095512;4636.2581986882105;4655.534446555343;4685.929711054328;4265.594768497003;4305.3541968704785;4327.502337231212;4327.718698284617;4356.607905288523;4039.737417067896;4346.456692913386;4369.12617476506;4406.71356361837;4454.242778727608;4215.114825886568;4314.482262128565;4324.978375108136;4336.627495958519;4427.734335939854;4255.063885945087;4256.191323648528;4292.399064131024;4306.310990241546;4324.027093903878;4259.91480170398;4273.850415235452;4311.956880431187;4312.482502099737;4325.091730736549;4612.262038073925;4635.513271106519;4654.604358629521;4659.277811939155;4723.267893476516;4898.53463920927;4946.08497427977;4974.228994505857;4980.427250866161;4982.10322142018;4940.456549779521;4952.900941981176;4966.701997880103;4994.925076123861;5030.698158110525;4615.584597386218;4620.930686039712;4623.745693986796;4628.583427491509;4683.531646835289;4976.576990955809;5053;5059.645824792229;5065.746712664352;5126.872088140603;4834.830780922651;4859.489753575895;4867.050925069578;4886.633502487257;4901.191303434894;4924.409070911442;4935.481774413706;4951.950480495221;4953.72754498506;5016.44819069902;4943.777530011158;4985.351904252424;4985.975070124626;5014.448410674823;5046.722430266371;4735.763211839394;4815.879603009953;4828.637852161102;4946.62900282473;4950.133726597903;4294.76378799169;4298.3552467130185;4299.634531064895;4346.8043938022865;4348.043430445297;3711.1649878777057;3734.9439758403646;3742.6818720408523;3785.981070094687;3792.4311353296675;4235.25882970479;4278.743275403485;4282.057947251599;4382.846600368972;4386.407834942242;4998;4998.550130488274;5026.74866256693;5066.822661206914;5080.161773307437;4328.458942632171;4328.913421731548;4337.869863904088;4338.558242368404;4396.736195828261;4397.912041759147;4444.755538445416;4516.119356725473;4521.186186486464;4563.863084107482;4674.439067311944;4697.882552936204;4727.338172655762;4731.739754313546;4764.071006153906;5036.320096787033;5047.646664733434;5050.065737838511;5050.747462626928;5106.412762532208;4637.86086417408;4661.347411362344;4705.247160454311;4720.221163507983;4769.141554520081;4900.191468407673;4922.138625740553;4930.580900623487;4943.3573635427165;4984.476629953948;5009.148444764326;5012.348394708664;5018.899622007612;5019;5083.669561478492;4803.615710743063;4891.315215869852;4902.681325713817;4903.877403064952;4959.900801984012;4830.541098595628;4846.273059041172;4876.268559716071;4886.975565122151;4963.602911767122;4805.207140821725;4805.735684537244;4817.759112044454;4820.30105634674;4887.193613053806;4807.903841923072;4854;4864.148773964613;4921.581665558468;4923.753812309442;4792.9281060784815;4796.760161991956;4811.855644330536;4850.660453768202;4905.533974272438 08:26:00 INFO - PROCESS | 3093 | |1;ext.html;555.9305086864142;559.5411762354868;575.7380391921674;577;577.8815342854715;29340.413191736177;32314;32338;32364.029079127635;32373;31937.73027450474;32957.670423295756;40255.19489610213;41309;41336;7563.962180189092;7677.884831727529;7690.692372305101;7698.03774528184;7699.461037727361;7658.808529786744;7737.961310193441;7743.225677432268;7747.9612601936915;7748.5350878947165;7772;7812.179721129285;7815.335696465807;7816.218378162167;7821.4133939954445;7693.192214817447;7742.225777422269;7753.573553454557;7755.1081625613215;7767.300942915164;7623.771286861403;7650.158482566913;7704.537727736354;7706.113796913371;7711;38966.415503767465;39210.21579568393;39299.60700392988;39319.41020884689;39376.80311598453;2894.6960569140147;3095.613048368954;3161.4467468192975;3283.5238890360765;3408.835389527643;27677.723222767716;27979.580306295422;28500;28768;29044.27389315263;3476.89569312921;3524.859005639771;3616.059824445637;3622.2031153146268;3635.291118231946;248922;249597;250722;251210;251590;51673.48326516687;52041.21938170931;52118;52153.7392313036;52226.73886630619;32180.83909580437;33594.8320258402;33673.15817104592;35299.647003530146;55332;12648;12666.36668166588;12667;12747.872521274854;12751;9693.22454203662;9702.805943881223;9710.465924374086;9712.562934667956;9724.076212759777;18064.548386290448;18093.457196284133;18152.636947261246;18171.909140454478;18209.27162913495;6615.735370585219;6706.396424321834;6740.4270636995425;6891.552049116792;6964.965175174092;780.7969927818694;916.876221710074;928.2666693312343;939.2251392601131;971.7279161834698;27951.58072628912;28561;28657.713422865505;28700.282492937426;29292.560611590845;722.8265216348144;907.5825120444538;933.5005771911995;964.2237998411206;986.5215370545279;14769.18769467668;14837.406503739945;14918.701625967637;15092;15121;369519;371886;372195;372256;373892;49950.500494995315;50451.495485045416;50485;50528.74735626372;50542;1056.144522936424;1094.600470828158;1128.492178519653;1180.4333919718583;1226.5645695778048;27126.864365678044;29395.7060429393;29888.103356899326;30373.39253214879;30522.236944076576;41444;42203.3669494964;42235.577644223165;42350;42363.3645495324;283551;284614;284734;285196;285610;22416.887915560317;23196.18813341525;23216.53566928686;23217.535649287256;25393.74606253914;41406.79296603498;41954.580454196286;42391.57608424;42410.363844542975;43009;35412.46881296834;35560.64439355573;35776.64223357733;35817.46273805947;36123.819380902925;36412.27175456529;36477.81761091178;36503.45244821383;36948;36961.81519092495;35430;35558.11104722299;35621.82189089038;35809.28381432409;35834;31594;32696.70591400713;32896;32950;33194.5020824683;24775.62836557417;24850.627240591042;25039.99040230368;25120.74879251257;25124.371890702878 08:26:00 INFO - PROCESS | 3093 | |2;jquery.html;337.30482563516676;357.97852128872256;359.6152117234559;370.49797524354506;385.8128807528348;12229;13775.242361670103;15127.924360378196;17049.744253836172;17866.82133178668;15957.601059973507;16709.248083836224;17293.481195564153;17404.912975435105;17416.56458588536;4689.460712018119;5087.5421212090905;5111.7987272991;5116.846494605168;5120.155174396239;3617.9638203618024;3816.8091595420256;4970.975145124269;5062.519060689228;5065.316182315396;3803.8478460861534;3836.5012548368813;3932.13493031534;5948.018576934822;5992.910106348409;5974.641521508724;5999.76000959961;6001.009833377488;6019.953215906569;6025.849353766147;6155.138280640714;6558.639274839882;6591.11020012297;6697.263301036882;6703.530752847302;22622.09511619533;23019.42451438711;23065.654015189786;23496.882515587484;23566.87898089163;2101.3800928726064;2280.395695140789;2287.8055365293803;2394.365493144318;2642.735726427361;13782.517611883535;13918.652033699238;13935.651608709763;14143.71712565743;14823.407063717546;1840.2271046160645;1845.2618952419004;1864.2915692037075;1877.5306173456636;1914.7606549181353;80359.33891238504;82311.5884420574;83383.5830820848;83998.58000709958;84478.15521844765;16201;16373.672526549402;16402.507924762278;16615.66768664644;16668.166591670368;28731.2817179568;28815;28831.855840720662;28940.855295723806;29003.274918126794;8400.831983360298;8614.95692521546;8683.52240626759;8833.249173820297;8895.777605559913;7055.9294407056295;7104.3961263293195;7116.181639111568;7305.3425191732995;7321.963390183121;8207;8357.164283571716;8416.705415310556;8460.280876125475;8529.488230706178;3197.840107994591;3365.5961284646;3403.829808509565;3462.8961131166106;3465.878694245689;800.9719659811879;802.297989259398;864.3646919514152;907.9591418386188;918.1186061381148;16339;16612.169391530617;16621.335146594;16663.750043749355;16711.83288167127;818.9303909167668;864.1358641358642;885.7209978856639;905.6151135767273;908.7818923458323;8805.69180078694;9707.466089365153;9714.75713107178;9753.951230243803;9947.55236014381;376434;384180;387330;388211;388888;47279.29081063787;61058.084128738104;67671.66164169148;79286;80503.59748201222;863.0214710185912;879.4195830751673;902.7201567514091;906.1482206725657;909.1499448016126;14962.625934351729;14996.839365085494;15343.309551070452;15477.690446191238;15520.5343839685;35333.82333088421;36158;36578;36892.81553592215;37863.24273514569;46691;48221.75889120532;55224.72387638036;55335.723321383135;55474.44525554854;7189.856202875809;7450.8509829802015;7564.470487066073;7663.463557551141;7865.960670196612;8407.11725268838;10732;11254.493547790205;11360.829587556029;11447.14146439037;9731.708048758548;10063.798724025624;10148.594056237667;10377.377357358582;10705.090067344363;4729.621630269501;7903.051633803981;9600.471974041495;9962.900370996198;10017.39895606266;8203.917960820316;10126.341787783771;10184.949075254577;10363.481825908826;10411.427371494641;7438;7514.586697731677;7554.244575542401;7667.079950405987;7667.769966901002;9283.39657922233;9960.053794889474;10004.649837255953;10194.898051019394;10230.539625717009 08:26:00 INFO - PROCESS | 3093 | |3;mootools.html;1197.9580714674987;1240.8076748104047;1244.9502019919203;1301.948440052596;1666.4917200253917;6602.504812139085;7451.925480745191;7694.807629809257;7699.846003079942;7925.603719814;7680.193579674137;7745.419093567977;7785.299323060924;7794.571298578576;7796.649150788214;2080.635888719479;2093.1627349060345;2097.213544920655;2100.69539916712;2113.8837363944976;2066.5935451211185;2108.641530939744;2133.4986278224605;2146.12009076278;2146.216630929715;2072.2125592274915;2090.2370634718372;2093.0581238442687;2108.3780284816016;2123.352377524854;2037.0527704617425;2057.783932687061;2065.39070974063;2067.638163321413;2068.6173057984247;2020.5251765835017;2036.2771216218177;2059.907304171301;2061.299158286175;2072.108993132952;7736.303732664031;7783.143854176036;7790.45466817323;7791.22087791222;7795.259450352208;4301.376300436419;4468.4414448193975;4471.82112715491;4553.635709143261;4554.2485489894125;2765.2948498132846;2898.7970842041063;2912.956305655417;2930.780191485626;2932.1936467471614;870.2689740617911;890.3544929925816;893.5487578772678;900.3517467423445;907.246985002453;9803.31376803624;9808.705738827917;9815.950920245425;9824.508774561315;9865.753356166082;3564.1267889367273;3633.237020225782;3765.3787125124595;3771.8872932484983;3775.1317197044286;7872.56700881457;7905.881411778828;7918.366530677532;7918.841623167505;7931.603419829101;4344.23975804233;4360.4767427908855;4364.061726728769;4368.7815609219415;4370.409994650745;3671.6328367163605;3788.1476667749534;3985.8604948827233;4072.592740725963;4075.91848163041;3284.540164376989;3347.8493467794005;3463.5670541182353;3466.098814308298;3487.093355727529;1012.3065699995526;1027.4143738069229;1038.5326603028516;1038.5378506564657;1040.7190058684114;676.0771546838628;688.2807466197835;789.1910791438706;825.4469505431375;826.6982551368707;4782.569568738761;4903.299090284072;4939.802407903644;5019.824306149268;5076.670016448993;355.4153417628039;366.6718287133001;366.80192695944424;371.06491641064366;376.1536542778748;3508.368493671164;3602.405603075463;3639.5086663300644;3689.1699367642605;3755.849766009329;9506;9707;9710.660126895526;9718.854217186748;9731.513424328898;9437.292203084797;9532.285078619132;9549.761255968517;9550.37922535033;9555.665551705795;6828.658567071627;7003.439724822002;7016.824579385454;7031.367176953996;7037.120359955005;4969.45336013031;5033.748312584429;5077.949220507895;5165.92251116226;5184.351956005499;8217.137200593852;8230.876536851832;8357.456765310235;8502.234798868132;8508.574571271289;8118.878216826634;8431.747047588582;8654.04805471385;8686.52224127679;8688.348373872112;6817.659117044227;6902.8619427610165;6904.930950690429;6965.44276457872;6986.091808065123;7450.925490745023;7515.473916825769;7524.473286869867;7524.510906791041;7526.548407095592;6495.610263384212;6595.142631457879;6682.231543372574;6878.55289406187;6883.139607549057;6508.056331831953;6509.810938152203;6578.76974305897;6629.46964242869;6645.800625981228;6078.787242446493;6139.815805525842;6145.231846019247;6147.0779383092895;6167.074938759222;4472.195004899149;4578.9771051144535;4636.374089497875;4662.7202367858035;4705.341252224623;4507.5041745408635;4520.954790452053;4655.0457156283555;4665.813367465264;4776.09254241693 08:26:00 INFO - PROCESS | 3093 | |4;prototype.html;287.40363745228655;288.34257892006224;291.30523700973185;295.5271565495208;299.49086552860143;4639.559241872025;4779.761011949402;4788.473267940532;4822.107910036646;4840.273958906166;4574.862754117374;4714.292856071591;4725.87335698936;4734.668573199869;4739.241721324589;3779.7732136071922;3781.45168950502;3785.1104990327253;3791.3365161096835;3798.1644038311597;3576.5529308836394;3584.2473080653094;3779.603141670126;3794.563625183098;3794.582595914447;3703.5926048134684;3721.1069343357535;3731.962680373202;3744.232432351375;3758.552957111518;3731.6193008586997;3742.2328422673286;3744.4008958566633;3746.269477451898;3760.9059773505746;3313.453280208763;3313.7680362374645;3316.557297575562;3320.7177389921885;3325.5676762021026;4553.521880202564;4635.976820115911;4647.326137710047;4659.813607455698;4695.530446955311;4278.930267433142;4284.821674039664;4286.37847512109;4287.506936702288;4289.571042895716;4960;4984.82553110643;4992.600591952635;4998.550420378122;5004.274380214885;3449.189440481485;3596.1369271374942;3612.440071788877;3613.5663720353464;3614.963850361489;5186.974065129688;5199.7140157291715;5201.375834899836;5206.375234971828;5207.427183009866;3704.5369328833895;3708.4622729704042;3709;3712.498812660256;3715.8327875245677;3757.0982964088967;3761.4169803680475;3765.3975363942186;3767.3972164453558;3775.3770627846648;3876.7480113792512;4153.127843152972;4157.3140431829015;4167.353895211375;4271.337942618899;4964.67729597575;4972.925406118911;4974.801007959641;4985.529268865694;5000.449950505442;1172.5251273234353;1204.5121725701106;1221.8045112781913;1243.881831226032;1257.459292504232;847.3771777743353;857.7812657772229;865.2169786343369;866.6273502393905;873.3013589128799;4394.736315821061;4399.394221109272;4418.64650827933;4429.734215946989;4431.091626216617;5086.18621020635;5090.2693084351495;5099.69401835891;5106.15748401517;5110.626986189097;4222.9577704222565;4390.780460976938;4397.890052748707;4418.513963464016;4427.158839820424;2398.760123987587;2419.4314336130997;2422.709274887025;2424.369663887402;2424.5393375258645;4227.661787057028;4230.238557059759;4287.678424118204;4289.313709806478;4305.246581848164;4388.626966707866;4565.817367305337;4598.402207712976;4607.516210797818;4608.585227329557;4225.366195070764;4243.957560424418;4244.766537840386;4250.468691413574;4259.212045771542;4473.485549161888;4502.639788816821;4516.57727815737;4528.977355113335;4530.343100250511;4277.871663850089;4358.0388825029495;4436.556344365537;4473.821047158077;4474.351219073281;4279.465066866642;4282.935755963601;4283.828646854091;4288.335308027136;4293.463317085364;3308.966910330866;3313.7680362375368;3325.3515564464697;3326.168457885529;3332.9666703332655;4515.75163366018;4533.863984080483;4542.318652202196;4551.271796512542;4561.840335588371;4196.832126714898;4339.457567804025;4341.721999890063;4369.7159684621665;4385.517593064824;4358.193734159064;4378.890527736832;4385.956140438555;4392.209402307615;4400.647948164204;4300.290452075373;4318.589733975393;4331.440681354647;4691.437027556579;4830.734309612864;4737.715737055788;4934.753262336941;4990.750462476934;5015.84952451427;5039.420466646383;4887.265020917523;4892.510748925079;4896.192128298933;4902.338184345068;4906.160189928777 08:26:00 INFO - PROCESS | 3093 | |5;yui.html;618.5082859126993;631.6304961597465;632.6330728177658;699.9090118284622;722.5447967780298;12618.747625047505;13688.110272832258;13714.58856234312;13717.97115216359;13728.17630942143;13461.596152115428;14381.209033503153;14538.618831211044;14887.18120503372;14904.18027008514;743.238180864614;761.5354633673455;761.6496411650647;761.6648674583166;761.7524304601;608.8082254089969;624.9250089989185;627.645380360095;629.8677277771674;744.556988591787;653.4543656047206;759.532887274325;798.3453568074152;798.7763426240633;803.8231589050399;795.3796039089519;795.5385876191795;795.6697970342273;795.6817273090752;795.7970717467038;586.6509426890993;586.7564960541371;587.1720873568248;587.4654064801053;587.6151121015741;10594.9470252649;10780;12532.185407948546;13004.934975325157;13045.021623378285;12266.38668066602;12994.28531430771;13313.467461301536;13348.466061357534;13941.581752547338;10603.151747860153;10627.574897004111;10630.255882088257;10684.519196636093;10894.128469722404;3300.884469043596;3325.48454989477;3331.4003479373705;3331.9666803331897;3347.9497807532907;52002.47997520014;53210.73394633041;66538.66730666316;66819.33180668228;67619;10335.22485813552;10475;10534.157267418588;10585.259031867849;10704.1436685065;18423.72364414535;18454.446366609023;18459.815401845808;18521.629567408847;18564.628707425774;6699.263081061079;6704.865902681919;6707.49693772969;6729.8654026919185;6988.231294557595;3412.931741365159;3486.790792552455;3489.8953031409096;3604.5494313210847;3616.9095772605897;2859.1422573227946;2961.644602647653;2977.970220297769;2983.761299096067;2989.7757668174972;472.8014234021719;481.94698583155827;483.8524250103752;489.33694843487274;497.1399478901521;574.1473911241802;604.4729006248501;631.3812463785516;638.5466318913531;656.2223764838586;8131.227533384319;8843.336749743667;9201.629226117675;9219.170274675178;9318.114779095975;572.9541636669056;621.4344946099028;633.7243299164878;634.4892361648917;636.9936300637027;3859.845606175778;3915.334393153171;4027.3958906163725;4029.2747305485295;4118.19695159441;74935.62532187304;76576.61711691406;77337.61331193308;104637;106356;66636;73329.6333518329;76905.6154719234;77417;78472.60763696145;60047.69976150179;65386.67306663531;69002.30997689959;69527.65236173887;70576.64711676408;8281.29608983243;9004.41471304363;9314.627414903329;9472.564037231015;9474;35369.64630353663;43584.78207608942;44921.32618010667;44982;45286.77356613196;54813.725931370085;61830.690846545476;62388.37611623826;62677.68661156665;63961.680191598745;11059.391733454737;11298.039666628429;11417.486213120263;11525.193236473702;12134.635960921187;12180.817287740869;12497;12742.808857867325;13122.868771312547;13365.198088114745;11880.465379058136;12268.32524211177;12298.569550066062;12461.501539938301;12519;11315.886841131813;11361.196166540687;11412.771744564896;11511.42442877836;11967.222130561486;11791.941040294743;12019;12589.24464532131;12765.234085954873;12781.8082728761;9464.810703785748;9505.144536991704;10323.277370583986;10419.42693151884;10483.947580262355;9235.307351948497;10502.264841461025;10525.789484210427;10550.630727924487;10691.251612387057 08:26:00 INFO - PROCESS | 3093 | __end_tp_report 08:26:00 INFO - PROCESS | 3093 | __start_cc_report 08:26:00 INFO - PROCESS | 3093 | _x_x_mozilla_cycle_collect,1195 08:26:00 INFO - PROCESS | 3093 | __end_cc_report 08:26:00 INFO - PROCESS | 3093 | __startTimestamp1475681160330__endTimestamp 08:26:00 INFO - PROCESS | 3093 | 08:26:00 INFO - PROCESS | 3093 | ------- Summary: start ------- 08:26:00 INFO - PROCESS | 3093 | Number of tests: 6 08:26:00 INFO - PROCESS | 3093 | 08:26:00 INFO - PROCESS | 3093 | [#0] dojo.html Cycles:165 Average:4618.46 Median:4735.76 stddev:474.72 (10.0%) stddev-sans-first:448.32 08:26:00 INFO - PROCESS | 3093 | Values: 2575.9 2595.5 2600.5 2625.6 2632.6 4542.7 4613.6 4643.2 4705.4 4769.3 4603.7 4634.5 4636.3 4655.5 4685.9 4265.6 4305.4 4327.5 4327.7 4356.6 4039.7 4346.5 4369.1 4406.7 4454.2 4215.1 4314.5 4325.0 4336.6 4427.7 4255.1 4256.2 4292.4 4306.3 4324.0 4259.9 4273.9 4312.0 4312.5 4325.1 4612.3 4635.5 4654.6 4659.3 4723.3 4898.5 4946.1 4974.2 4980.4 4982.1 4940.5 4952.9 4966.7 4994.9 5030.7 4615.6 4620.9 4623.7 4628.6 4683.5 4976.6 5053.0 5059.6 5065.7 5126.9 4834.8 4859.5 4867.1 4886.6 4901.2 4924.4 4935.5 4952.0 4953.7 5016.4 4943.8 4985.4 4986.0 5014.4 5046.7 4735.8 4815.9 4828.6 4946.6 4950.1 4294.8 4298.4 4299.6 4346.8 4348.0 3711.2 3734.9 3742.7 3786.0 3792.4 4235.3 4278.7 4282.1 4382.8 4386.4 4998.0 4998.6 5026.7 5066.8 5080.2 4328.5 4328.9 4337.9 4338.6 4396.7 4397.9 4444.8 4516.1 4521.2 4563.9 4674.4 4697.9 4727.3 4731.7 4764.1 5036.3 5047.6 5050.1 5050.7 5106.4 4637.9 4661.3 4705.2 4720.2 4769.1 4900.2 4922.1 4930.6 4943.4 4984.5 5009.1 5012.3 5018.9 5019.0 5083.7 4803.6 4891.3 4902.7 4903.9 4959.9 4830.5 4846.3 4876.3 4887.0 4963.6 4805.2 4805.7 4817.8 4820.3 4887.2 4807.9 4854.0 4864.1 4921.6 4923.8 4792.9 4796.8 4811.9 4850.7 4905.5 08:26:00 INFO - PROCESS | 3093 | 08:26:00 INFO - PROCESS | 3093 | [#1] ext.html Cycles:180 Average:45202.05 Median:20023.78 stddev:80620.96 (402.6%) stddev-sans-first:80777.43 08:26:00 INFO - PROCESS | 3093 | Values: 555.9 559.5 575.7 577.0 577.9 29340.4 32314.0 32338.0 32364.0 32373.0 31937.7 32957.7 40255.2 41309.0 41336.0 7564.0 7677.9 7690.7 7698.0 7699.5 7658.8 7738.0 7743.2 7748.0 7748.5 7772.0 7812.2 7815.3 7816.2 7821.4 7693.2 7742.2 7753.6 7755.1 7767.3 7623.8 7650.2 7704.5 7706.1 7711.0 38966.4 39210.2 39299.6 39319.4 39376.8 2894.7 3095.6 3161.4 3283.5 3408.8 27677.7 27979.6 28500.0 28768.0 29044.3 3476.9 3524.9 3616.1 3622.2 3635.3 248922.0 249597.0 250722.0 251210.0 251590.0 51673.5 52041.2 52118.0 52153.7 52226.7 32180.8 33594.8 33673.2 35299.6 55332.0 12648.0 12666.4 12667.0 12747.9 12751.0 9693.2 9702.8 9710.5 9712.6 9724.1 18064.5 18093.5 18152.6 18171.9 18209.3 6615.7 6706.4 6740.4 6891.6 6965.0 780.8 916.9 928.3 939.2 971.7 27951.6 28561.0 28657.7 28700.3 29292.6 722.8 907.6 933.5 964.2 986.5 14769.2 14837.4 14918.7 15092.0 15121.0 369519.0 371886.0 372195.0 372256.0 373892.0 49950.5 50451.5 50485.0 50528.7 50542.0 1056.1 1094.6 1128.5 1180.4 1226.6 27126.9 29395.7 29888.1 30373.4 30522.2 41444.0 42203.4 42235.6 42350.0 42363.4 283551.0 284614.0 284734.0 285196.0 285610.0 22416.9 23196.2 23216.5 23217.5 25393.7 41406.8 41954.6 42391.6 42410.4 43009.0 35412.5 35560.6 35776.6 35817.5 36123.8 36412.3 36477.8 36503.5 36948.0 36961.8 35430.0 35558.1 35621.8 35809.3 35834.0 31594.0 32696.7 32896.0 32950.0 33194.5 24775.6 24850.6 25040.0 25120.7 25124.4 08:26:00 INFO - PROCESS | 3093 | 08:26:00 INFO - PROCESS | 3093 | [#2] jquery.html Cycles:180 Average:25162.17 Median:25311.57 stddev:63644.18 (251.4%) stddev-sans-first:63795.42 08:26:00 INFO - PROCESS | 3093 | Values: 337.3 358.0 359.6 370.5 385.8 12229.0 13775.2 15127.9 17049.7 17866.8 15957.6 16709.2 17293.5 17404.9 17416.6 4689.5 5087.5 5111.8 5116.8 5120.2 3618.0 3816.8 4971.0 5062.5 5065.3 3803.8 3836.5 3932.1 5948.0 5992.9 5974.6 5999.8 6001.0 6020.0 6025.8 6155.1 6558.6 6591.1 6697.3 6703.5 22622.1 23019.4 23065.7 23496.9 23566.9 2101.4 2280.4 2287.8 2394.4 2642.7 13782.5 13918.7 13935.7 14143.7 14823.4 1840.2 1845.3 1864.3 1877.5 1914.8 80359.3 82311.6 83383.6 83998.6 84478.2 16201.0 16373.7 16402.5 16615.7 16668.2 28731.3 28815.0 28831.9 28940.9 29003.3 8400.8 8615.0 8683.5 8833.2 8895.8 7055.9 7104.4 7116.2 7305.3 7322.0 8207.0 8357.2 8416.7 8460.3 8529.5 3197.8 3365.6 3403.8 3462.9 3465.9 801.0 802.3 864.4 908.0 918.1 16339.0 16612.2 16621.3 16663.8 16711.8 818.9 864.1 885.7 905.6 908.8 8805.7 9707.5 9714.8 9754.0 9947.6 376434.0 384180.0 387330.0 388211.0 388888.0 47279.3 61058.1 67671.7 79286.0 80503.6 863.0 879.4 902.7 906.1 909.1 14962.6 14996.8 15343.3 15477.7 15520.5 35333.8 36158.0 36578.0 36892.8 37863.2 46691.0 48221.8 55224.7 55335.7 55474.4 7189.9 7450.9 7564.5 7663.5 7866.0 8407.1 10732.0 11254.5 11360.8 11447.1 9731.7 10063.8 10148.6 10377.4 10705.1 4729.6 7903.1 9600.5 9962.9 10017.4 8203.9 10126.3 10184.9 10363.5 10411.4 7438.0 7514.6 7554.2 7667.1 7667.8 9283.4 9960.1 10004.6 10194.9 10230.5 08:26:00 INFO - PROCESS | 3093 | 08:26:00 INFO - PROCESS | 3093 | [#3] mootools.html Cycles:180 Average:4947.61 Median:5055.21 stddev:2800.83 (55.4%) stddev-sans-first:2794.51 08:26:00 INFO - PROCESS | 3093 | Values: 1198.0 1240.8 1245.0 1301.9 1666.5 6602.5 7451.9 7694.8 7699.8 7925.6 7680.2 7745.4 7785.3 7794.6 7796.6 2080.6 2093.2 2097.2 2100.7 2113.9 2066.6 2108.6 2133.5 2146.1 2146.2 2072.2 2090.2 2093.1 2108.4 2123.4 2037.1 2057.8 2065.4 2067.6 2068.6 2020.5 2036.3 2059.9 2061.3 2072.1 7736.3 7783.1 7790.5 7791.2 7795.3 4301.4 4468.4 4471.8 4553.6 4554.2 2765.3 2898.8 2913.0 2930.8 2932.2 870.3 890.4 893.5 900.4 907.2 9803.3 9808.7 9816.0 9824.5 9865.8 3564.1 3633.2 3765.4 3771.9 3775.1 7872.6 7905.9 7918.4 7918.8 7931.6 4344.2 4360.5 4364.1 4368.8 4370.4 3671.6 3788.1 3985.9 4072.6 4075.9 3284.5 3347.8 3463.6 3466.1 3487.1 1012.3 1027.4 1038.5 1038.5 1040.7 676.1 688.3 789.2 825.4 826.7 4782.6 4903.3 4939.8 5019.8 5076.7 355.4 366.7 366.8 371.1 376.2 3508.4 3602.4 3639.5 3689.2 3755.8 9506.0 9707.0 9710.7 9718.9 9731.5 9437.3 9532.3 9549.8 9550.4 9555.7 6828.7 7003.4 7016.8 7031.4 7037.1 4969.5 5033.7 5077.9 5165.9 5184.4 8217.1 8230.9 8357.5 8502.2 8508.6 8118.9 8431.7 8654.0 8686.5 8688.3 6817.7 6902.9 6904.9 6965.4 6986.1 7450.9 7515.5 7524.5 7524.5 7526.5 6495.6 6595.1 6682.2 6878.6 6883.1 6508.1 6509.8 6578.8 6629.5 6645.8 6078.8 6139.8 6145.2 6147.1 6167.1 4472.2 4579.0 4636.4 4662.7 4705.3 4507.5 4521.0 4655.0 4665.8 4776.1 08:26:00 INFO - PROCESS | 3093 | 08:26:00 INFO - PROCESS | 3093 | [#4] prototype.html Cycles:180 Average:3968.92 Median:4335.45 stddev:1125.47 (26.0%) stddev-sans-first:1094.18 08:26:00 INFO - PROCESS | 3093 | Values: 287.4 288.3 291.3 295.5 299.5 4639.6 4779.8 4788.5 4822.1 4840.3 4574.9 4714.3 4725.9 4734.7 4739.2 3779.8 3781.5 3785.1 3791.3 3798.2 3576.6 3584.2 3779.6 3794.6 3794.6 3703.6 3721.1 3732.0 3744.2 3758.6 3731.6 3742.2 3744.4 3746.3 3760.9 3313.5 3313.8 3316.6 3320.7 3325.6 4553.5 4636.0 4647.3 4659.8 4695.5 4278.9 4284.8 4286.4 4287.5 4289.6 4960.0 4984.8 4992.6 4998.6 5004.3 3449.2 3596.1 3612.4 3613.6 3615.0 5187.0 5199.7 5201.4 5206.4 5207.4 3704.5 3708.5 3709.0 3712.5 3715.8 3757.1 3761.4 3765.4 3767.4 3775.4 3876.7 4153.1 4157.3 4167.4 4271.3 4964.7 4972.9 4974.8 4985.5 5000.4 1172.5 1204.5 1221.8 1243.9 1257.5 847.4 857.8 865.2 866.6 873.3 4394.7 4399.4 4418.6 4429.7 4431.1 5086.2 5090.3 5099.7 5106.2 5110.6 4223.0 4390.8 4397.9 4418.5 4427.2 2398.8 2419.4 2422.7 2424.4 2424.5 4227.7 4230.2 4287.7 4289.3 4305.2 4388.6 4565.8 4598.4 4607.5 4608.6 4225.4 4244.0 4244.8 4250.5 4259.2 4473.5 4502.6 4516.6 4529.0 4530.3 4277.9 4358.0 4436.6 4473.8 4474.4 4279.5 4282.9 4283.8 4288.3 4293.5 3309.0 3313.8 3325.4 3326.2 3333.0 4515.8 4533.9 4542.3 4551.3 4561.8 4196.8 4339.5 4341.7 4369.7 4385.5 4358.2 4378.9 4386.0 4392.2 4400.6 4300.3 4318.6 4331.4 4691.4 4830.7 4737.7 4934.8 4990.8 5015.8 5039.4 4887.3 4892.5 4896.2 4902.3 4906.2 08:26:00 INFO - PROCESS | 3093 | 08:26:00 INFO - PROCESS | 3093 | [#5] yui.html Cycles:180 Average:17021.38 Median:44253.05 stddev:23312.75 (52.7%) stddev-sans-first:23345.61 08:26:00 INFO - PROCESS | 3093 | Values: 618.5 631.6 632.6 699.9 722.5 12618.7 13688.1 13714.6 13718.0 13728.2 13461.6 14381.2 14538.6 14887.2 14904.2 743.2 761.5 761.6 761.7 761.8 608.8 624.9 627.6 629.9 744.6 653.5 759.5 798.3 798.8 803.8 795.4 795.5 795.7 795.7 795.8 586.7 586.8 587.2 587.5 587.6 10594.9 10780.0 12532.2 13004.9 13045.0 12266.4 12994.3 13313.5 13348.5 13941.6 10603.2 10627.6 10630.3 10684.5 10894.1 3300.9 3325.5 3331.4 3332.0 3347.9 52002.5 53210.7 66538.7 66819.3 67619.0 10335.2 10475.0 10534.2 10585.3 10704.1 18423.7 18454.4 18459.8 18521.6 18564.6 6699.3 6704.9 6707.5 6729.9 6988.2 3412.9 3486.8 3489.9 3604.5 3616.9 2859.1 2961.6 2978.0 2983.8 2989.8 472.8 481.9 483.9 489.3 497.1 574.1 604.5 631.4 638.5 656.2 8131.2 8843.3 9201.6 9219.2 9318.1 573.0 621.4 633.7 634.5 637.0 3859.8 3915.3 4027.4 4029.3 4118.2 74935.6 76576.6 77337.6 104637.0 106356.0 66636.0 73329.6 76905.6 77417.0 78472.6 60047.7 65386.7 69002.3 69527.7 70576.6 8281.3 9004.4 9314.6 9472.6 9474.0 35369.6 43584.8 44921.3 44982.0 45286.8 54813.7 61830.7 62388.4 62677.7 63961.7 11059.4 11298.0 11417.5 11525.2 12134.6 12180.8 12497.0 12742.8 13122.9 13365.2 11880.5 12268.3 12298.6 12461.5 12519.0 11315.9 11361.2 11412.8 11511.4 11967.2 11791.9 12019.0 12589.2 12765.2 12781.8 9464.8 9505.1 10323.3 10419.4 10483.9 9235.3 10502.3 10525.8 10550.6 10691.3 08:26:00 INFO - PROCESS | 3093 | -------- Summary: end -------- 08:26:00 INFO - PROCESS | 3093 | 08:26:01 INFO - TEST-INFO | 3093: exit 0 08:26:01 INFO - TEST-OK | dromaeo_css | took 1121501ms 08:26:01 INFO - TEST-START | kraken 08:26:01 INFO - operating with platform_type : linux_ 08:26:01 INFO - Initialising browser for kraken test... 08:26:01 INFO - TEST-INFO | started process 3400 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHDqKZ3/profile http://localhost:50109/getInfo.html) 08:26:05 INFO - PROCESS | 3400 | __metrics Screen width/height:1600/1200 08:26:05 INFO - PROCESS | 3400 | colorDepth:24 08:26:05 INFO - PROCESS | 3400 | Browser inner width/height: 1024/697 08:26:05 INFO - PROCESS | 3400 | __metrics 08:26:06 INFO - PROCESS | 3400 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:26:06 INFO - PROCESS | 3400 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:26:06 INFO - PROCESS | 3400 | console.error: PushService: 08:26:06 INFO - PROCESS | 3400 | stateChangeProcessEnqueue: Error transitioning state 08:26:06 INFO - PROCESS | 3400 | UnknownError 08:26:07 INFO - TEST-INFO | 3400: exit 0 08:26:07 INFO - Browser initialized. 08:26:07 INFO - Running cycle 1/1 for kraken test... 08:26:07 INFO - TEST-INFO | started process 3482 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHDqKZ3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:26:19 INFO - PROCESS | 3482 | RSS: Main: 176291840 08:26:19 INFO - PROCESS | 3482 | 08:26:22 INFO - PROCESS | 3482 | Cycle 1(1): loaded http://localhost:50109/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50109/tests/kraken/driver.html?testName=audio-beat-detection) 08:26:23 INFO - PROCESS | 3482 | RSS: Main: 233844736 08:26:23 INFO - PROCESS | 3482 | 08:26:26 INFO - PROCESS | 3482 | Cycle 1(1): loaded http://localhost:50109/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50109/tests/kraken/driver.html?testName=audio-dft) 08:26:26 INFO - PROCESS | 3482 | RSS: Main: 218976256 08:26:26 INFO - PROCESS | 3482 | 08:26:30 INFO - PROCESS | 3482 | Cycle 1(1): loaded http://localhost:50109/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50109/tests/kraken/driver.html?testName=audio-fft) 08:26:30 INFO - PROCESS | 3482 | RSS: Main: 301527040 08:26:30 INFO - PROCESS | 3482 | 08:26:32 INFO - PROCESS | 3482 | Cycle 1(1): loaded http://localhost:50109/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50109/tests/kraken/driver.html?testName=audio-oscillator) 08:26:33 INFO - PROCESS | 3482 | RSS: Main: 211947520 08:26:33 INFO - PROCESS | 3482 | 08:26:35 INFO - PROCESS | 3482 | Cycle 1(1): loaded http://localhost:50109/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50109/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:26:36 INFO - PROCESS | 3482 | RSS: Main: 214638592 08:26:36 INFO - PROCESS | 3482 | 08:26:39 INFO - PROCESS | 3482 | Cycle 1(1): loaded http://localhost:50109/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50109/tests/kraken/driver.html?testName=imaging-darkroom) 08:26:40 INFO - PROCESS | 3482 | RSS: Main: 250769408 08:26:40 INFO - PROCESS | 3482 | 08:26:43 INFO - PROCESS | 3482 | Cycle 1(1): loaded http://localhost:50109/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50109/tests/kraken/driver.html?testName=imaging-desaturate) 08:26:44 INFO - PROCESS | 3482 | RSS: Main: 249151488 08:26:44 INFO - PROCESS | 3482 | 08:26:47 INFO - PROCESS | 3482 | Cycle 1(1): loaded http://localhost:50109/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50109/tests/kraken/driver.html?testName=json-parse-financial) 08:26:47 INFO - PROCESS | 3482 | RSS: Main: 249249792 08:26:47 INFO - PROCESS | 3482 | 08:26:49 INFO - PROCESS | 3482 | Cycle 1(1): loaded http://localhost:50109/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50109/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:26:50 INFO - PROCESS | 3482 | RSS: Main: 211496960 08:26:50 INFO - PROCESS | 3482 | 08:26:52 INFO - PROCESS | 3482 | Cycle 1(1): loaded http://localhost:50109/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50109/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:26:52 INFO - PROCESS | 3482 | RSS: Main: 218652672 08:26:52 INFO - PROCESS | 3482 | 08:26:54 INFO - PROCESS | 3482 | Cycle 1(1): loaded http://localhost:50109/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50109/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:26:55 INFO - PROCESS | 3482 | RSS: Main: 227905536 08:26:55 INFO - PROCESS | 3482 | 08:26:58 INFO - PROCESS | 3482 | Cycle 1(1): loaded http://localhost:50109/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50109/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:26:59 INFO - PROCESS | 3482 | RSS: Main: 237555712 08:26:59 INFO - PROCESS | 3482 | 08:27:02 INFO - PROCESS | 3482 | Cycle 1(1): loaded http://localhost:50109/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50109/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:27:02 INFO - PROCESS | 3482 | RSS: Main: 233971712 08:27:02 INFO - PROCESS | 3482 | 08:27:04 INFO - PROCESS | 3482 | Cycle 1(1): loaded http://localhost:50109/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50109/tests/kraken/driver.html?testName=ai-astar) 08:27:04 INFO - PROCESS | 3482 | RSS: Main: 284577792 08:27:04 INFO - PROCESS | 3482 | 08:27:04 INFO - PROCESS | 3482 | __start_tp_report 08:27:04 INFO - PROCESS | 3482 | _x_x_mozilla_page_load 08:27:04 INFO - PROCESS | 3482 | _x_x_mozilla_page_load_details 08:27:04 INFO - PROCESS | 3482 | |i|pagename|runs| 08:27:04 INFO - PROCESS | 3482 | |0;ai-astar;116;116;117;116;116;118;115;118;117;116 08:27:04 INFO - PROCESS | 3482 | |1;audio-beat-detection;151;130;129;176;128;135;133;131;165;131 08:27:04 INFO - PROCESS | 3482 | |2;audio-dft;161;161;161;162;161;162;162;161;162;161 08:27:04 INFO - PROCESS | 3482 | |3;audio-fft;77;77;77;101;76;77;78;78;103;78 08:27:04 INFO - PROCESS | 3482 | |4;audio-oscillator;85;84;109;83;83;83;116;83;83;123 08:27:04 INFO - PROCESS | 3482 | |5;imaging-gaussian-blur;117;117;117;117;117;118;118;116;116;117 08:27:04 INFO - PROCESS | 3482 | |6;imaging-darkroom;146;146;147;146;146;146;146;146;145;147 08:27:04 INFO - PROCESS | 3482 | |7;imaging-desaturate;95;95;94;94;95;95;96;94;95;95 08:27:04 INFO - PROCESS | 3482 | |8;json-parse-financial;65;62;62;63;64;63;64;64;71;64 08:27:04 INFO - PROCESS | 3482 | |9;json-stringify-tinderbox;66;66;67;67;67;66;67;67;67;67 08:27:04 INFO - PROCESS | 3482 | |10;stanford-crypto-aes;83;83;90;85;83;84;84;84;83;82 08:27:04 INFO - PROCESS | 3482 | |11;stanford-crypto-ccm;139;136;140;138;141;139;139;144;178;136 08:27:04 INFO - PROCESS | 3482 | |12;stanford-crypto-pbkdf2;176;174;177;175;181;180;177;175;173;172 08:27:04 INFO - PROCESS | 3482 | |13;stanford-crypto-sha256-iterative;73;73;70;70;69;74;70;73;70;69 08:27:04 INFO - PROCESS | 3482 | __end_tp_report 08:27:04 INFO - PROCESS | 3482 | __start_cc_report 08:27:04 INFO - PROCESS | 3482 | _x_x_mozilla_cycle_collect,1985 08:27:04 INFO - PROCESS | 3482 | __end_cc_report 08:27:04 INFO - PROCESS | 3482 | __startTimestamp1475681224705__endTimestamp 08:27:04 INFO - PROCESS | 3482 | 08:27:04 INFO - PROCESS | 3482 | ------- Summary: start ------- 08:27:04 INFO - PROCESS | 3482 | Number of tests: 14 08:27:04 INFO - PROCESS | 3482 | 08:27:04 INFO - PROCESS | 3482 | [#0] ai-astar Cycles:10 Average:116.50 Median:116.50 stddev:0.97 (0.8%) stddev-sans-first:1.01 08:27:04 INFO - PROCESS | 3482 | Values: 116.0 116.0 117.0 116.0 116.0 118.0 115.0 118.0 117.0 116.0 08:27:04 INFO - PROCESS | 3482 | 08:27:04 INFO - PROCESS | 3482 | [#1] audio-beat-detection Cycles:10 Average:140.90 Median:134.00 stddev:17.11 (12.8%) stddev-sans-first:17.75 08:27:04 INFO - PROCESS | 3482 | Values: 151.0 130.0 129.0 176.0 128.0 135.0 133.0 131.0 165.0 131.0 08:27:04 INFO - PROCESS | 3482 | 08:27:04 INFO - PROCESS | 3482 | [#2] audio-dft Cycles:10 Average:161.40 Median:161.50 stddev:0.52 (0.3%) stddev-sans-first:0.53 08:27:04 INFO - PROCESS | 3482 | Values: 161.0 161.0 161.0 162.0 161.0 162.0 162.0 161.0 162.0 161.0 08:27:04 INFO - PROCESS | 3482 | 08:27:04 INFO - PROCESS | 3482 | [#3] audio-fft Cycles:10 Average:82.20 Median:77.00 stddev:10.46 (13.6%) stddev-sans-first:10.93 08:27:04 INFO - PROCESS | 3482 | Values: 77.0 77.0 77.0 101.0 76.0 77.0 78.0 78.0 103.0 78.0 08:27:04 INFO - PROCESS | 3482 | 08:27:04 INFO - PROCESS | 3482 | [#4] audio-oscillator Cycles:10 Average:93.20 Median:83.00 stddev:16.09 (19.4%) stddev-sans-first:16.79 08:27:04 INFO - PROCESS | 3482 | Values: 85.0 84.0 109.0 83.0 83.0 83.0 116.0 83.0 83.0 123.0 08:27:04 INFO - PROCESS | 3482 | 08:27:04 INFO - PROCESS | 3482 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 08:27:04 INFO - PROCESS | 3482 | Values: 117.0 117.0 117.0 117.0 117.0 118.0 118.0 116.0 116.0 117.0 08:27:04 INFO - PROCESS | 3482 | 08:27:04 INFO - PROCESS | 3482 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 08:27:04 INFO - PROCESS | 3482 | Values: 146.0 146.0 147.0 146.0 146.0 146.0 146.0 146.0 145.0 147.0 08:27:04 INFO - PROCESS | 3482 | 08:27:04 INFO - PROCESS | 3482 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 08:27:04 INFO - PROCESS | 3482 | Values: 95.0 95.0 94.0 94.0 95.0 95.0 96.0 94.0 95.0 95.0 08:27:04 INFO - PROCESS | 3482 | 08:27:04 INFO - PROCESS | 3482 | [#8] json-parse-financial Cycles:10 Average:64.20 Median:64.00 stddev:2.57 (4.0%) stddev-sans-first:2.71 08:27:04 INFO - PROCESS | 3482 | Values: 65.0 62.0 62.0 63.0 64.0 63.0 64.0 64.0 71.0 64.0 08:27:04 INFO - PROCESS | 3482 | 08:27:04 INFO - PROCESS | 3482 | [#9] json-stringify-tinderbox Cycles:10 Average:66.70 Median:67.00 stddev:0.48 (0.7%) stddev-sans-first:0.44 08:27:04 INFO - PROCESS | 3482 | Values: 66.0 66.0 67.0 67.0 67.0 66.0 67.0 67.0 67.0 67.0 08:27:04 INFO - PROCESS | 3482 | 08:27:04 INFO - PROCESS | 3482 | [#10] stanford-crypto-aes Cycles:10 Average:84.10 Median:84.00 stddev:2.23 (2.7%) stddev-sans-first:2.33 08:27:04 INFO - PROCESS | 3482 | Values: 83.0 83.0 90.0 85.0 83.0 84.0 84.0 84.0 83.0 82.0 08:27:04 INFO - PROCESS | 3482 | 08:27:04 INFO - PROCESS | 3482 | [#11] stanford-crypto-ccm Cycles:10 Average:143.00 Median:139.50 stddev:12.52 (9.0%) stddev-sans-first:13.19 08:27:04 INFO - PROCESS | 3482 | Values: 139.0 136.0 140.0 138.0 141.0 139.0 139.0 144.0 178.0 136.0 08:27:04 INFO - PROCESS | 3482 | 08:27:04 INFO - PROCESS | 3482 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.00 Median:176.50 stddev:2.87 (1.6%) stddev-sans-first:3.04 08:27:04 INFO - PROCESS | 3482 | Values: 176.0 174.0 177.0 175.0 181.0 180.0 177.0 175.0 173.0 172.0 08:27:04 INFO - PROCESS | 3482 | 08:27:04 INFO - PROCESS | 3482 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.10 Median:71.50 stddev:1.91 (2.7%) stddev-sans-first:1.90 08:27:04 INFO - PROCESS | 3482 | Values: 73.0 73.0 70.0 70.0 69.0 74.0 70.0 73.0 70.0 69.0 08:27:04 INFO - PROCESS | 3482 | -------- Summary: end -------- 08:27:04 INFO - PROCESS | 3482 | 08:27:06 INFO - TEST-INFO | 3482: exit 0 08:27:06 INFO - TEST-OK | kraken | took 64808ms 08:27:06 INFO - SUITE-END | took 1186s 08:27:06 INFO - Completed test suite (00:19:46) 08:27:06 INFO - javascript benchmark 08:27:06 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2575.8583277919715, 2595.5198288316665, 2600.5189040027594, 2625.645537852389, 2632.6051092336147, 4542.704724192933, 4613.630909527238, 4643.210654188788, 4705.411823522059, 4769.284607308901, 4603.7237765734, 4634.513376095512, 4636.2581986882105, 4655.534446555343, 4685.929711054328, 4265.594768497003, 4305.3541968704785, 4327.502337231212, 4327.718698284617, 4356.607905288523, 4039.737417067896, 4346.456692913386, 4369.12617476506, 4406.71356361837, 4454.242778727608, 4215.114825886568, 4314.482262128565, 4324.978375108136, 4336.627495958519, 4427.734335939854, 4255.063885945087, 4256.191323648528, 4292.399064131024, 4306.310990241546, 4324.027093903878, 4259.91480170398, 4273.850415235452, 4311.956880431187, 4312.482502099737, 4325.091730736549, 4612.262038073925, 4635.513271106519, 4654.604358629521, 4659.277811939155, 4723.267893476516, 4898.53463920927, 4946.08497427977, 4974.228994505857, 4980.427250866161, 4982.10322142018, 4940.456549779521, 4952.900941981176, 4966.701997880103, 4994.925076123861, 5030.698158110525, 4615.584597386218, 4620.930686039712, 4623.745693986796, 4628.583427491509, 4683.531646835289, 4976.576990955809, 5053.0, 5059.645824792229, 5065.746712664352, 5126.872088140603, 4834.830780922651, 4859.489753575895, 4867.050925069578, 4886.633502487257, 4901.191303434894, 4924.409070911442, 4935.481774413706, 4951.950480495221, 4953.72754498506, 5016.44819069902, 4943.777530011158, 4985.351904252424, 4985.975070124626, 5014.448410674823, 5046.722430266371, 4735.763211839394, 4815.879603009953, 4828.637852161102, 4946.62900282473, 4950.133726597903, 4294.76378799169, 4298.3552467130185, 4299.634531064895, 4346.8043938022865, 4348.043430445297, 3711.1649878777057, 3734.9439758403646, 3742.6818720408523, 3785.981070094687, 3792.4311353296675, 4235.25882970479, 4278.743275403485, 4282.057947251599, 4382.846600368972, 4386.407834942242, 4998.0, 4998.550130488274, 5026.74866256693, 5066.822661206914, 5080.161773307437, 4328.458942632171, 4328.913421731548, 4337.869863904088, 4338.558242368404, 4396.736195828261, 4397.912041759147, 4444.755538445416, 4516.119356725473, 4521.186186486464, 4563.863084107482, 4674.439067311944, 4697.882552936204, 4727.338172655762, 4731.739754313546, 4764.071006153906, 5036.320096787033, 5047.646664733434, 5050.065737838511, 5050.747462626928, 5106.412762532208, 4637.86086417408, 4661.347411362344, 4705.247160454311, 4720.221163507983, 4769.141554520081, 4900.191468407673, 4922.138625740553, 4930.580900623487, 4943.3573635427165, 4984.476629953948, 5009.148444764326, 5012.348394708664, 5018.899622007612, 5019.0, 5083.669561478492, 4803.615710743063, 4891.315215869852, 4902.681325713817, 4903.877403064952, 4959.900801984012, 4830.541098595628, 4846.273059041172, 4876.268559716071, 4886.975565122151, 4963.602911767122, 4805.207140821725, 4805.735684537244, 4817.759112044454, 4820.30105634674, 4887.193613053806, 4807.903841923072, 4854.0, 4864.148773964613, 4921.581665558468, 4923.753812309442, 4792.9281060784815, 4796.760161991956, 4811.855644330536, 4850.660453768202, 4905.533974272438], "value": 4588.557231591501, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [555.9305086864142, 559.5411762354868, 575.7380391921674, 577.0, 577.8815342854715, 29340.413191736177, 32314.0, 32338.0, 32364.029079127635, 32373.0, 31937.73027450474, 32957.670423295756, 40255.19489610213, 41309.0, 41336.0, 7563.962180189092, 7677.884831727529, 7690.692372305101, 7698.03774528184, 7699.461037727361, 7658.808529786744, 7737.961310193441, 7743.225677432268, 7747.9612601936915, 7748.5350878947165, 7772.0, 7812.179721129285, 7815.335696465807, 7816.218378162167, 7821.4133939954445, 7693.192214817447, 7742.225777422269, 7753.573553454557, 7755.1081625613215, 7767.300942915164, 7623.771286861403, 7650.158482566913, 7704.537727736354, 7706.113796913371, 7711.0, 38966.415503767465, 39210.21579568393, 39299.60700392988, 39319.41020884689, 39376.80311598453, 2894.6960569140147, 3095.613048368954, 3161.4467468192975, 3283.5238890360765, 3408.835389527643, 27677.723222767716, 27979.580306295422, 28500.0, 28768.0, 29044.27389315263, 3476.89569312921, 3524.859005639771, 3616.059824445637, 3622.2031153146268, 3635.291118231946, 248922.0, 249597.0, 250722.0, 251210.0, 251590.0, 51673.48326516687, 52041.21938170931, 52118.0, 52153.7392313036, 52226.73886630619, 32180.83909580437, 33594.8320258402, 33673.15817104592, 35299.647003530146, 55332.0, 12648.0, 12666.36668166588, 12667.0, 12747.872521274854, 12751.0, 9693.22454203662, 9702.805943881223, 9710.465924374086, 9712.562934667956, 9724.076212759777, 18064.548386290448, 18093.457196284133, 18152.636947261246, 18171.909140454478, 18209.27162913495, 6615.735370585219, 6706.396424321834, 6740.4270636995425, 6891.552049116792, 6964.965175174092, 780.7969927818694, 916.876221710074, 928.2666693312343, 939.2251392601131, 971.7279161834698, 27951.58072628912, 28561.0, 28657.713422865505, 28700.282492937426, 29292.560611590845, 722.8265216348144, 907.5825120444538, 933.5005771911995, 964.2237998411206, 986.5215370545279, 14769.18769467668, 14837.406503739945, 14918.701625967637, 15092.0, 15121.0, 369519.0, 371886.0, 372195.0, 372256.0, 373892.0, 49950.500494995315, 50451.495485045416, 50485.0, 50528.74735626372, 50542.0, 1056.144522936424, 1094.600470828158, 1128.492178519653, 1180.4333919718583, 1226.5645695778048, 27126.864365678044, 29395.7060429393, 29888.103356899326, 30373.39253214879, 30522.236944076576, 41444.0, 42203.3669494964, 42235.577644223165, 42350.0, 42363.3645495324, 283551.0, 284614.0, 284734.0, 285196.0, 285610.0, 22416.887915560317, 23196.18813341525, 23216.53566928686, 23217.535649287256, 25393.74606253914, 41406.79296603498, 41954.580454196286, 42391.57608424, 42410.363844542975, 43009.0, 35412.46881296834, 35560.64439355573, 35776.64223357733, 35817.46273805947, 36123.819380902925, 36412.27175456529, 36477.81761091178, 36503.45244821383, 36948.0, 36961.81519092495, 35430.0, 35558.11104722299, 35621.82189089038, 35809.28381432409, 35834.0, 31594.0, 32696.70591400713, 32896.0, 32950.0, 33194.5020824683, 24775.62836557417, 24850.627240591042, 25039.99040230368, 25120.74879251257, 25124.371890702878], "value": 16949.29194854578, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [337.30482563516676, 357.97852128872256, 359.6152117234559, 370.49797524354506, 385.8128807528348, 12229.0, 13775.242361670103, 15127.924360378196, 17049.744253836172, 17866.82133178668, 15957.601059973507, 16709.248083836224, 17293.481195564153, 17404.912975435105, 17416.56458588536, 4689.460712018119, 5087.5421212090905, 5111.7987272991, 5116.846494605168, 5120.155174396239, 3617.9638203618024, 3816.8091595420256, 4970.975145124269, 5062.519060689228, 5065.316182315396, 3803.8478460861534, 3836.5012548368813, 3932.13493031534, 5948.018576934822, 5992.910106348409, 5974.641521508724, 5999.76000959961, 6001.009833377488, 6019.953215906569, 6025.849353766147, 6155.138280640714, 6558.639274839882, 6591.11020012297, 6697.263301036882, 6703.530752847302, 22622.09511619533, 23019.42451438711, 23065.654015189786, 23496.882515587484, 23566.87898089163, 2101.3800928726064, 2280.395695140789, 2287.8055365293803, 2394.365493144318, 2642.735726427361, 13782.517611883535, 13918.652033699238, 13935.651608709763, 14143.71712565743, 14823.407063717546, 1840.2271046160645, 1845.2618952419004, 1864.2915692037075, 1877.5306173456636, 1914.7606549181353, 80359.33891238504, 82311.5884420574, 83383.5830820848, 83998.58000709958, 84478.15521844765, 16201.0, 16373.672526549402, 16402.507924762278, 16615.66768664644, 16668.166591670368, 28731.2817179568, 28815.0, 28831.855840720662, 28940.855295723806, 29003.274918126794, 8400.831983360298, 8614.95692521546, 8683.52240626759, 8833.249173820297, 8895.777605559913, 7055.9294407056295, 7104.3961263293195, 7116.181639111568, 7305.3425191732995, 7321.963390183121, 8207.0, 8357.164283571716, 8416.705415310556, 8460.280876125475, 8529.488230706178, 3197.840107994591, 3365.5961284646, 3403.829808509565, 3462.8961131166106, 3465.878694245689, 800.9719659811879, 802.297989259398, 864.3646919514152, 907.9591418386188, 918.1186061381148, 16339.0, 16612.169391530617, 16621.335146594, 16663.750043749355, 16711.83288167127, 818.9303909167668, 864.1358641358642, 885.7209978856639, 905.6151135767273, 908.7818923458323, 8805.69180078694, 9707.466089365153, 9714.75713107178, 9753.951230243803, 9947.55236014381, 376434.0, 384180.0, 387330.0, 388211.0, 388888.0, 47279.29081063787, 61058.084128738104, 67671.66164169148, 79286.0, 80503.59748201222, 863.0214710185912, 879.4195830751673, 902.7201567514091, 906.1482206725657, 909.1499448016126, 14962.625934351729, 14996.839365085494, 15343.309551070452, 15477.690446191238, 15520.5343839685, 35333.82333088421, 36158.0, 36578.0, 36892.81553592215, 37863.24273514569, 46691.0, 48221.75889120532, 55224.72387638036, 55335.723321383135, 55474.44525554854, 7189.856202875809, 7450.8509829802015, 7564.470487066073, 7663.463557551141, 7865.960670196612, 8407.11725268838, 10732.0, 11254.493547790205, 11360.829587556029, 11447.14146439037, 9731.708048758548, 10063.798724025624, 10148.594056237667, 10377.377357358582, 10705.090067344363, 4729.621630269501, 7903.051633803981, 9600.471974041495, 9962.900370996198, 10017.39895606266, 8203.917960820316, 10126.341787783771, 10184.949075254577, 10363.481825908826, 10411.427371494641, 7438.0, 7514.586697731677, 7554.244575542401, 7667.079950405987, 7667.769966901002, 9283.39657922233, 9960.053794889474, 10004.649837255953, 10194.898051019394, 10230.539625717009], "value": 8917.232058663005, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1197.9580714674987, 1240.8076748104047, 1244.9502019919203, 1301.948440052596, 1666.4917200253917, 6602.504812139085, 7451.925480745191, 7694.807629809257, 7699.846003079942, 7925.603719814, 7680.193579674137, 7745.419093567977, 7785.299323060924, 7794.571298578576, 7796.649150788214, 2080.635888719479, 2093.1627349060345, 2097.213544920655, 2100.69539916712, 2113.8837363944976, 2066.5935451211185, 2108.641530939744, 2133.4986278224605, 2146.12009076278, 2146.216630929715, 2072.2125592274915, 2090.2370634718372, 2093.0581238442687, 2108.3780284816016, 2123.352377524854, 2037.0527704617425, 2057.783932687061, 2065.39070974063, 2067.638163321413, 2068.6173057984247, 2020.5251765835017, 2036.2771216218177, 2059.907304171301, 2061.299158286175, 2072.108993132952, 7736.303732664031, 7783.143854176036, 7790.45466817323, 7791.22087791222, 7795.259450352208, 4301.376300436419, 4468.4414448193975, 4471.82112715491, 4553.635709143261, 4554.2485489894125, 2765.2948498132846, 2898.7970842041063, 2912.956305655417, 2930.780191485626, 2932.1936467471614, 870.2689740617911, 890.3544929925816, 893.5487578772678, 900.3517467423445, 907.246985002453, 9803.31376803624, 9808.705738827917, 9815.950920245425, 9824.508774561315, 9865.753356166082, 3564.1267889367273, 3633.237020225782, 3765.3787125124595, 3771.8872932484983, 3775.1317197044286, 7872.56700881457, 7905.881411778828, 7918.366530677532, 7918.841623167505, 7931.603419829101, 4344.23975804233, 4360.4767427908855, 4364.061726728769, 4368.7815609219415, 4370.409994650745, 3671.6328367163605, 3788.1476667749534, 3985.8604948827233, 4072.592740725963, 4075.91848163041, 3284.540164376989, 3347.8493467794005, 3463.5670541182353, 3466.098814308298, 3487.093355727529, 1012.3065699995526, 1027.4143738069229, 1038.5326603028516, 1038.5378506564657, 1040.7190058684114, 676.0771546838628, 688.2807466197835, 789.1910791438706, 825.4469505431375, 826.6982551368707, 4782.569568738761, 4903.299090284072, 4939.802407903644, 5019.824306149268, 5076.670016448993, 355.4153417628039, 366.6718287133001, 366.80192695944424, 371.06491641064366, 376.1536542778748, 3508.368493671164, 3602.405603075463, 3639.5086663300644, 3689.1699367642605, 3755.849766009329, 9506.0, 9707.0, 9710.660126895526, 9718.854217186748, 9731.513424328898, 9437.292203084797, 9532.285078619132, 9549.761255968517, 9550.37922535033, 9555.665551705795, 6828.658567071627, 7003.439724822002, 7016.824579385454, 7031.367176953996, 7037.120359955005, 4969.45336013031, 5033.748312584429, 5077.949220507895, 5165.92251116226, 5184.351956005499, 8217.137200593852, 8230.876536851832, 8357.456765310235, 8502.234798868132, 8508.574571271289, 8118.878216826634, 8431.747047588582, 8654.04805471385, 8686.52224127679, 8688.348373872112, 6817.659117044227, 6902.8619427610165, 6904.930950690429, 6965.44276457872, 6986.091808065123, 7450.925490745023, 7515.473916825769, 7524.473286869867, 7524.510906791041, 7526.548407095592, 6495.610263384212, 6595.142631457879, 6682.231543372574, 6878.55289406187, 6883.139607549057, 6508.056331831953, 6509.810938152203, 6578.76974305897, 6629.46964242869, 6645.800625981228, 6078.787242446493, 6139.815805525842, 6145.231846019247, 6147.0779383092895, 6167.074938759222, 4472.195004899149, 4578.9771051144535, 4636.374089497875, 4662.7202367858035, 4705.341252224623, 4507.5041745408635, 4520.954790452053, 4655.0457156283555, 4665.813367465264, 4776.09254241693], "value": 3885.6097293219445, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [287.40363745228655, 288.34257892006224, 291.30523700973185, 295.5271565495208, 299.49086552860143, 4639.559241872025, 4779.761011949402, 4788.473267940532, 4822.107910036646, 4840.273958906166, 4574.862754117374, 4714.292856071591, 4725.87335698936, 4734.668573199869, 4739.241721324589, 3779.7732136071922, 3781.45168950502, 3785.1104990327253, 3791.3365161096835, 3798.1644038311597, 3576.5529308836394, 3584.2473080653094, 3779.603141670126, 3794.563625183098, 3794.582595914447, 3703.5926048134684, 3721.1069343357535, 3731.962680373202, 3744.232432351375, 3758.552957111518, 3731.6193008586997, 3742.2328422673286, 3744.4008958566633, 3746.269477451898, 3760.9059773505746, 3313.453280208763, 3313.7680362374645, 3316.557297575562, 3320.7177389921885, 3325.5676762021026, 4553.521880202564, 4635.976820115911, 4647.326137710047, 4659.813607455698, 4695.530446955311, 4278.930267433142, 4284.821674039664, 4286.37847512109, 4287.506936702288, 4289.571042895716, 4960.0, 4984.82553110643, 4992.600591952635, 4998.550420378122, 5004.274380214885, 3449.189440481485, 3596.1369271374942, 3612.440071788877, 3613.5663720353464, 3614.963850361489, 5186.974065129688, 5199.7140157291715, 5201.375834899836, 5206.375234971828, 5207.427183009866, 3704.5369328833895, 3708.4622729704042, 3709.0, 3712.498812660256, 3715.8327875245677, 3757.0982964088967, 3761.4169803680475, 3765.3975363942186, 3767.3972164453558, 3775.3770627846648, 3876.7480113792512, 4153.127843152972, 4157.3140431829015, 4167.353895211375, 4271.337942618899, 4964.67729597575, 4972.925406118911, 4974.801007959641, 4985.529268865694, 5000.449950505442, 1172.5251273234353, 1204.5121725701106, 1221.8045112781913, 1243.881831226032, 1257.459292504232, 847.3771777743353, 857.7812657772229, 865.2169786343369, 866.6273502393905, 873.3013589128799, 4394.736315821061, 4399.394221109272, 4418.64650827933, 4429.734215946989, 4431.091626216617, 5086.18621020635, 5090.2693084351495, 5099.69401835891, 5106.15748401517, 5110.626986189097, 4222.9577704222565, 4390.780460976938, 4397.890052748707, 4418.513963464016, 4427.158839820424, 2398.760123987587, 2419.4314336130997, 2422.709274887025, 2424.369663887402, 2424.5393375258645, 4227.661787057028, 4230.238557059759, 4287.678424118204, 4289.313709806478, 4305.246581848164, 4388.626966707866, 4565.817367305337, 4598.402207712976, 4607.516210797818, 4608.585227329557, 4225.366195070764, 4243.957560424418, 4244.766537840386, 4250.468691413574, 4259.212045771542, 4473.485549161888, 4502.639788816821, 4516.57727815737, 4528.977355113335, 4530.343100250511, 4277.871663850089, 4358.0388825029495, 4436.556344365537, 4473.821047158077, 4474.351219073281, 4279.465066866642, 4282.935755963601, 4283.828646854091, 4288.335308027136, 4293.463317085364, 3308.966910330866, 3313.7680362375368, 3325.3515564464697, 3326.168457885529, 3332.9666703332655, 4515.75163366018, 4533.863984080483, 4542.318652202196, 4551.271796512542, 4561.840335588371, 4196.832126714898, 4339.457567804025, 4341.721999890063, 4369.7159684621665, 4385.517593064824, 4358.193734159064, 4378.890527736832, 4385.956140438555, 4392.209402307615, 4400.647948164204, 4300.290452075373, 4318.589733975393, 4331.440681354647, 4691.437027556579, 4830.734309612864, 4737.715737055788, 4934.753262336941, 4990.750462476934, 5015.84952451427, 5039.420466646383, 4887.265020917523, 4892.510748925079, 4896.192128298933, 4902.338184345068, 4906.160189928777], "value": 3615.343947927518, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [618.5082859126993, 631.6304961597465, 632.6330728177658, 699.9090118284622, 722.5447967780298, 12618.747625047505, 13688.110272832258, 13714.58856234312, 13717.97115216359, 13728.17630942143, 13461.596152115428, 14381.209033503153, 14538.618831211044, 14887.18120503372, 14904.18027008514, 743.238180864614, 761.5354633673455, 761.6496411650647, 761.6648674583166, 761.7524304601, 608.8082254089969, 624.9250089989185, 627.645380360095, 629.8677277771674, 744.556988591787, 653.4543656047206, 759.532887274325, 798.3453568074152, 798.7763426240633, 803.8231589050399, 795.3796039089519, 795.5385876191795, 795.6697970342273, 795.6817273090752, 795.7970717467038, 586.6509426890993, 586.7564960541371, 587.1720873568248, 587.4654064801053, 587.6151121015741, 10594.9470252649, 10780.0, 12532.185407948546, 13004.934975325157, 13045.021623378285, 12266.38668066602, 12994.28531430771, 13313.467461301536, 13348.466061357534, 13941.581752547338, 10603.151747860153, 10627.574897004111, 10630.255882088257, 10684.519196636093, 10894.128469722404, 3300.884469043596, 3325.48454989477, 3331.4003479373705, 3331.9666803331897, 3347.9497807532907, 52002.47997520014, 53210.73394633041, 66538.66730666316, 66819.33180668228, 67619.0, 10335.22485813552, 10475.0, 10534.157267418588, 10585.259031867849, 10704.1436685065, 18423.72364414535, 18454.446366609023, 18459.815401845808, 18521.629567408847, 18564.628707425774, 6699.263081061079, 6704.865902681919, 6707.49693772969, 6729.8654026919185, 6988.231294557595, 3412.931741365159, 3486.790792552455, 3489.8953031409096, 3604.5494313210847, 3616.9095772605897, 2859.1422573227946, 2961.644602647653, 2977.970220297769, 2983.761299096067, 2989.7757668174972, 472.8014234021719, 481.94698583155827, 483.8524250103752, 489.33694843487274, 497.1399478901521, 574.1473911241802, 604.4729006248501, 631.3812463785516, 638.5466318913531, 656.2223764838586, 8131.227533384319, 8843.336749743667, 9201.629226117675, 9219.170274675178, 9318.114779095975, 572.9541636669056, 621.4344946099028, 633.7243299164878, 634.4892361648917, 636.9936300637027, 3859.845606175778, 3915.334393153171, 4027.3958906163725, 4029.2747305485295, 4118.19695159441, 74935.62532187304, 76576.61711691406, 77337.61331193308, 104637.0, 106356.0, 66636.0, 73329.6333518329, 76905.6154719234, 77417.0, 78472.60763696145, 60047.69976150179, 65386.67306663531, 69002.30997689959, 69527.65236173887, 70576.64711676408, 8281.29608983243, 9004.41471304363, 9314.627414903329, 9472.564037231015, 9474.0, 35369.64630353663, 43584.78207608942, 44921.32618010667, 44982.0, 45286.77356613196, 54813.725931370085, 61830.690846545476, 62388.37611623826, 62677.68661156665, 63961.680191598745, 11059.391733454737, 11298.039666628429, 11417.486213120263, 11525.193236473702, 12134.635960921187, 12180.817287740869, 12497.0, 12742.808857867325, 13122.868771312547, 13365.198088114745, 11880.465379058136, 12268.32524211177, 12298.569550066062, 12461.501539938301, 12519.0, 11315.886841131813, 11361.196166540687, 11412.771744564896, 11511.42442877836, 11967.222130561486, 11791.941040294743, 12019.0, 12589.24464532131, 12765.234085954873, 12781.8082728761, 9464.810703785748, 9505.144536991704, 10323.277370583986, 10419.42693151884, 10483.947580262355, 9235.307351948497, 10502.264841461025, 10525.789484210427, 10550.630727924487, 10691.251612387057], "value": 6514.141339245376, "unit": "score"}], "name": "dromaeo_css", "value": 6315.820571440047, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 116.0, 117.0, 116.0, 116.0, 118.0, 115.0, 118.0, 117.0, 116.0], "value": 116.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 130.0, 129.0, 176.0, 128.0, 135.0, 133.0, 131.0, 165.0, 131.0], "value": 140.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 161.0, 162.0, 161.0, 162.0, 162.0, 161.0, 162.0, 161.0], "value": 161.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 77.0, 77.0, 101.0, 76.0, 77.0, 78.0, 78.0, 103.0, 78.0], "value": 82.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 109.0, 83.0, 83.0, 83.0, 116.0, 83.0, 83.0, 123.0], "value": 93.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 118.0, 116.0, 116.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 147.0, 146.0, 146.0, 146.0, 146.0, 146.0, 145.0, 147.0], "value": 146.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 94.0, 95.0, 95.0, 96.0, 94.0, 95.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 62.0, 62.0, 63.0, 64.0, 63.0, 64.0, 64.0, 71.0, 64.0], "value": 64.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 67.0, 67.0, 67.0, 66.0, 67.0, 67.0, 67.0, 67.0], "value": 66.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 90.0, 85.0, 83.0, 84.0, 84.0, 84.0, 83.0, 82.0], "value": 84.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 136.0, 140.0, 138.0, 141.0, 139.0, 139.0, 144.0, 178.0, 136.0], "value": 143.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 174.0, 177.0, 175.0, 181.0, 180.0, 177.0, 175.0, 173.0, 172.0], "value": 176.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 73.0, 70.0, 70.0, 69.0, 74.0, 70.0, 73.0, 70.0, 69.0], "value": 71.1, "unit": "score"}], "name": "kraken", "value": 1557.1999999999998, "alertThreshold": 2.0}]} 08:27:06 INFO - Return code: 0 08:27:06 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:27:06 INFO - # TBPL SUCCESS # 08:27:06 INFO - Running post-action listener: _resource_record_post_action 08:27:06 INFO - [mozharness: 2016-10-05 15:27:06.523273Z] Finished run-tests step (success) 08:27:06 INFO - Running post-run listener: _resource_record_post_run 08:27:06 INFO - Total resource usage - Wall time: 1203s; CPU: 13.0%; Read bytes: 4096; Write bytes: 391811072; Read time: 16; Write time: 263192 08:27:06 INFO - TinderboxPrint: CPU usage
13.1% 08:27:06 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 08:27:06 INFO - TinderboxPrint: I/O write bytes / time
391,811,072 / 263,192 08:27:06 INFO - TinderboxPrint: CPU idle
8,340.3 (86.9%) 08:27:06 INFO - TinderboxPrint: CPU user
1,208.0 (12.6%) 08:27:06 INFO - TinderboxPrint: Swap in / out
0 / 0 08:27:06 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 99168256; Read time: 0; Write time: 72728 08:27:06 INFO - run-tests - Wall time: 1187s; CPU: 13.0%; Read bytes: 0; Write bytes: 292642816; Read time: 0; Write time: 190464 08:27:07 INFO - Running post-run listener: _upload_blobber_files 08:27:07 INFO - Blob upload gear active. 08:27:07 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:27:07 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 08:27:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:27:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:27:07 INFO - (blobuploader) - INFO - Open directory for files ... 08:27:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:27:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:27:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:27:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:27:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:27:08 INFO - (blobuploader) - INFO - Done attempting. 08:27:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:27:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:27:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:27:12 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:27:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:27:12 INFO - (blobuploader) - INFO - Done attempting. 08:27:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:27:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:27:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:27:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:27:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:27:12 INFO - (blobuploader) - INFO - Done attempting. 08:27:12 INFO - (blobuploader) - INFO - Iteration through files over. 08:27:12 INFO - Return code: 0 08:27:12 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:27:12 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:27:12 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/878c5a6fe529fc226131863dfa75fa444a2c61744db3ef84c2a94e9d347769e67d22fef4e47c446fd99fdb2e34a512cadb4df1ad423bfa976306751a03adaf28", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2c8140e6e7196573ed43d19364660ad5420197f72e60c96a425ca546bb116448e8c6d865805c810949086ff3896d6636d4c8e30057b79c2ced44794be3eca4b6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/dd9a1b4347b8459b4f8970b653f13b3d74ad000c17e24428ac072e4e59cc3e2bc2e9f38233bb21a9eaa1debbe81bc3fcc7f3815f98c6a46cab44eab72815df1f"} 08:27:12 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:27:12 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:27:12 INFO - Contents: 08:27:12 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/878c5a6fe529fc226131863dfa75fa444a2c61744db3ef84c2a94e9d347769e67d22fef4e47c446fd99fdb2e34a512cadb4df1ad423bfa976306751a03adaf28", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2c8140e6e7196573ed43d19364660ad5420197f72e60c96a425ca546bb116448e8c6d865805c810949086ff3896d6636d4c8e30057b79c2ced44794be3eca4b6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/dd9a1b4347b8459b4f8970b653f13b3d74ad000c17e24428ac072e4e59cc3e2bc2e9f38233bb21a9eaa1debbe81bc3fcc7f3815f98c6a46cab44eab72815df1f"} 08:27:12 INFO - Running post-run listener: copy_logs_to_upload_dir 08:27:12 INFO - Copying logs to upload dir... 08:27:12 INFO - mkdir: /builds/slave/test/build/upload/logs 08:27:12 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1245.665840 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-10-05 08:27:11.671643) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-05 08:27:11.675149) ========= 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=ed14279e38b05397cf4aa391000001a4-1475679984.343718-1477131147 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/878c5a6fe529fc226131863dfa75fa444a2c61744db3ef84c2a94e9d347769e67d22fef4e47c446fd99fdb2e34a512cadb4df1ad423bfa976306751a03adaf28", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2c8140e6e7196573ed43d19364660ad5420197f72e60c96a425ca546bb116448e8c6d865805c810949086ff3896d6636d4c8e30057b79c2ced44794be3eca4b6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/dd9a1b4347b8459b4f8970b653f13b3d74ad000c17e24428ac072e4e59cc3e2bc2e9f38233bb21a9eaa1debbe81bc3fcc7f3815f98c6a46cab44eab72815df1f"} build_url:https://queue.taskcluster.net/v1/task/fuPdWzMHSm2wndZevS6uaQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011315 build_url: 'https://queue.taskcluster.net/v1/task/fuPdWzMHSm2wndZevS6uaQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/878c5a6fe529fc226131863dfa75fa444a2c61744db3ef84c2a94e9d347769e67d22fef4e47c446fd99fdb2e34a512cadb4df1ad423bfa976306751a03adaf28", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2c8140e6e7196573ed43d19364660ad5420197f72e60c96a425ca546bb116448e8c6d865805c810949086ff3896d6636d4c8e30057b79c2ced44794be3eca4b6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/dd9a1b4347b8459b4f8970b653f13b3d74ad000c17e24428ac072e4e59cc3e2bc2e9f38233bb21a9eaa1debbe81bc3fcc7f3815f98c6a46cab44eab72815df1f"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-05 08:27:11.700354) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-05 08:27:11.700787) ========= 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=ed14279e38b05397cf4aa391000001a4-1475679984.343718-1477131147 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004457 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-05 08:27:11.786835) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-05 08:27:11.787291) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-05 08:27:11.787588) ========= ========= Total master_lag: 0.16 =========