builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-036 starttime: 1476202678.64 results: success (0) buildid: 20161011063006 builduid: 45db9453e63c4aff867c02f084bf8a5d revision: 8654fba1417d44e510b8f2791f5ccf06c0496744 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-11 09:17:58.640390) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-11 09:17:58.642553) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-11 09:17:58.642841) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-11 09:17:58.658308) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-11 09:17:58.658644) ========= 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=14ef55db36f7623abb31b9cf000001d5-1476202653.785782-48228851 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-11 09:17:58-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.6M=0s 2016-10-11 09:17:59 (46.6 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.097583 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-11 09:17:58.776126) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-11 09:17:58.776449) ========= 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=14ef55db36f7623abb31b9cf000001d5-1476202653.785782-48228851 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014955 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-11 09:17:58.826210) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-11 09:17:58.826556) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 8654fba1417d44e510b8f2791f5ccf06c0496744 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 8654fba1417d44e510b8f2791f5ccf06c0496744 --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=14ef55db36f7623abb31b9cf000001d5-1476202653.785782-48228851 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-11 09:17:59,200 truncating revision to first 12 chars 2016-10-11 09:17:59,200 Setting DEBUG logging. 2016-10-11 09:17:59,200 attempt 1/10 2016-10-11 09:17:59,200 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/8654fba1417d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-11 09:17:59,658 unpacking tar archive at: fx-team-8654fba1417d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.829006 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-11 09:17:59.670422) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-11 09:17:59.670960) ========= script_repo_revision: 8654fba1417d44e510b8f2791f5ccf06c0496744 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-11 09:17:59.671501) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-11 09:17:59.671910) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-11 09:17:59.706198) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-10-11 09:17:59.706596) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=14ef55db36f7623abb31b9cf000001d5-1476202653.785782-48228851 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:18:00 INFO - MultiFileLogger online at 20161011 09:18:00 in /builds/slave/test 09:18:00 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 09:18:00 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:18:00 INFO - {'append_to_log': False, 09:18:00 INFO - 'base_work_dir': '/builds/slave/test', 09:18:00 INFO - 'blob_upload_branch': 'Fx-Team', 09:18:00 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:18:00 INFO - 'branch': 'Fx-Team', 09:18:00 INFO - 'buildbot_json_path': 'buildprops.json', 09:18:00 INFO - 'config_files': ('talos/linux_config.py',), 09:18:00 INFO - 'default_actions': ('clobber', 09:18:00 INFO - 'read-buildbot-config', 09:18:00 INFO - 'download-and-extract', 09:18:00 INFO - 'populate-webroot', 09:18:00 INFO - 'create-virtualenv', 09:18:00 INFO - 'install', 09:18:00 INFO - 'run-tests'), 09:18:00 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:18:00 INFO - 'download_minidump_stackwalk': True, 09:18:00 INFO - 'download_symbols': 'ondemand', 09:18:00 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:18:00 INFO - 'tooltool.py': '/tools/tooltool.py', 09:18:00 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:18:00 INFO - '/tools/misc-python/virtualenv.py')}, 09:18:00 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:18:00 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:18:00 INFO - 'installer_path': 'installer.exe', 09:18:00 INFO - 'log_level': 'info', 09:18:00 INFO - 'log_name': 'talos', 09:18:00 INFO - 'log_to_console': True, 09:18:00 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:18:00 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:18:00 INFO - 'opt_config_files': (), 09:18:00 INFO - 'pip_index': False, 09:18:00 INFO - 'sps_profile': False, 09:18:00 INFO - 'sps_profile_interval': 0, 09:18:00 INFO - 'suite': 'dromaeojs', 09:18:00 INFO - 'system_bits': '32', 09:18:00 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:18:00 INFO - 'title': 'talos-linux64-ix-036', 09:18:00 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:18:00 INFO - 'use_talos_json': True, 09:18:00 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:18:00 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:18:00 INFO - 'work_dir': 'build'} 09:18:00 INFO - [mozharness: 2016-10-11 16:18:00.180705Z] Running clobber step. 09:18:00 INFO - Running pre-action listener: _resource_record_pre_action 09:18:00 INFO - Running main action method: clobber 09:18:00 INFO - rmtree: /builds/slave/test/build 09:18:00 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:18:01 INFO - Running post-action listener: _resource_record_post_action 09:18:01 INFO - [mozharness: 2016-10-11 16:18:01.166894Z] Finished clobber step (success) 09:18:01 INFO - [mozharness: 2016-10-11 16:18:01.166993Z] Running read-buildbot-config step. 09:18:01 INFO - Running pre-action listener: _resource_record_pre_action 09:18:01 INFO - Running main action method: read_buildbot_config 09:18:01 INFO - Using buildbot properties: 09:18:01 INFO - { 09:18:01 INFO - "project": "", 09:18:01 INFO - "product": "firefox", 09:18:01 INFO - "script_repo_revision": "production", 09:18:01 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 09:18:01 INFO - "repository": "", 09:18:01 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 09:18:01 INFO - "buildid": "20161011063006", 09:18:01 INFO - "pgo_build": "True", 09:18:01 INFO - "basedir": "/builds/slave/test", 09:18:01 INFO - "buildnumber": 525, 09:18:01 INFO - "slavename": "talos-linux64-ix-036", 09:18:01 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 09:18:01 INFO - "platform": "ubuntu64_hw", 09:18:01 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 09:18:01 INFO - "branch": "fx-team", 09:18:01 INFO - "repo_path": "integration/fx-team", 09:18:01 INFO - "revision": "8654fba1417d44e510b8f2791f5ccf06c0496744", 09:18:01 INFO - "stage_platform": "linux64-pgo", 09:18:01 INFO - "builduid": "45db9453e63c4aff867c02f084bf8a5d", 09:18:01 INFO - "slavebuilddir": "test" 09:18:01 INFO - } 09:18:01 INFO - Found installer url https://queue.taskcluster.net/v1/task/OXumNNtiRvOTYjaHkJGKOQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 09:18:01 INFO - Running post-action listener: _resource_record_post_action 09:18:01 INFO - [mozharness: 2016-10-11 16:18:01.169406Z] Finished read-buildbot-config step (success) 09:18:01 INFO - [mozharness: 2016-10-11 16:18:01.169494Z] Running download-and-extract step. 09:18:01 INFO - Running pre-action listener: _resource_record_pre_action 09:18:01 INFO - Running main action method: download_and_extract 09:18:01 INFO - mkdir: /builds/slave/test/build/tests 09:18:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:18:01 INFO - trying https://queue.taskcluster.net/v1/task/OXumNNtiRvOTYjaHkJGKOQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 09:18:01 INFO - Downloading https://queue.taskcluster.net/v1/task/OXumNNtiRvOTYjaHkJGKOQ/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 09:18:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OXumNNtiRvOTYjaHkJGKOQ/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 09:18:01 INFO - Downloaded 1361 bytes. 09:18:01 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 09:18:01 INFO - Using the following test package requirements: 09:18:01 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 09:18:01 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:18:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:18:01 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:18:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 09:18:01 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:18:01 INFO - u'jsshell-linux-x86_64.zip'], 09:18:01 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:18:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:18:01 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 09:18:01 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:18:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:18:01 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:18:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:18:01 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:18:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:18:01 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:18:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:18:01 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:18:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OXumNNtiRvOTYjaHkJGKOQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 09:18:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OXumNNtiRvOTYjaHkJGKOQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:18:01 INFO - Fetch https://queue.taskcluster.net/v1/task/OXumNNtiRvOTYjaHkJGKOQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 09:18:02 INFO - Http code: 200 09:18:02 INFO - via: 1.1 1b52a5dd431f9e3c81753e61dfdf467a.cloudfront.net (CloudFront) 09:18:02 INFO - x-amz-cf-id: kibAprp9LrJ2VZynZnEzjWFnbFeNA02jkYsTkPwt_tg-Nq6M27gIMQ== 09:18:02 INFO - x-amz-version-id: ZYWUrk74TBqGIS9v3Hi8g5Nqv3cQ2aCA 09:18:02 INFO - Expected file size: 22100582 09:18:02 INFO - Obtained file size: 22100582 09:18:06 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 09:18:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OXumNNtiRvOTYjaHkJGKOQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 09:18:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OXumNNtiRvOTYjaHkJGKOQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:18:06 INFO - Fetch https://queue.taskcluster.net/v1/task/OXumNNtiRvOTYjaHkJGKOQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 09:18:07 INFO - Http code: 200 09:18:07 INFO - via: 1.1 24b0e5a3429d07ef12381da50e07f70f.cloudfront.net (CloudFront) 09:18:07 INFO - x-amz-cf-id: Q2NMWHag7MN1bfcDI_tJb65TwLjRIusm-yAKLBDzeKQA1L0JWWsiDg== 09:18:07 INFO - x-amz-version-id: ZYWUrk74TBqGIS9v3Hi8g5Nqv3cQ2aCA 09:18:07 INFO - Expected file size: 22100582 09:18:07 INFO - Obtained file size: 22100582 09:18:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OXumNNtiRvOTYjaHkJGKOQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 09:18:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OXumNNtiRvOTYjaHkJGKOQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 09:18:12 INFO - Fetch https://queue.taskcluster.net/v1/task/OXumNNtiRvOTYjaHkJGKOQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 09:18:12 INFO - Http code: 200 09:18:12 INFO - via: 1.1 7f9e159e8ac7593f5d3d995abc6d2db3.cloudfront.net (CloudFront) 09:18:12 INFO - x-amz-cf-id: MgLxEllIDI3ETsifc2QRCgHoUFU2iwxz9t_Qk3epVJWqcsuwwhSJlg== 09:18:12 INFO - x-amz-version-id: MDmR0GihNguBeFmWyKcCKD52VgeIBtiv 09:18:12 INFO - Expected file size: 14409006 09:18:12 INFO - Obtained file size: 14409006 09:18:13 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')]} 09:18:13 INFO - trying https://queue.taskcluster.net/v1/task/OXumNNtiRvOTYjaHkJGKOQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 09:18:13 INFO - Downloading https://queue.taskcluster.net/v1/task/OXumNNtiRvOTYjaHkJGKOQ/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 09:18:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OXumNNtiRvOTYjaHkJGKOQ/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 09:18:14 INFO - Downloaded 59756893 bytes. 09:18:14 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/OXumNNtiRvOTYjaHkJGKOQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 09:18:14 INFO - mkdir: /builds/slave/test/properties 09:18:14 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:18:14 INFO - Writing to file /builds/slave/test/properties/build_url 09:18:14 INFO - Contents: 09:18:14 INFO - build_url:https://queue.taskcluster.net/v1/task/OXumNNtiRvOTYjaHkJGKOQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 09:18:14 INFO - Running post-action listener: _resource_record_post_action 09:18:14 INFO - Running post-action listener: set_extra_try_arguments 09:18:14 INFO - [mozharness: 2016-10-11 16:18:14.853627Z] Finished download-and-extract step (success) 09:18:14 INFO - [mozharness: 2016-10-11 16:18:14.853854Z] Running populate-webroot step. 09:18:14 INFO - Running pre-action listener: _resource_record_pre_action 09:18:14 INFO - Running main action method: populate_webroot 09:18:14 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:18:14 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:18:14 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:18:14 INFO - '--tppagecycles', 09:18:14 INFO - '7'], 09:18:14 INFO - 'tests': ['tsvgm']}}, 09:18:14 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:18:14 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:18:14 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:18:14 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:18:14 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:18:14 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:18:14 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:18:14 INFO - 'talos_options': ['--disable-e10s'], 09:18:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:18:14 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:18:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:18:14 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:18:14 INFO - 'talos_options': ['--disable-e10s'], 09:18:14 INFO - 'tests': ['damp', 'tps']}, 09:18:14 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:18:14 INFO - 'tests': ['damp', 'tps']}, 09:18:14 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:18:14 INFO - 'tests': ['dromaeo_dom']}, 09:18:14 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:18:14 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:18:14 INFO - 'tests': ['basic_compositor_video']}, 09:18:14 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:18:14 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:18:14 INFO - 'tests': ['a11yr', 09:18:14 INFO - 'ts_paint', 09:18:14 INFO - 'tpaint', 09:18:14 INFO - 'sessionrestore', 09:18:14 INFO - 'sessionrestore_no_auto_restore', 09:18:14 INFO - 'tabpaint']}, 09:18:14 INFO - 'other-e10s': {'tests': ['a11yr', 09:18:14 INFO - 'ts_paint', 09:18:14 INFO - 'tpaint', 09:18:14 INFO - 'sessionrestore', 09:18:14 INFO - 'sessionrestore_no_auto_restore', 09:18:14 INFO - 'tabpaint']}, 09:18:14 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:18:14 INFO - 'ts_paint', 09:18:14 INFO - 'tpaint', 09:18:14 INFO - 'sessionrestore', 09:18:14 INFO - 'sessionrestore_no_auto_restore', 09:18:14 INFO - 'tabpaint']}, 09:18:14 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:18:14 INFO - 'ts_paint', 09:18:14 INFO - 'tpaint', 09:18:14 INFO - 'sessionrestore', 09:18:14 INFO - 'sessionrestore_no_auto_restore', 09:18:14 INFO - 'tabpaint']}, 09:18:14 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:18:14 INFO - 'tests': ['a11yr', 09:18:14 INFO - 'ts_paint', 09:18:14 INFO - 'tpaint', 09:18:14 INFO - 'sessionrestore', 09:18:14 INFO - 'sessionrestore_no_auto_restore', 09:18:14 INFO - 'tabpaint']}, 09:18:14 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:18:14 INFO - 'tests': ['a11yr', 09:18:14 INFO - 'ts_paint', 09:18:14 INFO - 'tpaint', 09:18:14 INFO - 'sessionrestore', 09:18:14 INFO - 'sessionrestore_no_auto_restore', 09:18:14 INFO - 'tabpaint']}, 09:18:14 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:18:14 INFO - 'tests': ['tsvgx', 09:18:14 INFO - 'tsvgr_opacity', 09:18:14 INFO - 'tart', 09:18:14 INFO - 'tscrollx', 09:18:14 INFO - 'cart']}, 09:18:14 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:18:14 INFO - 'tsvgr_opacity', 09:18:14 INFO - 'tart', 09:18:14 INFO - 'tscrollx', 09:18:14 INFO - 'cart']}, 09:18:14 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:18:14 INFO - 'talos_options': ['--disable-e10s'], 09:18:14 INFO - 'tests': ['tp5o']}, 09:18:14 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:18:14 INFO - 'tests': ['tp5o']}, 09:18:14 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:18:14 INFO - 'talos_options': ['--disable-e10s', 09:18:14 INFO - '--xperf_path', 09:18:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:18:14 INFO - 'tests': ['tp5n']}, 09:18:14 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:18:14 INFO - 'talos_options': ['--xperf_path', 09:18:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:18:14 INFO - 'tests': ['tp5n']}}, 09:18:14 INFO - 'talos.zip': {'path': '', 09:18:14 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:18:14 INFO - Running post-action listener: _resource_record_post_action 09:18:14 INFO - [mozharness: 2016-10-11 16:18:14.872544Z] Finished populate-webroot step (success) 09:18:14 INFO - [mozharness: 2016-10-11 16:18:14.872631Z] Running create-virtualenv step. 09:18:14 INFO - Running pre-action listener: _resource_record_pre_action 09:18:14 INFO - Running main action method: create_virtualenv 09:18:14 INFO - Creating virtualenv /builds/slave/test/build/venv 09:18:14 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 09:18:14 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:18:14 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:18:14 INFO - Using real prefix '/usr' 09:18:14 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:18:15 INFO - Installing distribute.............................................................................................................................................................................................done. 09:18:17 INFO - Installing pip.................done. 09:18:17 INFO - Return code: 0 09:18:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:18:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:18:17 INFO - Reading from file tmpfile_stdout 09:18:17 INFO - Output received: 09:18:17 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) 09:18:17 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:18:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:18:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:18:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:18:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:18:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18:17 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 0x7f258c20ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f0f790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f0c930>, '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 0x1f0d830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f0dcc0>, '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': '14ef55db36f7623abb31b9cf000001d5-1476202653.785782-48228851', '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 09:18:17 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 09:18:17 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 09:18:17 INFO - Using env: {'DISPLAY': ':0', 09:18:17 INFO - 'HOME': '/home/cltbld', 09:18:17 INFO - 'LANG': 'en_US.UTF-8', 09:18:17 INFO - 'LANGUAGE': 'en_US:en', 09:18:17 INFO - 'LOGNAME': 'cltbld', 09:18:17 INFO - 'MAIL': '/var/mail/cltbld', 09:18:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:18:17 INFO - 'MOZ_NO_REMOTE': '1', 09:18:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:18:17 INFO - 'NO_EM_RESTART': '1', 09:18:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:18:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:18:17 INFO - 'PWD': '/builds/slave/test', 09:18:17 INFO - 'SHELL': '/bin/bash', 09:18:17 INFO - 'SHLVL': '1', 09:18:17 INFO - 'TERM': 'linux', 09:18:17 INFO - 'TMOUT': '86400', 09:18:17 INFO - 'USER': 'cltbld', 09:18:17 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1476202653.785782-48228851', 09:18:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:18:17 INFO - '_': '/tools/buildbot/bin/python'} 09:18:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:18:17 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 09:18:17 INFO - Cleaning up... 09:18:17 INFO - Return code: 0 09:18:17 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:18:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:18:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:18:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:18:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:18:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18:17 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 0x7f258c20ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f0f790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f0c930>, '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 0x1f0d830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f0dcc0>, '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': '14ef55db36f7623abb31b9cf000001d5-1476202653.785782-48228851', '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 09:18:17 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 09:18:17 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 09:18:17 INFO - Using env: {'DISPLAY': ':0', 09:18:17 INFO - 'HOME': '/home/cltbld', 09:18:17 INFO - 'LANG': 'en_US.UTF-8', 09:18:17 INFO - 'LANGUAGE': 'en_US:en', 09:18:17 INFO - 'LOGNAME': 'cltbld', 09:18:17 INFO - 'MAIL': '/var/mail/cltbld', 09:18:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:18:17 INFO - 'MOZ_NO_REMOTE': '1', 09:18:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:18:17 INFO - 'NO_EM_RESTART': '1', 09:18:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:18:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:18:17 INFO - 'PWD': '/builds/slave/test', 09:18:17 INFO - 'SHELL': '/bin/bash', 09:18:17 INFO - 'SHLVL': '1', 09:18:17 INFO - 'TERM': 'linux', 09:18:17 INFO - 'TMOUT': '86400', 09:18:17 INFO - 'USER': 'cltbld', 09:18:17 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1476202653.785782-48228851', 09:18:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:18:17 INFO - '_': '/tools/buildbot/bin/python'} 09:18:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:18:18 INFO - Downloading/unpacking psutil>=3.1.1 09:18:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:18:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:18:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:18:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:18:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:18:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:18:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:18:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:18:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:18:20 INFO - Installing collected packages: psutil 09:18:20 INFO - Running setup.py install for psutil 09:18:20 INFO - building 'psutil._psutil_linux' extension 09:18:20 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 09:18:20 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 09:18:20 INFO - building 'psutil._psutil_posix' extension 09:18:20 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 09:18:20 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 09:18:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:18:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:18:20 INFO - Successfully installed psutil 09:18:20 INFO - Cleaning up... 09:18:20 INFO - Return code: 0 09:18:20 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:18:20 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')]} 09:18:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:18:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18:20 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')]} 09:18:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:18:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18:20 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 0x7f258c20ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f0f790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f0c930>, '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 0x1f0d830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f0dcc0>, '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': '14ef55db36f7623abb31b9cf000001d5-1476202653.785782-48228851', '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 09:18:20 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 09:18:20 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 09:18:20 INFO - Using env: {'DISPLAY': ':0', 09:18:20 INFO - 'HOME': '/home/cltbld', 09:18:20 INFO - 'LANG': 'en_US.UTF-8', 09:18:20 INFO - 'LANGUAGE': 'en_US:en', 09:18:20 INFO - 'LOGNAME': 'cltbld', 09:18:20 INFO - 'MAIL': '/var/mail/cltbld', 09:18:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:18:20 INFO - 'MOZ_NO_REMOTE': '1', 09:18:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:18:20 INFO - 'NO_EM_RESTART': '1', 09:18:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:18:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:18:20 INFO - 'PWD': '/builds/slave/test', 09:18:20 INFO - 'SHELL': '/bin/bash', 09:18:20 INFO - 'SHLVL': '1', 09:18:20 INFO - 'TERM': 'linux', 09:18:20 INFO - 'TMOUT': '86400', 09:18:20 INFO - 'USER': 'cltbld', 09:18:20 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1476202653.785782-48228851', 09:18:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:18:20 INFO - '_': '/tools/buildbot/bin/python'} 09:18:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:18:20 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:18:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:18:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:18:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:18:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:18:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:18:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:18:22 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:18:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:18:22 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:18:22 INFO - Installing collected packages: mozsystemmonitor 09:18:22 INFO - Running setup.py install for mozsystemmonitor 09:18:22 INFO - Successfully installed mozsystemmonitor 09:18:22 INFO - Cleaning up... 09:18:23 INFO - Return code: 0 09:18:23 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:18:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:18:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:18:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:18:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:18:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f258c20ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f0f790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f0c930>, '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 0x1f0d830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f0dcc0>, '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': '14ef55db36f7623abb31b9cf000001d5-1476202653.785782-48228851', '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 09:18:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 09:18:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 09:18:23 INFO - Using env: {'DISPLAY': ':0', 09:18:23 INFO - 'HOME': '/home/cltbld', 09:18:23 INFO - 'LANG': 'en_US.UTF-8', 09:18:23 INFO - 'LANGUAGE': 'en_US:en', 09:18:23 INFO - 'LOGNAME': 'cltbld', 09:18:23 INFO - 'MAIL': '/var/mail/cltbld', 09:18:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:18:23 INFO - 'MOZ_NO_REMOTE': '1', 09:18:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:18:23 INFO - 'NO_EM_RESTART': '1', 09:18:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:18:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:18:23 INFO - 'PWD': '/builds/slave/test', 09:18:23 INFO - 'SHELL': '/bin/bash', 09:18:23 INFO - 'SHLVL': '1', 09:18:23 INFO - 'TERM': 'linux', 09:18:23 INFO - 'TMOUT': '86400', 09:18:23 INFO - 'USER': 'cltbld', 09:18:23 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1476202653.785782-48228851', 09:18:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:18:23 INFO - '_': '/tools/buildbot/bin/python'} 09:18:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:18:23 INFO - Downloading/unpacking jsonschema==2.5.1 09:18:23 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 09:18:23 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 09:18:23 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 09:18:23 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 09:18:23 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 09:18:23 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 09:18:25 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:18:25 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:18:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:18:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:18:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:18:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:18:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:18:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:18:25 INFO - Downloading functools32-3.2.3-2.tar.gz 09:18:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:18:25 INFO - warning: no files found matching '*.txt' 09:18:25 INFO - no previously-included directories found matching 'build' 09:18:25 INFO - no previously-included directories found matching 'dist' 09:18:25 INFO - no previously-included directories found matching '.git*' 09:18:25 INFO - Installing collected packages: jsonschema, functools32 09:18:25 INFO - Running setup.py install for functools32 09:18:25 INFO - warning: no files found matching '*.txt' 09:18:25 INFO - no previously-included directories found matching 'build' 09:18:25 INFO - no previously-included directories found matching 'dist' 09:18:25 INFO - no previously-included directories found matching '.git*' 09:18:25 INFO - Successfully installed jsonschema functools32 09:18:25 INFO - Cleaning up... 09:18:25 INFO - Return code: 0 09:18:25 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:18:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:18:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:18:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:18:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:18:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f258c20ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f0f790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f0c930>, '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 0x1f0d830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f0dcc0>, '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': '14ef55db36f7623abb31b9cf000001d5-1476202653.785782-48228851', '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 09:18:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 09:18:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 09:18:25 INFO - Using env: {'DISPLAY': ':0', 09:18:25 INFO - 'HOME': '/home/cltbld', 09:18:25 INFO - 'LANG': 'en_US.UTF-8', 09:18:25 INFO - 'LANGUAGE': 'en_US:en', 09:18:25 INFO - 'LOGNAME': 'cltbld', 09:18:25 INFO - 'MAIL': '/var/mail/cltbld', 09:18:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:18:25 INFO - 'MOZ_NO_REMOTE': '1', 09:18:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:18:25 INFO - 'NO_EM_RESTART': '1', 09:18:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:18:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:18:25 INFO - 'PWD': '/builds/slave/test', 09:18:25 INFO - 'SHELL': '/bin/bash', 09:18:25 INFO - 'SHLVL': '1', 09:18:25 INFO - 'TERM': 'linux', 09:18:25 INFO - 'TMOUT': '86400', 09:18:25 INFO - 'USER': 'cltbld', 09:18:25 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1476202653.785782-48228851', 09:18:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:18:25 INFO - '_': '/tools/buildbot/bin/python'} 09:18:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:18:25 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:18:25 INFO - Cleaning up... 09:18:25 INFO - Return code: 0 09:18:25 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:18:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:18:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:18:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:18:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:18:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f258c20ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f0f790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f0c930>, '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 0x1f0d830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f0dcc0>, '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': '14ef55db36f7623abb31b9cf000001d5-1476202653.785782-48228851', '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 09:18:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:18:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:18:25 INFO - Using env: {'DISPLAY': ':0', 09:18:25 INFO - 'HOME': '/home/cltbld', 09:18:25 INFO - 'LANG': 'en_US.UTF-8', 09:18:25 INFO - 'LANGUAGE': 'en_US:en', 09:18:25 INFO - 'LOGNAME': 'cltbld', 09:18:25 INFO - 'MAIL': '/var/mail/cltbld', 09:18:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:18:25 INFO - 'MOZ_NO_REMOTE': '1', 09:18:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:18:25 INFO - 'NO_EM_RESTART': '1', 09:18:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:18:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:18:25 INFO - 'PWD': '/builds/slave/test', 09:18:25 INFO - 'SHELL': '/bin/bash', 09:18:25 INFO - 'SHLVL': '1', 09:18:25 INFO - 'TERM': 'linux', 09:18:25 INFO - 'TMOUT': '86400', 09:18:25 INFO - 'USER': 'cltbld', 09:18:25 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1476202653.785782-48228851', 09:18:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:18:25 INFO - '_': '/tools/buildbot/bin/python'} 09:18:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:18:26 INFO - Downloading/unpacking blobuploader==1.2.4 09:18:26 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 09:18:26 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 09:18:26 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 09:18:26 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 09:18:26 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 09:18:26 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 09:18:27 INFO - Downloading blobuploader-1.2.4.tar.gz 09:18:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:18:28 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:18:28 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 09:18:28 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 09:18:28 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 09:18:28 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 09:18:28 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 09:18:28 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 09:18:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:18:28 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:18:28 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 09:18:28 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 09:18:28 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 09:18:28 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 09:18:28 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 09:18:28 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 09:18:28 INFO - Downloading docopt-0.6.1.tar.gz 09:18:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:18:28 INFO - Installing collected packages: blobuploader, requests, docopt 09:18:28 INFO - Running setup.py install for blobuploader 09:18:28 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:18:28 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:18:28 INFO - Running setup.py install for requests 09:18:29 INFO - Running setup.py install for docopt 09:18:29 INFO - Successfully installed blobuploader requests docopt 09:18:29 INFO - Cleaning up... 09:18:29 INFO - Return code: 0 09:18:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:18:29 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')]} 09:18:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:18:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18:29 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')]} 09:18:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:18:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18:29 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 0x7f258c20ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f0f790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f0c930>, '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 0x1f0d830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f0dcc0>, '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': '14ef55db36f7623abb31b9cf000001d5-1476202653.785782-48228851', '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 09:18:29 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 09:18:29 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 09:18:29 INFO - Using env: {'DISPLAY': ':0', 09:18:29 INFO - 'HOME': '/home/cltbld', 09:18:29 INFO - 'LANG': 'en_US.UTF-8', 09:18:29 INFO - 'LANGUAGE': 'en_US:en', 09:18:29 INFO - 'LOGNAME': 'cltbld', 09:18:29 INFO - 'MAIL': '/var/mail/cltbld', 09:18:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:18:29 INFO - 'MOZ_NO_REMOTE': '1', 09:18:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:18:29 INFO - 'NO_EM_RESTART': '1', 09:18:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:18:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:18:29 INFO - 'PWD': '/builds/slave/test', 09:18:29 INFO - 'SHELL': '/bin/bash', 09:18:29 INFO - 'SHLVL': '1', 09:18:29 INFO - 'TERM': 'linux', 09:18:29 INFO - 'TMOUT': '86400', 09:18:29 INFO - 'USER': 'cltbld', 09:18:29 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1476202653.785782-48228851', 09:18:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:18:29 INFO - '_': '/tools/buildbot/bin/python'} 09:18:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:18:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:18:29 INFO - Running setup.py (path:/tmp/pip-QhXVQa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:18:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:18:29 INFO - Running setup.py (path:/tmp/pip-c9iYiQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:18:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:18:29 INFO - Running setup.py (path:/tmp/pip-pn9eib-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:18:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:18:29 INFO - Running setup.py (path:/tmp/pip-aeXMlA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:18:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:18:29 INFO - Running setup.py (path:/tmp/pip-nReaoo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:18:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:18:29 INFO - Running setup.py (path:/tmp/pip-DUw9qd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:18:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:18:30 INFO - Running setup.py (path:/tmp/pip-0y2bYB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:18:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:18:30 INFO - Running setup.py (path:/tmp/pip-ANfIQn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:18:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:18:30 INFO - Running setup.py (path:/tmp/pip-XGxzWP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:18:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:18:30 INFO - Running setup.py (path:/tmp/pip-VJiYLC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:18:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:18:30 INFO - Running setup.py (path:/tmp/pip-ZXMwKw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:18:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:18:30 INFO - Running setup.py (path:/tmp/pip-96OKJW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:18:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:18:30 INFO - Running setup.py (path:/tmp/pip-pxWWrc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:18:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:18:30 INFO - Running setup.py (path:/tmp/pip-1nKDqs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:18:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:18:30 INFO - Running setup.py (path:/tmp/pip-aKvVb7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:18:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:18:30 INFO - Running setup.py (path:/tmp/pip-H4ph46-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:18:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:18:30 INFO - Running setup.py (path:/tmp/pip-qKYqh6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:18:30 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:18:30 INFO - Running setup.py install for manifestparser 09:18:30 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:18:30 INFO - Running setup.py install for mozcrash 09:18:31 INFO - Running setup.py install for mozdebug 09:18:31 INFO - Running setup.py install for mozdevice 09:18:31 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:18:31 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:18:31 INFO - Running setup.py install for mozfile 09:18:31 INFO - Running setup.py install for mozhttpd 09:18:31 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:18:31 INFO - Running setup.py install for mozinfo 09:18:31 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:18:31 INFO - Running setup.py install for mozInstall 09:18:31 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:18:31 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:18:31 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:18:31 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:18:31 INFO - Running setup.py install for mozleak 09:18:31 INFO - Running setup.py install for mozlog 09:18:31 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:18:31 INFO - Running setup.py install for moznetwork 09:18:31 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:18:31 INFO - Running setup.py install for mozprocess 09:18:32 INFO - Running setup.py install for mozprofile 09:18:32 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:18:32 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:18:32 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:18:32 INFO - Running setup.py install for mozrunner 09:18:32 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:18:32 INFO - Running setup.py install for mozscreenshot 09:18:32 INFO - Running setup.py install for moztest 09:18:32 INFO - Running setup.py install for mozversion 09:18:32 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:18:32 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:18:32 INFO - Cleaning up... 09:18:32 INFO - Return code: 0 09:18:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:18:32 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')]} 09:18:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:18:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18:32 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')]} 09:18:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:18:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18:32 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 0x7f258c20ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f0f790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f0c930>, '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 0x1f0d830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f0dcc0>, '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': '14ef55db36f7623abb31b9cf000001d5-1476202653.785782-48228851', '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 09:18:32 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 09:18:32 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 09:18:32 INFO - Using env: {'DISPLAY': ':0', 09:18:32 INFO - 'HOME': '/home/cltbld', 09:18:32 INFO - 'LANG': 'en_US.UTF-8', 09:18:32 INFO - 'LANGUAGE': 'en_US:en', 09:18:32 INFO - 'LOGNAME': 'cltbld', 09:18:32 INFO - 'MAIL': '/var/mail/cltbld', 09:18:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:18:32 INFO - 'MOZ_NO_REMOTE': '1', 09:18:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:18:32 INFO - 'NO_EM_RESTART': '1', 09:18:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:18:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:18:32 INFO - 'PWD': '/builds/slave/test', 09:18:32 INFO - 'SHELL': '/bin/bash', 09:18:32 INFO - 'SHLVL': '1', 09:18:32 INFO - 'TERM': 'linux', 09:18:32 INFO - 'TMOUT': '86400', 09:18:32 INFO - 'USER': 'cltbld', 09:18:32 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1476202653.785782-48228851', 09:18:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:18:32 INFO - '_': '/tools/buildbot/bin/python'} 09:18:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:18:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:18:32 INFO - Running setup.py (path:/tmp/pip-p0tCT9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:18:32 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)) 09:18:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:18:32 INFO - Running setup.py (path:/tmp/pip-Q8P2k_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:18:33 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)) 09:18:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:18:33 INFO - Running setup.py (path:/tmp/pip-p0zrX4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:18:33 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)) 09:18:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:18:33 INFO - Running setup.py (path:/tmp/pip-AyfLks-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:18:33 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)) 09:18:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:18:33 INFO - Running setup.py (path:/tmp/pip-Lvmv7c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:18:33 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)) 09:18:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:18:33 INFO - Running setup.py (path:/tmp/pip-70mvR6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:18:33 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)) 09:18:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:18:33 INFO - Running setup.py (path:/tmp/pip-FN9sH2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:18:33 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)) 09:18:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:18:33 INFO - Running setup.py (path:/tmp/pip-nYpTIF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:18:33 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)) 09:18:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:18:33 INFO - Running setup.py (path:/tmp/pip-PnQ8PI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:18:33 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)) 09:18:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:18:33 INFO - Running setup.py (path:/tmp/pip-JfcllE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:18:33 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)) 09:18:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:18:33 INFO - Running setup.py (path:/tmp/pip-CO372C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:18:33 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)) 09:18:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:18:33 INFO - Running setup.py (path:/tmp/pip-Uc2Gvp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:18:33 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)) 09:18:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:18:33 INFO - Running setup.py (path:/tmp/pip-ZOJmSF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:18:33 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)) 09:18:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:18:33 INFO - Running setup.py (path:/tmp/pip-zdgxes-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:18:33 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)) 09:18:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:18:33 INFO - Running setup.py (path:/tmp/pip-k6JQ4j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:18:33 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)) 09:18:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:18:33 INFO - Running setup.py (path:/tmp/pip-d7_uN6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:18:34 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)) 09:18:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:18:34 INFO - Running setup.py (path:/tmp/pip-VOXEhJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:18:34 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)) 09:18:34 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)) 09:18:34 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)) 09:18:34 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)) 09:18:34 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)) 09:18:34 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)) 09:18:34 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:18:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:18:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:18:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:18:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:18:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:18:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:18:36 INFO - Downloading blessings-1.6.tar.gz 09:18:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:18:36 INFO - Installing collected packages: blessings 09:18:36 INFO - Running setup.py install for blessings 09:18:36 INFO - Successfully installed blessings 09:18:36 INFO - Cleaning up... 09:18:36 INFO - Return code: 0 09:18:36 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:18:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:18:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:18:36 INFO - Reading from file tmpfile_stdout 09:18:36 INFO - Current package versions: 09:18:36 INFO - argparse == 1.2.1 09:18:36 INFO - blessings == 1.6 09:18:36 INFO - blobuploader == 1.2.4 09:18:36 INFO - docopt == 0.6.1 09:18:36 INFO - functools32 == 3.2.3-2 09:18:36 INFO - jsonschema == 2.5.1 09:18:36 INFO - manifestparser == 1.1 09:18:36 INFO - mozInstall == 1.12 09:18:36 INFO - mozcrash == 0.17 09:18:36 INFO - mozdebug == 0.1 09:18:36 INFO - mozdevice == 0.48 09:18:36 INFO - mozfile == 1.2 09:18:36 INFO - mozhttpd == 0.7 09:18:36 INFO - mozinfo == 0.9 09:18:36 INFO - mozleak == 0.1 09:18:36 INFO - mozlog == 3.4 09:18:36 INFO - moznetwork == 0.27 09:18:36 INFO - mozprocess == 0.23 09:18:36 INFO - mozprofile == 0.28 09:18:36 INFO - mozrunner == 6.12 09:18:36 INFO - mozscreenshot == 0.1 09:18:36 INFO - mozsystemmonitor == 0.3 09:18:36 INFO - moztest == 0.7 09:18:36 INFO - mozversion == 1.4 09:18:36 INFO - psutil == 3.1.1 09:18:36 INFO - requests == 1.2.3 09:18:36 INFO - wsgiref == 0.1.2 09:18:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:18:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:18:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:18:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:18:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:18:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18:36 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 0x7f258c20ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f0f790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f0c930>, '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 0x1f0d830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f0dcc0>, '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': '14ef55db36f7623abb31b9cf000001d5-1476202653.785782-48228851', '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 09:18:36 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 09:18:36 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 09:18:36 INFO - Using env: {'DISPLAY': ':0', 09:18:36 INFO - 'HOME': '/home/cltbld', 09:18:36 INFO - 'LANG': 'en_US.UTF-8', 09:18:36 INFO - 'LANGUAGE': 'en_US:en', 09:18:36 INFO - 'LOGNAME': 'cltbld', 09:18:36 INFO - 'MAIL': '/var/mail/cltbld', 09:18:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:18:36 INFO - 'MOZ_NO_REMOTE': '1', 09:18:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:18:36 INFO - 'NO_EM_RESTART': '1', 09:18:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:18:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:18:36 INFO - 'PWD': '/builds/slave/test', 09:18:36 INFO - 'SHELL': '/bin/bash', 09:18:36 INFO - 'SHLVL': '1', 09:18:36 INFO - 'TERM': 'linux', 09:18:36 INFO - 'TMOUT': '86400', 09:18:36 INFO - 'USER': 'cltbld', 09:18:36 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1476202653.785782-48228851', 09:18:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:18:36 INFO - '_': '/tools/buildbot/bin/python'} 09:18:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:18:36 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)) 09:18:36 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)) 09:18:36 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)) 09:18:36 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)) 09:18:36 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)) 09:18:36 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)) 09:18:36 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)) 09:18:36 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)) 09:18:36 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)) 09:18:36 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)) 09:18:36 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)) 09:18:36 INFO - Cleaning up... 09:18:36 INFO - Return code: 0 09:18:36 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:18:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:18:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:18:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:18:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:18:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f258c20ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f0f790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f0c930>, '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 0x1f0d830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f0dcc0>, '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': '14ef55db36f7623abb31b9cf000001d5-1476202653.785782-48228851', '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 09:18:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:18:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:18:36 INFO - Using env: {'DISPLAY': ':0', 09:18:36 INFO - 'HOME': '/home/cltbld', 09:18:36 INFO - 'LANG': 'en_US.UTF-8', 09:18:36 INFO - 'LANGUAGE': 'en_US:en', 09:18:36 INFO - 'LOGNAME': 'cltbld', 09:18:36 INFO - 'MAIL': '/var/mail/cltbld', 09:18:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:18:36 INFO - 'MOZ_NO_REMOTE': '1', 09:18:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:18:36 INFO - 'NO_EM_RESTART': '1', 09:18:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:18:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:18:36 INFO - 'PWD': '/builds/slave/test', 09:18:36 INFO - 'SHELL': '/bin/bash', 09:18:36 INFO - 'SHLVL': '1', 09:18:36 INFO - 'TERM': 'linux', 09:18:36 INFO - 'TMOUT': '86400', 09:18:36 INFO - 'USER': 'cltbld', 09:18:36 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1476202653.785782-48228851', 09:18:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:18:36 INFO - '_': '/tools/buildbot/bin/python'} 09:18:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:18:36 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:18:36 INFO - Cleaning up... 09:18:37 INFO - Return code: 0 09:18:37 INFO - Running post-action listener: _resource_record_post_action 09:18:37 INFO - Running post-action listener: _start_resource_monitoring 09:18:37 INFO - Starting resource monitoring. 09:18:37 INFO - [mozharness: 2016-10-11 16:18:37.031041Z] Finished create-virtualenv step (success) 09:18:37 INFO - [mozharness: 2016-10-11 16:18:37.031548Z] Running install step. 09:18:37 INFO - Running pre-action listener: _resource_record_pre_action 09:18:37 INFO - Running main action method: install 09:18:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:18:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:18:37 INFO - Reading from file tmpfile_stdout 09:18:37 INFO - Detecting whether we're running mozinstall >=1.0... 09:18:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:18:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:18:37 INFO - Reading from file tmpfile_stdout 09:18:37 INFO - Output received: 09:18:37 INFO - Usage: mozinstall [options] installer 09:18:37 INFO - Options: 09:18:37 INFO - -h, --help show this help message and exit 09:18:37 INFO - -d DEST, --destination=DEST 09:18:37 INFO - Directory to install application into. [default: 09:18:37 INFO - "/builds/slave/test"] 09:18:37 INFO - --app=APP Application being installed. [default: firefox] 09:18:37 INFO - mkdir: /builds/slave/test/build/application 09:18:37 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'] 09:18:37 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 09:18:54 INFO - Reading from file tmpfile_stdout 09:18:54 INFO - Output received: 09:18:54 INFO - /builds/slave/test/build/application/firefox/firefox 09:18:54 INFO - Running post-action listener: _resource_record_post_action 09:18:54 INFO - [mozharness: 2016-10-11 16:18:54.419437Z] Finished install step (success) 09:18:54 INFO - [mozharness: 2016-10-11 16:18:54.419678Z] Running run-tests step. 09:18:54 INFO - Running pre-action listener: _resource_record_pre_action 09:18:54 INFO - Running main action method: run_tests 09:18:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:18:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:18:54 INFO - Python 2.7.3 09:18:54 INFO - Return code: 0 09:18:54 INFO - grabbing minidump binary from tooltool 09:18:54 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')]} 09:18:54 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 0x1f0c930>, '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 0x1f0d830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f0dcc0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:18:54 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 09:18:54 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 09:18:54 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 09:18:54 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:18:54 INFO - Return code: 0 09:18:54 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:18:54 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:18:54 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:18:54 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:18:54 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:18:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OXumNNtiRvOTYjaHkJGKOQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--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 09:18:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/OXumNNtiRvOTYjaHkJGKOQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-036 --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 09:18:54 INFO - Using env: {'DISPLAY': ':0', 09:18:54 INFO - 'HOME': '/home/cltbld', 09:18:54 INFO - 'LANG': 'en_US.UTF-8', 09:18:54 INFO - 'LANGUAGE': 'en_US:en', 09:18:54 INFO - 'LOGNAME': 'cltbld', 09:18:54 INFO - 'MAIL': '/var/mail/cltbld', 09:18:54 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:18:54 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:18:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:18:54 INFO - 'MOZ_NO_REMOTE': '1', 09:18:54 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:18:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:18:54 INFO - 'NO_EM_RESTART': '1', 09:18:54 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:18:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:18:54 INFO - 'PWD': '/builds/slave/test', 09:18:54 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:18:54 INFO - 'SHELL': '/bin/bash', 09:18:54 INFO - 'SHLVL': '1', 09:18:54 INFO - 'TERM': 'linux', 09:18:54 INFO - 'TMOUT': '86400', 09:18:54 INFO - 'USER': 'cltbld', 09:18:54 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1476202653.785782-48228851', 09:18:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:18:54 INFO - '_': '/tools/buildbot/bin/python'} 09:18:54 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OXumNNtiRvOTYjaHkJGKOQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--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 09:18:54 INFO - mozversion application_buildid: 20161011063006 09:18:54 INFO - mozversion application_changeset: 8654fba1417d44e510b8f2791f5ccf06c0496744 09:18:54 INFO - mozversion application_display_name: Nightly 09:18:54 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:18:54 INFO - mozversion application_name: Firefox 09:18:54 INFO - mozversion application_remotingname: firefox 09:18:54 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 09:18:54 INFO - mozversion application_vendor: Mozilla 09:18:54 INFO - mozversion application_version: 52.0a1 09:18:54 INFO - mozversion platform_buildid: 20161011063006 09:18:54 INFO - mozversion platform_changeset: 8654fba1417d44e510b8f2791f5ccf06c0496744 09:18:54 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 09:18:54 INFO - mozversion platform_version: 52.0a1 09:18:54 INFO - using testdate: 1476202734 09:18:54 INFO - actual date: 1476202734 09:18:54 INFO - starting webserver on 'localhost:52328' 09:18:54 INFO - SUITE-START | Running 2 tests 09:18:54 INFO - TEST-START | dromaeo_css 09:18:54 INFO - operating with platform_type : linux_ 09:18:54 INFO - Initialising browser for dromaeo_css test... 09:18:54 INFO - TEST-INFO | started process 2788 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyuK4k8/profile http://localhost:52328/getInfo.html) 09:18:59 INFO - PROCESS | 2788 | __metrics Screen width/height:1600/1200 09:18:59 INFO - PROCESS | 2788 | colorDepth:24 09:18:59 INFO - PROCESS | 2788 | Browser inner width/height: 1024/697 09:18:59 INFO - PROCESS | 2788 | __metrics 09:19:00 INFO - PROCESS | 2788 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:19:00 INFO - PROCESS | 2788 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:19:00 INFO - PROCESS | 2788 | console.error: PushService: 09:19:00 INFO - PROCESS | 2788 | stateChangeProcessEnqueue: Error transitioning state 09:19:00 INFO - PROCESS | 2788 | UnknownError 09:19:01 INFO - TEST-INFO | 2788: exit 0 09:19:01 INFO - Browser initialized. 09:19:01 INFO - Running cycle 1/1 for dromaeo_css test... 09:19:01 INFO - TEST-INFO | started process 2928 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyuK4k8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:19:13 INFO - PROCESS | 2928 | RSS: Main: 172679168 09:19:13 INFO - PROCESS | 2928 | 09:20:05 INFO - PROCESS | 2928 | 1476202805325 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] 09:22:15 INFO - PROCESS | 2928 | Cycle 1(1): loaded http://localhost:52328/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52328/tests/dromaeo/cssquery-ext.html) 09:22:17 INFO - PROCESS | 2928 | RSS: Main: 324419584 09:22:17 INFO - PROCESS | 2928 | 09:25:19 INFO - PROCESS | 2928 | Cycle 1(1): loaded http://localhost:52328/tests/dromaeo/cssquery-ext.html (next: http://localhost:52328/tests/dromaeo/cssquery-jquery.html) 09:25:20 INFO - PROCESS | 2928 | RSS: Main: 273383424 09:25:20 INFO - PROCESS | 2928 | 09:28:22 INFO - PROCESS | 2928 | Cycle 1(1): loaded http://localhost:52328/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52328/tests/dromaeo/cssquery-mootools.html) 09:28:22 INFO - PROCESS | 2928 | RSS: Main: 257699840 09:28:22 INFO - PROCESS | 2928 | 09:31:24 INFO - PROCESS | 2928 | Cycle 1(1): loaded http://localhost:52328/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52328/tests/dromaeo/cssquery-prototype.html) 09:31:25 INFO - PROCESS | 2928 | RSS: Main: 246169600 09:31:25 INFO - PROCESS | 2928 | 09:34:28 INFO - PROCESS | 2928 | Cycle 1(1): loaded http://localhost:52328/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52328/tests/dromaeo/cssquery-yui.html) 09:34:28 INFO - PROCESS | 2928 | RSS: Main: 216334336 09:34:28 INFO - PROCESS | 2928 | 09:37:31 INFO - PROCESS | 2928 | Cycle 1(1): loaded http://localhost:52328/tests/dromaeo/cssquery-yui.html (next: http://localhost:52328/tests/dromaeo/cssquery-dojo.html) 09:37:32 INFO - PROCESS | 2928 | RSS: Main: 309370880 09:37:32 INFO - PROCESS | 2928 | 09:37:32 INFO - PROCESS | 2928 | __start_tp_report 09:37:32 INFO - PROCESS | 2928 | _x_x_mozilla_page_load 09:37:32 INFO - PROCESS | 2928 | _x_x_mozilla_page_load_details 09:37:32 INFO - PROCESS | 2928 | |i|pagename|runs| 09:37:32 INFO - PROCESS | 2928 | |0;dojo.html;2981.5229563269877;2992.6708062113175;3017.034548944338;3018.24543864034;3062.647795503518;5038.521340472658;5080.898382032357;5123.513266239706;5148.613853960949;5154.639175257734;5197.844064678056;5199.752059505719;5226.712530810804;5228.137357336035;5246.685198888069;4688.929666055021;4722.64580156488;4738.620910327166;4748.955229849427;4815.349927759743;4573.108243892442;4638.744869032202;4663.743494107823;4756.4767875533835;4769.618430525549;4751.477337492873;4764.785584648682;4819.590334821544;4823.107725070856;4828.034393121372;4693.835715749967;4793.32893394925;4817.470078291385;4821.445533763627;4858.975705121487;4768.070226305872;4807.375041244616;4836.758162091881;4879.048585525824;4882.487338829443;5092.236164575306;5096.108181068298;5168.612354073422;5222.764975576109;5270.077736396153;5560.499555040025;5562.471565201299;5568.331800183963;5569.582281328876;5570.108782594806;5593.720313984284;5597.048501754712;5601.187827764992;5615.691136987464;5619.157126431027;5200.6619569727845;5239.738013099368;5249.370075590915;5264.078786212397;5339.946600534023;5717.199592057115;5720.2849643794525;5723.828285151452;5735.082386818089;5743.167240750151;5280.049591073644;5498.422665620053;5524.944750552523;5531.589444691578;5581.665100094007;5462.453754624586;5507.201455788968;5557.527610153183;5562.72186390687;5563.36021357541;5438.558781922794;5499.50504454601;5505.724713764296;5516.586256030814;5592.384837667853;5525.309336332958;5526.889462210734;5528.391876893538;5541.750621222055;5602.243697100839;4202.411662367271;4298.63461605767;4303.096349766522;4303.612674859278;4363.454568178978;3774.8490060397276;3839.040239940015;3845.4616353710503;3846.4614953906475;3856.421536769507;5340.305760251143;5349.224362467498;5349.812756553502;5352.437994010651;5400.621956463088;5628.352739434936;5633.8591535211945;5639.379668236491;5643.5203007743985;5709.571782116358;5010.974945125251;5117;5278.683279003272;5349.812756553502;5356.8660783479945;4857.465678775332;4923.975380123076;4933;4959.330490383824;4981.800727970913;5777.826665200051;5784.1034639630925;5832.766689332379;5843.970780146072;5846.1230815377185;5485.259489968963;5551.722413879371;5650.491455769001;5654.6324488908085;5721.084626459747;5625.493705566519;5655.971720141538;5656.915146272727;5757.251557297524;5812.534997200299;5384.6769193848495;5387.892242155057;5405.378381486179;5415.620906536505;5419.403865574863;5428.9661225731925;5473;5477.808276710296;5478.671279723229;5544.861378465571;5219.373675159005;5261.105612045885;5339.092354299856;5360.892782144258;5384.246205531307;5356.250124982427;5361.946380536145;5416.106342453451;5416.241726158262;5465.344158700981;5383.919241211307;5386.48828361305;5419.6206265562605;5427.918581221206;5495.2856128703015;5361.410244873139;5423.7830486780085;5434.918476222939;5448.863778405413;5464.26232458613;5342.412334643109;5407.215953686615;5409.810656626999;5448.400675925565;5471.343438787371 09:37:32 INFO - PROCESS | 2928 | |1;ext.html;542.40116824867;579.2007030298188;614.7817524778703;618.5484596244742;640.1837656987337;30880.691193088063;41875.974883014045;42472.787636061774;42506.36240456396;42564.36153457701;43766.34350484738;44253;44264.77867610665;44276.557234427644;44296.55703442964;8006;8183.79540511486;8844.77888052799;8991.685291014815;8998.19016288534;10693.679189624285;10968.725781855437;10991.725206869853;10992.615258465956;10994.615188468406;10743.51654175564;10813.405262710548;10841.728956776065;10849.511771970241;10859.67420977368;10804.72988175294;10866.456677166188;10881.530993315959;10889.891101088966;10900.727481812979;10596.629117980834;10657.893421065844;10663.733406664818;10665.573377064908;10669.146468282519;41494.79252603718;41730.374044389355;41740.37389439161;41778;41784.1643167138;3460.9480857786903;3475.8609655614;3491.0748651607346;3635.3274644190647;3674.191677830873;30608.54087188694;30680.53979190314;31237.8438107808;31531.684683153104;32136.196595085075;4012.578679238696;4017.3773065174946;4021.617946295097;4061.614146656063;4134.937975930334;317928;318693;319040;319383;320070;56787.14819277714;57198.14202786962;57272.42727572754;57307.71346143326;57428.71285643545;35668;59424.702876486204;59457.70271148703;59629.10556341658;59653.40346596565;14755;15048.172350520827;15495.612609684847;15506.147161906203;15509.689806204038;11584.652460426201;11840.407979600985;11959.983401410804;12011.33937633421;12178.512859485698;17833.46499605014;17974.191161397768;18211.362602308855;18304.63390732178;18466;5570.944290557123;6744.629045402452;6835.555688880207;6848.383645471931;6993.160820701549;824.2952275804101;964.2430691906819;980.6077568972325;1021.8824835144054;1072.7210925159359;29772.255693607833;31239;31369;31509.369812603618;31815.204619884225;1074.537948682074;1098.340995402752;1108.5067145120345;1124.7806677697934;1175.4651633506735;15664.451744189126;16096.436624718313;16099.597510062342;16764.664706705797;16782.83217167813;484054;512244;512603;514598;515322;56134.43865561292;56933.715331423075;56936;56968.715156423954;57002;1203.259995103023;1306.6537367597593;1344.5899000804652;1352.5874608244383;1362.2779926638898;24063.879680601483;33241.33517329591;33288;33540.66459335375;33541;52868.471315286355;53598.46401535935;53623.463765363405;53648.244622876024;53704;364322;367793;368968;369532;369690;27303.726962730118;27825.860870695516;27830.44339113166;27934.860325698242;28278.85860570684;45341;45553.31670025019;46176.30735539037;46829.76585117052;47080;37842.621573785014;38439.231215376094;38697.4195387075;39983.60016399915;40555;38771.806140969114;39224.803875981575;39779.40330895097;39979.60020399759;40977;39440.40839387354;39574.20851582895;39579.80210098931;40195.19609607733;40578.39132413075;32856;34963.300733985685;35235.29529409346;35900.28199436049;36232.63767362398;25517.23448296554;25582.614164424336;25699;26071;26110.477790443703 09:37:32 INFO - PROCESS | 2928 | |2;jquery.html;387.7983448606726;397.201624734284;405.8802653217302;410.39876580809107;424.168629486207;13285.535006274782;15201;18757.906210468947;19129;19694.21223151076;18184.636307273846;18744.156512956917;18783.812161878377;18830.62338753224;18880.716789248138;5482.698451585161;5589.804356847511;5831.416858314155;5840.299164100293;5841.299044114712;5581.079121944874;5649.12438572022;5664.830055098333;5685;5698.43015698431;5464.5682671211125;5636.408177141403;5668.744906479198;5677.347105082907;5678.744456499447;5622.859428514279;5623.465770751772;5657.688827114507;5666.121751128581;5694.544436445074;4929.728864912428;4978.5270399312;5039.748012599392;5067.847964561069;5116.283720279164;22140.446488837748;22465.775342246696;22599.62703916098;22603.095876164934;22654.773452265432;2324.1284518305633;2328.1734984080576;2533.290678609974;2577.1881857214917;2960.978462430458;13850.93074534631;14130.646733831634;14364.712705745827;14391.856081439157;14909.627259318495;1886.1795119123226;1959.559099202668;1986.433866348084;2001.8398528117716;2029.9594008119902;78550.6072469634;78633.31616812578;79687;79926;80490.59754701247;10375.533101010473;10380.480975951172;10435.530401131968;10842.620508282173;10864.619738309279;15409.229538523028;15410.768838467431;15430.768538471932;15453.5363939082;15462.458813941457;7503.962480187564;7795.688172473151;7889.289963903277;7910.327622152066;7988.400869934778;7297.744578939712;7317.817054573678;7382.667779949915;7552.584607846511;7650.273224043818;6412.422881940648;6437.774677886251;6446.838829029218;6563.901541476882;6577.868442631217;1840.3098837935775;1854.040441818131;1862.9254829806655;1894.6305470433133;1962.676158433871;828.2256090555229;918.42598376015;974.5176137811828;991.7818080022383;1071.8552995345685;18658;19445.51386215356;19526.511837204183;19644.508887277647;19686.606267874562;954.2985905359556;979.2557656181211;989.4014121456559;990.6235630460379;1025.6102680981328;10490.790184196427;10888.836667449994;10933.180011499011;10992.835107473395;11048.226624136234;209859;211877;443558;444690;450243;65756;86953.5652321747;95183.52408238054;97366.5131674337;99056;991.7669347703284;1024.636254129788;1046.0533217438078;1058.195771213883;1064.9787004259872;16437.342506299614;16482.83517164813;16902.154892255585;17216.569585760455;17384.65230695404;28460.43079138447;32704.67295327016;37063.81468092642;39848.601513985646;40677.796611016754;52957.47042529525;55526;55570.166447504125;56485;56573.71713141408;8133.14601966785;8292;8540.188682075193;8621.396502244783;8668.566571671265;12431.44058517387;12521.311327877054;12560.371981401076;12941.54704585335;13107.737845243233;6075.817725468243;10525.842112368473;11168.832467513157;11305;11812.586559470377;9081.500517471339;11031.724206894893;11182.552697891993;11192.384418856715;11439.197396637877;10775.838362424412;10869.29349592274;11182.161337899528;11314.151438642299;12112.818307725567;7904.881426778488;8001.119876813429;8049.476784009021;8060.637271322687;8293.253607175384;8561.400701950804;10919.781604368027;10991.175661825235;11107;11439 09:37:32 INFO - PROCESS | 2928 | |3;mootools.html;1450.5068276785894;1481.4370539195106;1606.1969015492255;1719.6302794899095;1760.5598600349913;7982.405718141598;8313.542755148464;8576;9259.675911343104;9275.90724092758;8597.18326758957;8901.84276044115;8921.866172007425;9073.591688374023;9099.272058235341;2330.8368414211054;2360.0441821062495;2362.6692263083182;2363.0075368345338;2364.326167042393;1969.2713695932525;2047.2629853252893;2322.5238826040704;2348.4011577047827;2391.485830546441;2193.6819161221615;2279.601069812776;2283.372072680018;2288.0847660935674;2292.1748170658548;2260;2262.479629685173;2283.4748007958096;2304.101400453824;2310.6996090508296;2276.8520046196945;2297.4830663100834;2298.276043046452;2303.504746479515;2349.5888219561507;9067.501287429188;9121.49831759253;9134.36059475837;9141.131592498701;9142.77143071422;5220.765065572021;5333.973330133364;5392.541633961118;5393.7572809223675;5402.297701298845;3254.853531591084;3395.5246265522846;3437.226624009603;3458.602260740022;3508.3509550733197;1119.8880111988817;1144.9427528623619;1165.9417029148508;1186.3178672263482;1197.8981786548154;12795.680107997374;12862;12902.483900643963;12940.935295323463;12949.093563450562;4452.844150454718;4765.809367625326;4794.664373493892;4813.919091781263;4850.902981940341;10793.83809242862;10809.297395669257;10811.297265677864;10817.080548153495;10824.458777061272;5437.510624043855;5439.102548079602;5440.646357986719;5447.264619276426;5447.918281225785;4761.2382018876815;4872.3665923430435;5009.649324547319;5010.223415370623;5011.1481048221885;3777.7544459610035;3875.7985024642453;3879.515060617423;3894.9610503895165;3975.8409663613133;1031.1235449867702;1059.157969414302;1113.2485572238706;1123.1688550472754;1153.6942710181809;797.9680812767424;798.4111617880376;884.7213127864702;984.0700537991529;1015.9238057145743;5883.0881213411985;6155.230596175478;6190.597611155261;6195.2255968004;6310.211223597051;949.126803340928;956.583886009588;976.4336684722844;981.6122631560494;999.6251405722854;3958.7822669752863;4114;4171;4194.182134483746;4235.661147108224;11330.830037549444;11553.36456494884;11601.12991525639;11630.244034137922;11642.708932276591;11451.25566838153;11483.655490335303;11546.134039947037;11561.653150405502;11563.88436115645;7918.802029949297;8309.044459887069;8314.376421768391;8488.278496327881;8538.103499132625;5943.286805583358;6117.816465506042;6225.252969643671;6276.403741644536;6300.180976473029;10300.690979270634;10691.518881650189;10841.945790270998;10854.40300783433;10855.837162442413;10454;10544.736381590521;10816.08063314627;10857.674269771604;10923.563057477611;7987.880181797394;8074.3944204183745;8125.187481251827;8144.918550814416;8191.508509489449;8386.538740369338;8533.359998000298;8541.572921353783;8542.40203185771;8542.701005465027;7724.8455030900195;7882.172371900868;7908.169642187488;7986.640601173078;8070.475419097975;7374.373178279906;7504.174540800398;7521.623918803928;7625.6568454418575;7945.44381893285;7286.526375785557;7409.740659076906;7412;7425.814354640961;7427.331540161195;5177.922331165111;5222.817201397933;5231.529162375405;5267.104592219409;5542.445755424425;5292.259083728358;5357.464253574612;5363.0882749931825;5398.973005134949;5449.536789372789 09:37:32 INFO - PROCESS | 2928 | |4;prototype.html;337.5662273977939;340.35672578826006;341.5781509835353;343.28425233388384;348.7489007914302;4999.25011248313;5180.782516108711;5215.269862219292;5254.868628284295;5277.261183434318;5057.418396884359;5114.156164232906;5125.924445332798;5143.614228932826;5172.741362931848;4070.3283958147017;4072.837086516543;4091.7340372875815;4096.815643296059;4103.558382762251;3988.8603898863403;4098.364753463218;4100.671946244308;4115.938260926088;4124.237016152007;4091.24312002279;4091.7954102294916;4099.770068979309;4100.487439070116;4101.323281658522;4080.1839632073406;4083.2445997490413;4089.20260549193;4089.325261331877;4101.46680931477;3666.5600127984544;3677.687396571295;3682.7606205596817;3683.336999340118;3704.499892514503;4896.510348965075;5102.4897510248675;5114.258432527263;5134.922976155361;5137.460566640524;4704.364910737041;4718.268668356376;4722.504137065627;4726.39302637105;4729.408823897013;5459.235707001023;5469.507744303032;5471.261379713727;5472.2338872557875;5507.118860982264;3949.5852935441653;4069.2471892699946;4086.7752273624938;4091.40674602184;4098.086327557206;5614.147331380635;5670.185540627001;5675.602707810455;5682;5706.80026199081;4160.647789468435;4160.750354978651;4167.1457351242925;4167.708260421741;4172.332426811696;4086.6117718816663;4162.729422587522;4174.227767862955;4198.3702444633545;4248.787560621957;4676.363272854542;4683.882902927386;4690.64820138491;4726.527347265246;4737;5460.208269800856;5464.972675136679;5504.972475137679;5561.416051314553;5564.693941833238;1359.5045450005114;1391.1583491987403;1397.489916180607;1433.8207724034496;1454.3237394611556;1012.367270455965;1025.4001409175717;1040.6097713357492;1041.8697662792151;1043.9373637581768;5253.632245742761;5301.602379821529;5307.548858347083;5311.715962136319;5313.1764576490705;5549.889002220014;5554.277943867352;5560.165975103767;5579.944200558024;5592.440755924456;5130.9230361544605;5144.176931690911;5219.869503262449;5314.946850531523;5328.3605967284175;2563.730808265105;2569.3663994405883;2574.3049376668196;2592.974070259311;2621.3446638340415;5049.823256186016;5055;5064.949350506521;5082.415522214918;5089.539113402848;4952.975235123801;4955.603551715854;5340.49265319794;5714.971425142848;5735.254416925773;5809.36097029318;5825.33008703996;5831.4168583141345;5835.620684655484;5864.853378665397;5521.558275337883;5604.8318550443555;5618.6628802272;5666.546676265972;5674.319081710221;5551.02938456842;5571.637843540157;5580.637258578179;5604.971975140098;5613.494785469327;5813.023571985376;5827.213326200908;5834.445727655866;5834.737436815439;5850.561207909509;3930.6265904739003;4069.918601627892;4083.387491876242;4096.344584866407;4117.711760176759;5331.573474122139;5659.745311460912;5664.207011018543;5665.263515742927;5682.119271512922;5402.486763757437;5431.619786615057;5478.698671572943;5481.588880833874;5498.395176530498;5449.155380915964;5476.58925580591;5482.259894914136;5483.917741233964;5545.584081193846;5315.3621565412395;5473.644213126134;5478.506934375925;5487.847552014122;5492.093804522369;5480.753366098615;5511.944880551143;5518.613697041169;5518.779248830002;5526.834194974157;5377.919331209957;5413.215083812904;5414.972925135507;5438.673679579238;5462.644928079662 09:37:32 INFO - PROCESS | 2928 | |5;yui.html;742.5693098003159;752.2176935986572;753.7399597138985;782.4405550031726;827.1893544326559;14495;17372.826271737278;17456.214470348834;17459;17484.562885927873;15164;15603.219839008032;15608.21958902056;15616.76574851378;15626.29681664325;767.3439209475888;792.9405294602899;797.0395673213764;797.7008621766837;797.9880301795478;796.7808852565562;800.3797057280625;800.655718041242;800.6877317846045;801.0787594266611;821.1624143373755;821.9917800822005;823.2960818500186;824.3570015387977;824.6206744897354;816.9714060007872;819.3486178488116;819.6516480495795;820.0692214336711;820.5445977482494;601.9638821670713;605.6245128020612;610.3896103896104;611.3672349118685;611.7644706787919;14753.114813111248;14810;14814.333354999051;14823.332950017168;14828.184449855253;13044.152130111512;13046.54337098197;13116.86883131166;13163.67090822737;13306.13510121839;11553.808647196327;11569.479373428216;11685.474153663106;11721.88278117225;11956.940215298955;3729.776213427176;3757.5866654667966;3812.218495208476;4012.859549915739;4042.110735638155;81385.59307203426;82578;82677;84798.5760071208;84999.57500212522;9808.21534277256;9820.4107753535;9898.10917017472;10015.14871235953;10532.420716860493;20639.69040464394;20664.173433062508;20692.58614827695;20702.689459657817;20708.689369659467;8301.128381519975;8532.274756645755;8885.111488851064;8952.23905968;8959.910400896038;4659.58063774262;4840.6127509799135;4860.145416981232;4998.125328067574;5067.695938243717;3565.679088881961;3691.483192353073;3701.481792549045;3703.759255648374;3705.444183372516;630.8076036808726;631.409631994087;640.3372509452694;646.8253571535753;648.5103746671233;723.5694761616829;747.3834086878347;754.7094368667993;764.2204950950111;770.8072981754561;9021.503817290111;9028.089383469485;9566.33035687509;9924.702258932244;9964.750881227883;641.8478830499265;662.5428454366568;669.9196096468357;673.1316601583902;675.0549231076434;4614.475833072729;4937.950620493821;4957.975210123926;4994.8251811187165;4996.500349964975;71627.2837271631;100953;124357.37821310836;125731;128458.35770821273;107774;108603;109151.45424272827;109228.4538577302;114574;92045;93209;93749;95260;97044.51477742566;8759.737207883774;9013.414128081653;9025.097490250922;9032.45805251687;9097.454152750855;53117.20324195063;54126;54156.72921635367;54788.45211547993;56287;74481.62759186169;79748.60125699567;80250.19749802661;81701.59149204454;81923.59038204771;10158.847617285894;10197.592096316064;10252.487375631337;10401.68794936153;10422.895771042497;12842.935785321013;12970.610881673565;13284.667883302995;13719.560561592798;13849.307534623027;12540.749185016066;12656.74686506283;12871.613851584467;12993.870061299265;13070.215787052808;11875.762484750085;12361;12858.67853303675;12942.41759120823;12945.223286602833;12342.13605047674;12948.611541653765;13077.019223558082;13364.575715515055;13470.797938031134;10657.89342106569;11265.605703800327;11641.53433862636;11678.532858685558;11718.941405292919;11350.318980861175;11375.886241137483;11473.254238474472;11819.290842549475;12175.14773965814 09:37:32 INFO - PROCESS | 2928 | __end_tp_report 09:37:32 INFO - PROCESS | 2928 | __start_cc_report 09:37:32 INFO - PROCESS | 2928 | _x_x_mozilla_cycle_collect,1426 09:37:32 INFO - PROCESS | 2928 | __end_cc_report 09:37:32 INFO - PROCESS | 2928 | __startTimestamp1476203852215__endTimestamp 09:37:32 INFO - PROCESS | 2928 | 09:37:32 INFO - PROCESS | 2928 | ------- Summary: start ------- 09:37:32 INFO - PROCESS | 2928 | Number of tests: 6 09:37:32 INFO - PROCESS | 2928 | 09:37:32 INFO - PROCESS | 2928 | [#0] dojo.html Cycles:165 Average:5178.16 Median:5361.95 stddev:576.42 (10.8%) stddev-sans-first:551.83 09:37:32 INFO - PROCESS | 2928 | Values: 2981.5 2992.7 3017.0 3018.2 3062.6 5038.5 5080.9 5123.5 5148.6 5154.6 5197.8 5199.8 5226.7 5228.1 5246.7 4688.9 4722.6 4738.6 4749.0 4815.3 4573.1 4638.7 4663.7 4756.5 4769.6 4751.5 4764.8 4819.6 4823.1 4828.0 4693.8 4793.3 4817.5 4821.4 4859.0 4768.1 4807.4 4836.8 4879.0 4882.5 5092.2 5096.1 5168.6 5222.8 5270.1 5560.5 5562.5 5568.3 5569.6 5570.1 5593.7 5597.0 5601.2 5615.7 5619.2 5200.7 5239.7 5249.4 5264.1 5339.9 5717.2 5720.3 5723.8 5735.1 5743.2 5280.0 5498.4 5524.9 5531.6 5581.7 5462.5 5507.2 5557.5 5562.7 5563.4 5438.6 5499.5 5505.7 5516.6 5592.4 5525.3 5526.9 5528.4 5541.8 5602.2 4202.4 4298.6 4303.1 4303.6 4363.5 3774.8 3839.0 3845.5 3846.5 3856.4 5340.3 5349.2 5349.8 5352.4 5400.6 5628.4 5633.9 5639.4 5643.5 5709.6 5011.0 5117.0 5278.7 5349.8 5356.9 4857.5 4924.0 4933.0 4959.3 4981.8 5777.8 5784.1 5832.8 5844.0 5846.1 5485.3 5551.7 5650.5 5654.6 5721.1 5625.5 5656.0 5656.9 5757.3 5812.5 5384.7 5387.9 5405.4 5415.6 5419.4 5429.0 5473.0 5477.8 5478.7 5544.9 5219.4 5261.1 5339.1 5360.9 5384.2 5356.3 5361.9 5416.1 5416.2 5465.3 5383.9 5386.5 5419.6 5427.9 5495.3 5361.4 5423.8 5434.9 5448.9 5464.3 5342.4 5407.2 5409.8 5448.4 5471.3 09:37:32 INFO - PROCESS | 2928 | 09:37:32 INFO - PROCESS | 2928 | [#1] ext.html Cycles:180 Average:56172.94 Median:36066.46 stddev:107463.84 (298.0%) stddev-sans-first:107684.13 09:37:32 INFO - PROCESS | 2928 | Values: 542.4 579.2 614.8 618.5 640.2 30880.7 41876.0 42472.8 42506.4 42564.4 43766.3 44253.0 44264.8 44276.6 44296.6 8006.0 8183.8 8844.8 8991.7 8998.2 10693.7 10968.7 10991.7 10992.6 10994.6 10743.5 10813.4 10841.7 10849.5 10859.7 10804.7 10866.5 10881.5 10889.9 10900.7 10596.6 10657.9 10663.7 10665.6 10669.1 41494.8 41730.4 41740.4 41778.0 41784.2 3460.9 3475.9 3491.1 3635.3 3674.2 30608.5 30680.5 31237.8 31531.7 32136.2 4012.6 4017.4 4021.6 4061.6 4134.9 317928.0 318693.0 319040.0 319383.0 320070.0 56787.1 57198.1 57272.4 57307.7 57428.7 35668.0 59424.7 59457.7 59629.1 59653.4 14755.0 15048.2 15495.6 15506.1 15509.7 11584.7 11840.4 11960.0 12011.3 12178.5 17833.5 17974.2 18211.4 18304.6 18466.0 5570.9 6744.6 6835.6 6848.4 6993.2 824.3 964.2 980.6 1021.9 1072.7 29772.3 31239.0 31369.0 31509.4 31815.2 1074.5 1098.3 1108.5 1124.8 1175.5 15664.5 16096.4 16099.6 16764.7 16782.8 484054.0 512244.0 512603.0 514598.0 515322.0 56134.4 56933.7 56936.0 56968.7 57002.0 1203.3 1306.7 1344.6 1352.6 1362.3 24063.9 33241.3 33288.0 33540.7 33541.0 52868.5 53598.5 53623.5 53648.2 53704.0 364322.0 367793.0 368968.0 369532.0 369690.0 27303.7 27825.9 27830.4 27934.9 28278.9 45341.0 45553.3 46176.3 46829.8 47080.0 37842.6 38439.2 38697.4 39983.6 40555.0 38771.8 39224.8 39779.4 39979.6 40977.0 39440.4 39574.2 39579.8 40195.2 40578.4 32856.0 34963.3 35235.3 35900.3 36232.6 25517.2 25582.6 25699.0 26071.0 26110.5 09:37:32 INFO - PROCESS | 2928 | 09:37:32 INFO - PROCESS | 2928 | [#2] jquery.html Cycles:180 Average:24685.40 Median:17832.83 stddev:61999.16 (347.7%) stddev-sans-first:62146.24 09:37:32 INFO - PROCESS | 2928 | Values: 387.8 397.2 405.9 410.4 424.2 13285.5 15201.0 18757.9 19129.0 19694.2 18184.6 18744.2 18783.8 18830.6 18880.7 5482.7 5589.8 5831.4 5840.3 5841.3 5581.1 5649.1 5664.8 5685.0 5698.4 5464.6 5636.4 5668.7 5677.3 5678.7 5622.9 5623.5 5657.7 5666.1 5694.5 4929.7 4978.5 5039.7 5067.8 5116.3 22140.4 22465.8 22599.6 22603.1 22654.8 2324.1 2328.2 2533.3 2577.2 2961.0 13850.9 14130.6 14364.7 14391.9 14909.6 1886.2 1959.6 1986.4 2001.8 2030.0 78550.6 78633.3 79687.0 79926.0 80490.6 10375.5 10380.5 10435.5 10842.6 10864.6 15409.2 15410.8 15430.8 15453.5 15462.5 7504.0 7795.7 7889.3 7910.3 7988.4 7297.7 7317.8 7382.7 7552.6 7650.3 6412.4 6437.8 6446.8 6563.9 6577.9 1840.3 1854.0 1862.9 1894.6 1962.7 828.2 918.4 974.5 991.8 1071.9 18658.0 19445.5 19526.5 19644.5 19686.6 954.3 979.3 989.4 990.6 1025.6 10490.8 10888.8 10933.2 10992.8 11048.2 209859.0 211877.0 443558.0 444690.0 450243.0 65756.0 86953.6 95183.5 97366.5 99056.0 991.8 1024.6 1046.1 1058.2 1065.0 16437.3 16482.8 16902.2 17216.6 17384.7 28460.4 32704.7 37063.8 39848.6 40677.8 52957.5 55526.0 55570.2 56485.0 56573.7 8133.1 8292.0 8540.2 8621.4 8668.6 12431.4 12521.3 12560.4 12941.5 13107.7 6075.8 10525.8 11168.8 11305.0 11812.6 9081.5 11031.7 11182.6 11192.4 11439.2 10775.8 10869.3 11182.2 11314.2 12112.8 7904.9 8001.1 8049.5 8060.6 8293.3 8561.4 10919.8 10991.2 11107.0 11439.0 09:37:32 INFO - PROCESS | 2928 | 09:37:32 INFO - PROCESS | 2928 | [#3] mootools.html Cycles:180 Average:5966.09 Median:4832.41 stddev:3477.25 (72.0%) stddev-sans-first:3470.45 09:37:32 INFO - PROCESS | 2928 | Values: 1450.5 1481.4 1606.2 1719.6 1760.6 7982.4 8313.5 8576.0 9259.7 9275.9 8597.2 8901.8 8921.9 9073.6 9099.3 2330.8 2360.0 2362.7 2363.0 2364.3 1969.3 2047.3 2322.5 2348.4 2391.5 2193.7 2279.6 2283.4 2288.1 2292.2 2260.0 2262.5 2283.5 2304.1 2310.7 2276.9 2297.5 2298.3 2303.5 2349.6 9067.5 9121.5 9134.4 9141.1 9142.8 5220.8 5334.0 5392.5 5393.8 5402.3 3254.9 3395.5 3437.2 3458.6 3508.4 1119.9 1144.9 1165.9 1186.3 1197.9 12795.7 12862.0 12902.5 12940.9 12949.1 4452.8 4765.8 4794.7 4813.9 4850.9 10793.8 10809.3 10811.3 10817.1 10824.5 5437.5 5439.1 5440.6 5447.3 5447.9 4761.2 4872.4 5009.6 5010.2 5011.1 3777.8 3875.8 3879.5 3895.0 3975.8 1031.1 1059.2 1113.2 1123.2 1153.7 798.0 798.4 884.7 984.1 1015.9 5883.1 6155.2 6190.6 6195.2 6310.2 949.1 956.6 976.4 981.6 999.6 3958.8 4114.0 4171.0 4194.2 4235.7 11330.8 11553.4 11601.1 11630.2 11642.7 11451.3 11483.7 11546.1 11561.7 11563.9 7918.8 8309.0 8314.4 8488.3 8538.1 5943.3 6117.8 6225.3 6276.4 6300.2 10300.7 10691.5 10841.9 10854.4 10855.8 10454.0 10544.7 10816.1 10857.7 10923.6 7987.9 8074.4 8125.2 8144.9 8191.5 8386.5 8533.4 8541.6 8542.4 8542.7 7724.8 7882.2 7908.2 7986.6 8070.5 7374.4 7504.2 7521.6 7625.7 7945.4 7286.5 7409.7 7412.0 7425.8 7427.3 5177.9 5222.8 5231.5 5267.1 5542.4 5292.3 5357.5 5363.1 5399.0 5449.5 09:37:32 INFO - PROCESS | 2928 | 09:37:32 INFO - PROCESS | 2928 | [#4] prototype.html Cycles:180 Average:4600.79 Median:5136.19 stddev:1338.42 (26.1%) stddev-sans-first:1303.36 09:37:32 INFO - PROCESS | 2928 | Values: 337.6 340.4 341.6 343.3 348.7 4999.3 5180.8 5215.3 5254.9 5277.3 5057.4 5114.2 5125.9 5143.6 5172.7 4070.3 4072.8 4091.7 4096.8 4103.6 3988.9 4098.4 4100.7 4115.9 4124.2 4091.2 4091.8 4099.8 4100.5 4101.3 4080.2 4083.2 4089.2 4089.3 4101.5 3666.6 3677.7 3682.8 3683.3 3704.5 4896.5 5102.5 5114.3 5134.9 5137.5 4704.4 4718.3 4722.5 4726.4 4729.4 5459.2 5469.5 5471.3 5472.2 5507.1 3949.6 4069.2 4086.8 4091.4 4098.1 5614.1 5670.2 5675.6 5682.0 5706.8 4160.6 4160.8 4167.1 4167.7 4172.3 4086.6 4162.7 4174.2 4198.4 4248.8 4676.4 4683.9 4690.6 4726.5 4737.0 5460.2 5465.0 5505.0 5561.4 5564.7 1359.5 1391.2 1397.5 1433.8 1454.3 1012.4 1025.4 1040.6 1041.9 1043.9 5253.6 5301.6 5307.5 5311.7 5313.2 5549.9 5554.3 5560.2 5579.9 5592.4 5130.9 5144.2 5219.9 5314.9 5328.4 2563.7 2569.4 2574.3 2593.0 2621.3 5049.8 5055.0 5064.9 5082.4 5089.5 4953.0 4955.6 5340.5 5715.0 5735.3 5809.4 5825.3 5831.4 5835.6 5864.9 5521.6 5604.8 5618.7 5666.5 5674.3 5551.0 5571.6 5580.6 5605.0 5613.5 5813.0 5827.2 5834.4 5834.7 5850.6 3930.6 4069.9 4083.4 4096.3 4117.7 5331.6 5659.7 5664.2 5665.3 5682.1 5402.5 5431.6 5478.7 5481.6 5498.4 5449.2 5476.6 5482.3 5483.9 5545.6 5315.4 5473.6 5478.5 5487.8 5492.1 5480.8 5511.9 5518.6 5518.8 5526.8 5377.9 5413.2 5415.0 5438.7 5462.6 09:37:32 INFO - PROCESS | 2928 | 09:37:32 INFO - PROCESS | 2928 | [#5] yui.html Cycles:180 Average:21411.02 Median:4947.96 stddev:31839.20 (643.5%) stddev-sans-first:31890.70 09:37:32 INFO - PROCESS | 2928 | Values: 742.6 752.2 753.7 782.4 827.2 14495.0 17372.8 17456.2 17459.0 17484.6 15164.0 15603.2 15608.2 15616.8 15626.3 767.3 792.9 797.0 797.7 798.0 796.8 800.4 800.7 800.7 801.1 821.2 822.0 823.3 824.4 824.6 817.0 819.3 819.7 820.1 820.5 602.0 605.6 610.4 611.4 611.8 14753.1 14810.0 14814.3 14823.3 14828.2 13044.2 13046.5 13116.9 13163.7 13306.1 11553.8 11569.5 11685.5 11721.9 11956.9 3729.8 3757.6 3812.2 4012.9 4042.1 81385.6 82578.0 82677.0 84798.6 84999.6 9808.2 9820.4 9898.1 10015.1 10532.4 20639.7 20664.2 20692.6 20702.7 20708.7 8301.1 8532.3 8885.1 8952.2 8959.9 4659.6 4840.6 4860.1 4998.1 5067.7 3565.7 3691.5 3701.5 3703.8 3705.4 630.8 631.4 640.3 646.8 648.5 723.6 747.4 754.7 764.2 770.8 9021.5 9028.1 9566.3 9924.7 9964.8 641.8 662.5 669.9 673.1 675.1 4614.5 4938.0 4958.0 4994.8 4996.5 71627.3 100953.0 124357.4 125731.0 128458.4 107774.0 108603.0 109151.5 109228.5 114574.0 92045.0 93209.0 93749.0 95260.0 97044.5 8759.7 9013.4 9025.1 9032.5 9097.5 53117.2 54126.0 54156.7 54788.5 56287.0 74481.6 79748.6 80250.2 81701.6 81923.6 10158.8 10197.6 10252.5 10401.7 10422.9 12842.9 12970.6 13284.7 13719.6 13849.3 12540.7 12656.7 12871.6 12993.9 13070.2 11875.8 12361.0 12858.7 12942.4 12945.2 12342.1 12948.6 13077.0 13364.6 13470.8 10657.9 11265.6 11641.5 11678.5 11718.9 11350.3 11375.9 11473.3 11819.3 12175.1 09:37:32 INFO - PROCESS | 2928 | -------- Summary: end -------- 09:37:32 INFO - PROCESS | 2928 | 09:37:33 INFO - TEST-INFO | 2928: exit 0 09:37:33 INFO - TEST-OK | dromaeo_css | took 1118453ms 09:37:33 INFO - TEST-START | kraken 09:37:33 INFO - operating with platform_type : linux_ 09:37:33 INFO - Initialising browser for kraken test... 09:37:33 INFO - TEST-INFO | started process 3244 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCGITGC/profile http://localhost:52328/getInfo.html) 09:37:37 INFO - PROCESS | 3244 | __metrics Screen width/height:1600/1200 09:37:37 INFO - PROCESS | 3244 | colorDepth:24 09:37:37 INFO - PROCESS | 3244 | Browser inner width/height: 1024/697 09:37:37 INFO - PROCESS | 3244 | __metrics 09:37:38 INFO - PROCESS | 3244 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:37:38 INFO - PROCESS | 3244 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:37:38 INFO - PROCESS | 3244 | console.error: PushService: 09:37:38 INFO - PROCESS | 3244 | stateChangeProcessEnqueue: Error transitioning state 09:37:38 INFO - PROCESS | 3244 | UnknownError 09:37:39 INFO - TEST-INFO | 3244: exit 0 09:37:39 INFO - Browser initialized. 09:37:39 INFO - Running cycle 1/1 for kraken test... 09:37:39 INFO - TEST-INFO | started process 3331 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCGITGC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:37:51 INFO - PROCESS | 3331 | RSS: Main: 172625920 09:37:51 INFO - PROCESS | 3331 | 09:37:54 INFO - PROCESS | 3331 | Cycle 1(1): loaded http://localhost:52328/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52328/tests/kraken/driver.html?testName=audio-beat-detection) 09:37:55 INFO - PROCESS | 3331 | RSS: Main: 231972864 09:37:55 INFO - PROCESS | 3331 | 09:37:57 INFO - PROCESS | 3331 | Cycle 1(1): loaded http://localhost:52328/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52328/tests/kraken/driver.html?testName=audio-dft) 09:37:58 INFO - PROCESS | 3331 | RSS: Main: 216424448 09:37:58 INFO - PROCESS | 3331 | 09:38:01 INFO - PROCESS | 3331 | Cycle 1(1): loaded http://localhost:52328/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52328/tests/kraken/driver.html?testName=audio-fft) 09:38:02 INFO - PROCESS | 3331 | RSS: Main: 298246144 09:38:02 INFO - PROCESS | 3331 | 09:38:04 INFO - PROCESS | 3331 | Cycle 1(1): loaded http://localhost:52328/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52328/tests/kraken/driver.html?testName=audio-oscillator) 09:38:04 INFO - PROCESS | 3331 | RSS: Main: 207446016 09:38:04 INFO - PROCESS | 3331 | 09:38:06 INFO - PROCESS | 3331 | Cycle 1(1): loaded http://localhost:52328/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52328/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:38:07 INFO - PROCESS | 3331 | RSS: Main: 212549632 09:38:07 INFO - PROCESS | 3331 | 09:38:10 INFO - PROCESS | 3331 | Cycle 1(1): loaded http://localhost:52328/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52328/tests/kraken/driver.html?testName=imaging-darkroom) 09:38:11 INFO - PROCESS | 3331 | RSS: Main: 249098240 09:38:11 INFO - PROCESS | 3331 | 09:38:14 INFO - PROCESS | 3331 | Cycle 1(1): loaded http://localhost:52328/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52328/tests/kraken/driver.html?testName=imaging-desaturate) 09:38:15 INFO - PROCESS | 3331 | RSS: Main: 248029184 09:38:15 INFO - PROCESS | 3331 | 09:38:17 INFO - PROCESS | 3331 | Cycle 1(1): loaded http://localhost:52328/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52328/tests/kraken/driver.html?testName=json-parse-financial) 09:38:18 INFO - PROCESS | 3331 | RSS: Main: 247984128 09:38:18 INFO - PROCESS | 3331 | 09:38:20 INFO - PROCESS | 3331 | Cycle 1(1): loaded http://localhost:52328/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52328/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:38:20 INFO - PROCESS | 3331 | RSS: Main: 209686528 09:38:20 INFO - PROCESS | 3331 | 09:38:22 INFO - PROCESS | 3331 | Cycle 1(1): loaded http://localhost:52328/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52328/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:38:23 INFO - PROCESS | 3331 | RSS: Main: 216281088 09:38:23 INFO - PROCESS | 3331 | 09:38:25 INFO - PROCESS | 3331 | Cycle 1(1): loaded http://localhost:52328/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52328/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:38:25 INFO - PROCESS | 3331 | RSS: Main: 226406400 09:38:25 INFO - PROCESS | 3331 | 09:38:28 INFO - PROCESS | 3331 | Cycle 1(1): loaded http://localhost:52328/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52328/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:38:29 INFO - PROCESS | 3331 | RSS: Main: 234561536 09:38:29 INFO - PROCESS | 3331 | 09:38:31 INFO - PROCESS | 3331 | Cycle 1(1): loaded http://localhost:52328/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52328/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:38:32 INFO - PROCESS | 3331 | RSS: Main: 232546304 09:38:32 INFO - PROCESS | 3331 | 09:38:34 INFO - PROCESS | 3331 | Cycle 1(1): loaded http://localhost:52328/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52328/tests/kraken/driver.html?testName=ai-astar) 09:38:34 INFO - PROCESS | 3331 | RSS: Main: 283172864 09:38:34 INFO - PROCESS | 3331 | 09:38:34 INFO - PROCESS | 3331 | __start_tp_report 09:38:34 INFO - PROCESS | 3331 | _x_x_mozilla_page_load 09:38:34 INFO - PROCESS | 3331 | _x_x_mozilla_page_load_details 09:38:34 INFO - PROCESS | 3331 | |i|pagename|runs| 09:38:34 INFO - PROCESS | 3331 | |0;ai-astar;108;112;113;112;113;113;112;111;113;111 09:38:34 INFO - PROCESS | 3331 | |1;audio-beat-detection;149;124;124;168;122;124;124;123;167;126 09:38:34 INFO - PROCESS | 3331 | |2;audio-dft;161;160;161;161;163;161;160;161;160;159 09:38:34 INFO - PROCESS | 3331 | |3;audio-fft;76;75;76;106;76;77;76;76;102;75 09:38:34 INFO - PROCESS | 3331 | |4;audio-oscillator;82;82;116;83;84;82;101;82;81;107 09:38:34 INFO - PROCESS | 3331 | |5;imaging-gaussian-blur;117;117;116;117;117;118;117;117;117;116 09:38:34 INFO - PROCESS | 3331 | |6;imaging-darkroom;145;146;147;146;146;145;146;145;145;146 09:38:34 INFO - PROCESS | 3331 | |7;imaging-desaturate;95;95;94;96;95;96;95;95;95;94 09:38:34 INFO - PROCESS | 3331 | |8;json-parse-financial;53;51;52;50;53;52;52;52;52;52 09:38:34 INFO - PROCESS | 3331 | |9;json-stringify-tinderbox;60;60;59;60;60;62;60;60;61;62 09:38:34 INFO - PROCESS | 3331 | |10;stanford-crypto-aes;85;81;79;80;78;79;80;79;80;79 09:38:34 INFO - PROCESS | 3331 | |11;stanford-crypto-ccm;134;131;129;134;129;140;130;132;175;141 09:38:34 INFO - PROCESS | 3331 | |12;stanford-crypto-pbkdf2;168;163;165;163;164;166;164;164;165;164 09:38:34 INFO - PROCESS | 3331 | |13;stanford-crypto-sha256-iterative;67;66;66;66;65;65;65;65;64;64 09:38:34 INFO - PROCESS | 3331 | __end_tp_report 09:38:34 INFO - PROCESS | 3331 | __start_cc_report 09:38:34 INFO - PROCESS | 3331 | _x_x_mozilla_cycle_collect,1711 09:38:34 INFO - PROCESS | 3331 | __end_cc_report 09:38:34 INFO - PROCESS | 3331 | __startTimestamp1476203914387__endTimestamp 09:38:34 INFO - PROCESS | 3331 | 09:38:34 INFO - PROCESS | 3331 | ------- Summary: start ------- 09:38:34 INFO - PROCESS | 3331 | Number of tests: 14 09:38:34 INFO - PROCESS | 3331 | 09:38:34 INFO - PROCESS | 3331 | [#0] ai-astar Cycles:10 Average:111.80 Median:112.50 stddev:1.55 (1.4%) stddev-sans-first:0.83 09:38:34 INFO - PROCESS | 3331 | Values: 108.0 112.0 113.0 112.0 113.0 113.0 112.0 111.0 113.0 111.0 09:38:34 INFO - PROCESS | 3331 | 09:38:34 INFO - PROCESS | 3331 | [#1] audio-beat-detection Cycles:10 Average:135.10 Median:125.00 stddev:18.82 (15.1%) stddev-sans-first:19.28 09:38:34 INFO - PROCESS | 3331 | Values: 149.0 124.0 124.0 168.0 122.0 124.0 124.0 123.0 167.0 126.0 09:38:34 INFO - PROCESS | 3331 | 09:38:34 INFO - PROCESS | 3331 | [#2] audio-dft Cycles:10 Average:160.70 Median:161.00 stddev:1.06 (0.7%) stddev-sans-first:1.12 09:38:34 INFO - PROCESS | 3331 | Values: 161.0 160.0 161.0 161.0 163.0 161.0 160.0 161.0 160.0 159.0 09:38:34 INFO - PROCESS | 3331 | 09:38:34 INFO - PROCESS | 3331 | [#3] audio-fft Cycles:10 Average:81.50 Median:76.00 stddev:11.91 (15.7%) stddev-sans-first:12.46 09:38:34 INFO - PROCESS | 3331 | Values: 76.0 75.0 76.0 106.0 76.0 77.0 76.0 76.0 102.0 75.0 09:38:34 INFO - PROCESS | 3331 | 09:38:34 INFO - PROCESS | 3331 | [#4] audio-oscillator Cycles:10 Average:90.00 Median:82.00 stddev:12.94 (15.8%) stddev-sans-first:13.40 09:38:34 INFO - PROCESS | 3331 | Values: 82.0 82.0 116.0 83.0 84.0 82.0 101.0 82.0 81.0 107.0 09:38:34 INFO - PROCESS | 3331 | 09:38:34 INFO - PROCESS | 3331 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 09:38:34 INFO - PROCESS | 3331 | Values: 117.0 117.0 116.0 117.0 117.0 118.0 117.0 117.0 117.0 116.0 09:38:34 INFO - PROCESS | 3331 | 09:38:34 INFO - PROCESS | 3331 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.67 (0.5%) stddev-sans-first:0.67 09:38:34 INFO - PROCESS | 3331 | Values: 145.0 146.0 147.0 146.0 146.0 145.0 146.0 145.0 145.0 146.0 09:38:34 INFO - PROCESS | 3331 | 09:38:34 INFO - PROCESS | 3331 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 09:38:34 INFO - PROCESS | 3331 | Values: 95.0 95.0 94.0 96.0 95.0 96.0 95.0 95.0 95.0 94.0 09:38:34 INFO - PROCESS | 3331 | 09:38:34 INFO - PROCESS | 3331 | [#8] json-parse-financial Cycles:10 Average:51.90 Median:52.00 stddev:0.88 (1.7%) stddev-sans-first:0.83 09:38:34 INFO - PROCESS | 3331 | Values: 53.0 51.0 52.0 50.0 53.0 52.0 52.0 52.0 52.0 52.0 09:38:34 INFO - PROCESS | 3331 | 09:38:34 INFO - PROCESS | 3331 | [#9] json-stringify-tinderbox Cycles:10 Average:60.40 Median:60.00 stddev:0.97 (1.6%) stddev-sans-first:1.01 09:38:34 INFO - PROCESS | 3331 | Values: 60.0 60.0 59.0 60.0 60.0 62.0 60.0 60.0 61.0 62.0 09:38:34 INFO - PROCESS | 3331 | 09:38:34 INFO - PROCESS | 3331 | [#10] stanford-crypto-aes Cycles:10 Average:80.00 Median:80.00 stddev:1.94 (2.4%) stddev-sans-first:0.88 09:38:34 INFO - PROCESS | 3331 | Values: 85.0 81.0 79.0 80.0 78.0 79.0 80.0 79.0 80.0 79.0 09:38:34 INFO - PROCESS | 3331 | 09:38:34 INFO - PROCESS | 3331 | [#11] stanford-crypto-ccm Cycles:10 Average:137.50 Median:134.00 stddev:13.83 (10.3%) stddev-sans-first:14.62 09:38:34 INFO - PROCESS | 3331 | Values: 134.0 131.0 129.0 134.0 129.0 140.0 130.0 132.0 175.0 141.0 09:38:34 INFO - PROCESS | 3331 | 09:38:34 INFO - PROCESS | 3331 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.60 Median:164.50 stddev:1.51 (0.9%) stddev-sans-first:0.97 09:38:34 INFO - PROCESS | 3331 | Values: 168.0 163.0 165.0 163.0 164.0 166.0 164.0 164.0 165.0 164.0 09:38:34 INFO - PROCESS | 3331 | 09:38:34 INFO - PROCESS | 3331 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.30 Median:65.50 stddev:0.95 (1.4%) stddev-sans-first:0.78 09:38:34 INFO - PROCESS | 3331 | Values: 67.0 66.0 66.0 66.0 65.0 65.0 65.0 65.0 64.0 64.0 09:38:34 INFO - PROCESS | 3331 | -------- Summary: end -------- 09:38:34 INFO - PROCESS | 3331 | 09:38:35 INFO - TEST-INFO | 3331: exit 0 09:38:35 INFO - TEST-OK | kraken | took 62519ms 09:38:35 INFO - SUITE-END | took 1180s 09:38:36 INFO - Completed test suite (00:19:41) 09:38:36 INFO - javascript benchmark 09:38:36 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2981.5229563269877, 2992.6708062113175, 3017.034548944338, 3018.24543864034, 3062.647795503518, 5038.521340472658, 5080.898382032357, 5123.513266239706, 5148.613853960949, 5154.639175257734, 5197.844064678056, 5199.752059505719, 5226.712530810804, 5228.137357336035, 5246.685198888069, 4688.929666055021, 4722.64580156488, 4738.620910327166, 4748.955229849427, 4815.349927759743, 4573.108243892442, 4638.744869032202, 4663.743494107823, 4756.4767875533835, 4769.618430525549, 4751.477337492873, 4764.785584648682, 4819.590334821544, 4823.107725070856, 4828.034393121372, 4693.835715749967, 4793.32893394925, 4817.470078291385, 4821.445533763627, 4858.975705121487, 4768.070226305872, 4807.375041244616, 4836.758162091881, 4879.048585525824, 4882.487338829443, 5092.236164575306, 5096.108181068298, 5168.612354073422, 5222.764975576109, 5270.077736396153, 5560.499555040025, 5562.471565201299, 5568.331800183963, 5569.582281328876, 5570.108782594806, 5593.720313984284, 5597.048501754712, 5601.187827764992, 5615.691136987464, 5619.157126431027, 5200.6619569727845, 5239.738013099368, 5249.370075590915, 5264.078786212397, 5339.946600534023, 5717.199592057115, 5720.2849643794525, 5723.828285151452, 5735.082386818089, 5743.167240750151, 5280.049591073644, 5498.422665620053, 5524.944750552523, 5531.589444691578, 5581.665100094007, 5462.453754624586, 5507.201455788968, 5557.527610153183, 5562.72186390687, 5563.36021357541, 5438.558781922794, 5499.50504454601, 5505.724713764296, 5516.586256030814, 5592.384837667853, 5525.309336332958, 5526.889462210734, 5528.391876893538, 5541.750621222055, 5602.243697100839, 4202.411662367271, 4298.63461605767, 4303.096349766522, 4303.612674859278, 4363.454568178978, 3774.8490060397276, 3839.040239940015, 3845.4616353710503, 3846.4614953906475, 3856.421536769507, 5340.305760251143, 5349.224362467498, 5349.812756553502, 5352.437994010651, 5400.621956463088, 5628.352739434936, 5633.8591535211945, 5639.379668236491, 5643.5203007743985, 5709.571782116358, 5010.974945125251, 5117.0, 5278.683279003272, 5349.812756553502, 5356.8660783479945, 4857.465678775332, 4923.975380123076, 4933.0, 4959.330490383824, 4981.800727970913, 5777.826665200051, 5784.1034639630925, 5832.766689332379, 5843.970780146072, 5846.1230815377185, 5485.259489968963, 5551.722413879371, 5650.491455769001, 5654.6324488908085, 5721.084626459747, 5625.493705566519, 5655.971720141538, 5656.915146272727, 5757.251557297524, 5812.534997200299, 5384.6769193848495, 5387.892242155057, 5405.378381486179, 5415.620906536505, 5419.403865574863, 5428.9661225731925, 5473.0, 5477.808276710296, 5478.671279723229, 5544.861378465571, 5219.373675159005, 5261.105612045885, 5339.092354299856, 5360.892782144258, 5384.246205531307, 5356.250124982427, 5361.946380536145, 5416.106342453451, 5416.241726158262, 5465.344158700981, 5383.919241211307, 5386.48828361305, 5419.6206265562605, 5427.918581221206, 5495.2856128703015, 5361.410244873139, 5423.7830486780085, 5434.918476222939, 5448.863778405413, 5464.26232458613, 5342.412334643109, 5407.215953686615, 5409.810656626999, 5448.400675925565, 5471.343438787371], "value": 5139.865164581211, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [542.40116824867, 579.2007030298188, 614.7817524778703, 618.5484596244742, 640.1837656987337, 30880.691193088063, 41875.974883014045, 42472.787636061774, 42506.36240456396, 42564.36153457701, 43766.34350484738, 44253.0, 44264.77867610665, 44276.557234427644, 44296.55703442964, 8006.0, 8183.79540511486, 8844.77888052799, 8991.685291014815, 8998.19016288534, 10693.679189624285, 10968.725781855437, 10991.725206869853, 10992.615258465956, 10994.615188468406, 10743.51654175564, 10813.405262710548, 10841.728956776065, 10849.511771970241, 10859.67420977368, 10804.72988175294, 10866.456677166188, 10881.530993315959, 10889.891101088966, 10900.727481812979, 10596.629117980834, 10657.893421065844, 10663.733406664818, 10665.573377064908, 10669.146468282519, 41494.79252603718, 41730.374044389355, 41740.37389439161, 41778.0, 41784.1643167138, 3460.9480857786903, 3475.8609655614, 3491.0748651607346, 3635.3274644190647, 3674.191677830873, 30608.54087188694, 30680.53979190314, 31237.8438107808, 31531.684683153104, 32136.196595085075, 4012.578679238696, 4017.3773065174946, 4021.617946295097, 4061.614146656063, 4134.937975930334, 317928.0, 318693.0, 319040.0, 319383.0, 320070.0, 56787.14819277714, 57198.14202786962, 57272.42727572754, 57307.71346143326, 57428.71285643545, 35668.0, 59424.702876486204, 59457.70271148703, 59629.10556341658, 59653.40346596565, 14755.0, 15048.172350520827, 15495.612609684847, 15506.147161906203, 15509.689806204038, 11584.652460426201, 11840.407979600985, 11959.983401410804, 12011.33937633421, 12178.512859485698, 17833.46499605014, 17974.191161397768, 18211.362602308855, 18304.63390732178, 18466.0, 5570.944290557123, 6744.629045402452, 6835.555688880207, 6848.383645471931, 6993.160820701549, 824.2952275804101, 964.2430691906819, 980.6077568972325, 1021.8824835144054, 1072.7210925159359, 29772.255693607833, 31239.0, 31369.0, 31509.369812603618, 31815.204619884225, 1074.537948682074, 1098.340995402752, 1108.5067145120345, 1124.7806677697934, 1175.4651633506735, 15664.451744189126, 16096.436624718313, 16099.597510062342, 16764.664706705797, 16782.83217167813, 484054.0, 512244.0, 512603.0, 514598.0, 515322.0, 56134.43865561292, 56933.715331423075, 56936.0, 56968.715156423954, 57002.0, 1203.259995103023, 1306.6537367597593, 1344.5899000804652, 1352.5874608244383, 1362.2779926638898, 24063.879680601483, 33241.33517329591, 33288.0, 33540.66459335375, 33541.0, 52868.471315286355, 53598.46401535935, 53623.463765363405, 53648.244622876024, 53704.0, 364322.0, 367793.0, 368968.0, 369532.0, 369690.0, 27303.726962730118, 27825.860870695516, 27830.44339113166, 27934.860325698242, 28278.85860570684, 45341.0, 45553.31670025019, 46176.30735539037, 46829.76585117052, 47080.0, 37842.621573785014, 38439.231215376094, 38697.4195387075, 39983.60016399915, 40555.0, 38771.806140969114, 39224.803875981575, 39779.40330895097, 39979.60020399759, 40977.0, 39440.40839387354, 39574.20851582895, 39579.80210098931, 40195.19609607733, 40578.39132413075, 32856.0, 34963.300733985685, 35235.29529409346, 35900.28199436049, 36232.63767362398, 25517.23448296554, 25582.614164424336, 25699.0, 26071.0, 26110.477790443703], "value": 19797.971818254435, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [387.7983448606726, 397.201624734284, 405.8802653217302, 410.39876580809107, 424.168629486207, 13285.535006274782, 15201.0, 18757.906210468947, 19129.0, 19694.21223151076, 18184.636307273846, 18744.156512956917, 18783.812161878377, 18830.62338753224, 18880.716789248138, 5482.698451585161, 5589.804356847511, 5831.416858314155, 5840.299164100293, 5841.299044114712, 5581.079121944874, 5649.12438572022, 5664.830055098333, 5685.0, 5698.43015698431, 5464.5682671211125, 5636.408177141403, 5668.744906479198, 5677.347105082907, 5678.744456499447, 5622.859428514279, 5623.465770751772, 5657.688827114507, 5666.121751128581, 5694.544436445074, 4929.728864912428, 4978.5270399312, 5039.748012599392, 5067.847964561069, 5116.283720279164, 22140.446488837748, 22465.775342246696, 22599.62703916098, 22603.095876164934, 22654.773452265432, 2324.1284518305633, 2328.1734984080576, 2533.290678609974, 2577.1881857214917, 2960.978462430458, 13850.93074534631, 14130.646733831634, 14364.712705745827, 14391.856081439157, 14909.627259318495, 1886.1795119123226, 1959.559099202668, 1986.433866348084, 2001.8398528117716, 2029.9594008119902, 78550.6072469634, 78633.31616812578, 79687.0, 79926.0, 80490.59754701247, 10375.533101010473, 10380.480975951172, 10435.530401131968, 10842.620508282173, 10864.619738309279, 15409.229538523028, 15410.768838467431, 15430.768538471932, 15453.5363939082, 15462.458813941457, 7503.962480187564, 7795.688172473151, 7889.289963903277, 7910.327622152066, 7988.400869934778, 7297.744578939712, 7317.817054573678, 7382.667779949915, 7552.584607846511, 7650.273224043818, 6412.422881940648, 6437.774677886251, 6446.838829029218, 6563.901541476882, 6577.868442631217, 1840.3098837935775, 1854.040441818131, 1862.9254829806655, 1894.6305470433133, 1962.676158433871, 828.2256090555229, 918.42598376015, 974.5176137811828, 991.7818080022383, 1071.8552995345685, 18658.0, 19445.51386215356, 19526.511837204183, 19644.508887277647, 19686.606267874562, 954.2985905359556, 979.2557656181211, 989.4014121456559, 990.6235630460379, 1025.6102680981328, 10490.790184196427, 10888.836667449994, 10933.180011499011, 10992.835107473395, 11048.226624136234, 209859.0, 211877.0, 443558.0, 444690.0, 450243.0, 65756.0, 86953.5652321747, 95183.52408238054, 97366.5131674337, 99056.0, 991.7669347703284, 1024.636254129788, 1046.0533217438078, 1058.195771213883, 1064.9787004259872, 16437.342506299614, 16482.83517164813, 16902.154892255585, 17216.569585760455, 17384.65230695404, 28460.43079138447, 32704.67295327016, 37063.81468092642, 39848.601513985646, 40677.796611016754, 52957.47042529525, 55526.0, 55570.166447504125, 56485.0, 56573.71713141408, 8133.14601966785, 8292.0, 8540.188682075193, 8621.396502244783, 8668.566571671265, 12431.44058517387, 12521.311327877054, 12560.371981401076, 12941.54704585335, 13107.737845243233, 6075.817725468243, 10525.842112368473, 11168.832467513157, 11305.0, 11812.586559470377, 9081.500517471339, 11031.724206894893, 11182.552697891993, 11192.384418856715, 11439.197396637877, 10775.838362424412, 10869.29349592274, 11182.161337899528, 11314.151438642299, 12112.818307725567, 7904.881426778488, 8001.119876813429, 8049.476784009021, 8060.637271322687, 8293.253607175384, 8561.400701950804, 10919.781604368027, 10991.175661825235, 11107.0, 11439.0], "value": 9023.857981341731, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1450.5068276785894, 1481.4370539195106, 1606.1969015492255, 1719.6302794899095, 1760.5598600349913, 7982.405718141598, 8313.542755148464, 8576.0, 9259.675911343104, 9275.90724092758, 8597.18326758957, 8901.84276044115, 8921.866172007425, 9073.591688374023, 9099.272058235341, 2330.8368414211054, 2360.0441821062495, 2362.6692263083182, 2363.0075368345338, 2364.326167042393, 1969.2713695932525, 2047.2629853252893, 2322.5238826040704, 2348.4011577047827, 2391.485830546441, 2193.6819161221615, 2279.601069812776, 2283.372072680018, 2288.0847660935674, 2292.1748170658548, 2260.0, 2262.479629685173, 2283.4748007958096, 2304.101400453824, 2310.6996090508296, 2276.8520046196945, 2297.4830663100834, 2298.276043046452, 2303.504746479515, 2349.5888219561507, 9067.501287429188, 9121.49831759253, 9134.36059475837, 9141.131592498701, 9142.77143071422, 5220.765065572021, 5333.973330133364, 5392.541633961118, 5393.7572809223675, 5402.297701298845, 3254.853531591084, 3395.5246265522846, 3437.226624009603, 3458.602260740022, 3508.3509550733197, 1119.8880111988817, 1144.9427528623619, 1165.9417029148508, 1186.3178672263482, 1197.8981786548154, 12795.680107997374, 12862.0, 12902.483900643963, 12940.935295323463, 12949.093563450562, 4452.844150454718, 4765.809367625326, 4794.664373493892, 4813.919091781263, 4850.902981940341, 10793.83809242862, 10809.297395669257, 10811.297265677864, 10817.080548153495, 10824.458777061272, 5437.510624043855, 5439.102548079602, 5440.646357986719, 5447.264619276426, 5447.918281225785, 4761.2382018876815, 4872.3665923430435, 5009.649324547319, 5010.223415370623, 5011.1481048221885, 3777.7544459610035, 3875.7985024642453, 3879.515060617423, 3894.9610503895165, 3975.8409663613133, 1031.1235449867702, 1059.157969414302, 1113.2485572238706, 1123.1688550472754, 1153.6942710181809, 797.9680812767424, 798.4111617880376, 884.7213127864702, 984.0700537991529, 1015.9238057145743, 5883.0881213411985, 6155.230596175478, 6190.597611155261, 6195.2255968004, 6310.211223597051, 949.126803340928, 956.583886009588, 976.4336684722844, 981.6122631560494, 999.6251405722854, 3958.7822669752863, 4114.0, 4171.0, 4194.182134483746, 4235.661147108224, 11330.830037549444, 11553.36456494884, 11601.12991525639, 11630.244034137922, 11642.708932276591, 11451.25566838153, 11483.655490335303, 11546.134039947037, 11561.653150405502, 11563.88436115645, 7918.802029949297, 8309.044459887069, 8314.376421768391, 8488.278496327881, 8538.103499132625, 5943.286805583358, 6117.816465506042, 6225.252969643671, 6276.403741644536, 6300.180976473029, 10300.690979270634, 10691.518881650189, 10841.945790270998, 10854.40300783433, 10855.837162442413, 10454.0, 10544.736381590521, 10816.08063314627, 10857.674269771604, 10923.563057477611, 7987.880181797394, 8074.3944204183745, 8125.187481251827, 8144.918550814416, 8191.508509489449, 8386.538740369338, 8533.359998000298, 8541.572921353783, 8542.40203185771, 8542.701005465027, 7724.8455030900195, 7882.172371900868, 7908.169642187488, 7986.640601173078, 8070.475419097975, 7374.373178279906, 7504.174540800398, 7521.623918803928, 7625.6568454418575, 7945.44381893285, 7286.526375785557, 7409.740659076906, 7412.0, 7425.814354640961, 7427.331540161195, 5177.922331165111, 5222.817201397933, 5231.529162375405, 5267.104592219409, 5542.445755424425, 5292.259083728358, 5357.464253574612, 5363.0882749931825, 5398.973005134949, 5449.536789372789], "value": 4711.435608467596, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [337.5662273977939, 340.35672578826006, 341.5781509835353, 343.28425233388384, 348.7489007914302, 4999.25011248313, 5180.782516108711, 5215.269862219292, 5254.868628284295, 5277.261183434318, 5057.418396884359, 5114.156164232906, 5125.924445332798, 5143.614228932826, 5172.741362931848, 4070.3283958147017, 4072.837086516543, 4091.7340372875815, 4096.815643296059, 4103.558382762251, 3988.8603898863403, 4098.364753463218, 4100.671946244308, 4115.938260926088, 4124.237016152007, 4091.24312002279, 4091.7954102294916, 4099.770068979309, 4100.487439070116, 4101.323281658522, 4080.1839632073406, 4083.2445997490413, 4089.20260549193, 4089.325261331877, 4101.46680931477, 3666.5600127984544, 3677.687396571295, 3682.7606205596817, 3683.336999340118, 3704.499892514503, 4896.510348965075, 5102.4897510248675, 5114.258432527263, 5134.922976155361, 5137.460566640524, 4704.364910737041, 4718.268668356376, 4722.504137065627, 4726.39302637105, 4729.408823897013, 5459.235707001023, 5469.507744303032, 5471.261379713727, 5472.2338872557875, 5507.118860982264, 3949.5852935441653, 4069.2471892699946, 4086.7752273624938, 4091.40674602184, 4098.086327557206, 5614.147331380635, 5670.185540627001, 5675.602707810455, 5682.0, 5706.80026199081, 4160.647789468435, 4160.750354978651, 4167.1457351242925, 4167.708260421741, 4172.332426811696, 4086.6117718816663, 4162.729422587522, 4174.227767862955, 4198.3702444633545, 4248.787560621957, 4676.363272854542, 4683.882902927386, 4690.64820138491, 4726.527347265246, 4737.0, 5460.208269800856, 5464.972675136679, 5504.972475137679, 5561.416051314553, 5564.693941833238, 1359.5045450005114, 1391.1583491987403, 1397.489916180607, 1433.8207724034496, 1454.3237394611556, 1012.367270455965, 1025.4001409175717, 1040.6097713357492, 1041.8697662792151, 1043.9373637581768, 5253.632245742761, 5301.602379821529, 5307.548858347083, 5311.715962136319, 5313.1764576490705, 5549.889002220014, 5554.277943867352, 5560.165975103767, 5579.944200558024, 5592.440755924456, 5130.9230361544605, 5144.176931690911, 5219.869503262449, 5314.946850531523, 5328.3605967284175, 2563.730808265105, 2569.3663994405883, 2574.3049376668196, 2592.974070259311, 2621.3446638340415, 5049.823256186016, 5055.0, 5064.949350506521, 5082.415522214918, 5089.539113402848, 4952.975235123801, 4955.603551715854, 5340.49265319794, 5714.971425142848, 5735.254416925773, 5809.36097029318, 5825.33008703996, 5831.4168583141345, 5835.620684655484, 5864.853378665397, 5521.558275337883, 5604.8318550443555, 5618.6628802272, 5666.546676265972, 5674.319081710221, 5551.02938456842, 5571.637843540157, 5580.637258578179, 5604.971975140098, 5613.494785469327, 5813.023571985376, 5827.213326200908, 5834.445727655866, 5834.737436815439, 5850.561207909509, 3930.6265904739003, 4069.918601627892, 4083.387491876242, 4096.344584866407, 4117.711760176759, 5331.573474122139, 5659.745311460912, 5664.207011018543, 5665.263515742927, 5682.119271512922, 5402.486763757437, 5431.619786615057, 5478.698671572943, 5481.588880833874, 5498.395176530498, 5449.155380915964, 5476.58925580591, 5482.259894914136, 5483.917741233964, 5545.584081193846, 5315.3621565412395, 5473.644213126134, 5478.506934375925, 5487.847552014122, 5492.093804522369, 5480.753366098615, 5511.944880551143, 5518.613697041169, 5518.779248830002, 5526.834194974157, 5377.919331209957, 5413.215083812904, 5414.972925135507, 5438.673679579238, 5462.644928079662], "value": 4183.402563164966, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [742.5693098003159, 752.2176935986572, 753.7399597138985, 782.4405550031726, 827.1893544326559, 14495.0, 17372.826271737278, 17456.214470348834, 17459.0, 17484.562885927873, 15164.0, 15603.219839008032, 15608.21958902056, 15616.76574851378, 15626.29681664325, 767.3439209475888, 792.9405294602899, 797.0395673213764, 797.7008621766837, 797.9880301795478, 796.7808852565562, 800.3797057280625, 800.655718041242, 800.6877317846045, 801.0787594266611, 821.1624143373755, 821.9917800822005, 823.2960818500186, 824.3570015387977, 824.6206744897354, 816.9714060007872, 819.3486178488116, 819.6516480495795, 820.0692214336711, 820.5445977482494, 601.9638821670713, 605.6245128020612, 610.3896103896104, 611.3672349118685, 611.7644706787919, 14753.114813111248, 14810.0, 14814.333354999051, 14823.332950017168, 14828.184449855253, 13044.152130111512, 13046.54337098197, 13116.86883131166, 13163.67090822737, 13306.13510121839, 11553.808647196327, 11569.479373428216, 11685.474153663106, 11721.88278117225, 11956.940215298955, 3729.776213427176, 3757.5866654667966, 3812.218495208476, 4012.859549915739, 4042.110735638155, 81385.59307203426, 82578.0, 82677.0, 84798.5760071208, 84999.57500212522, 9808.21534277256, 9820.4107753535, 9898.10917017472, 10015.14871235953, 10532.420716860493, 20639.69040464394, 20664.173433062508, 20692.58614827695, 20702.689459657817, 20708.689369659467, 8301.128381519975, 8532.274756645755, 8885.111488851064, 8952.23905968, 8959.910400896038, 4659.58063774262, 4840.6127509799135, 4860.145416981232, 4998.125328067574, 5067.695938243717, 3565.679088881961, 3691.483192353073, 3701.481792549045, 3703.759255648374, 3705.444183372516, 630.8076036808726, 631.409631994087, 640.3372509452694, 646.8253571535753, 648.5103746671233, 723.5694761616829, 747.3834086878347, 754.7094368667993, 764.2204950950111, 770.8072981754561, 9021.503817290111, 9028.089383469485, 9566.33035687509, 9924.702258932244, 9964.750881227883, 641.8478830499265, 662.5428454366568, 669.9196096468357, 673.1316601583902, 675.0549231076434, 4614.475833072729, 4937.950620493821, 4957.975210123926, 4994.8251811187165, 4996.500349964975, 71627.2837271631, 100953.0, 124357.37821310836, 125731.0, 128458.35770821273, 107774.0, 108603.0, 109151.45424272827, 109228.4538577302, 114574.0, 92045.0, 93209.0, 93749.0, 95260.0, 97044.51477742566, 8759.737207883774, 9013.414128081653, 9025.097490250922, 9032.45805251687, 9097.454152750855, 53117.20324195063, 54126.0, 54156.72921635367, 54788.45211547993, 56287.0, 74481.62759186169, 79748.60125699567, 80250.19749802661, 81701.59149204454, 81923.59038204771, 10158.847617285894, 10197.592096316064, 10252.487375631337, 10401.68794936153, 10422.895771042497, 12842.935785321013, 12970.610881673565, 13284.667883302995, 13719.560561592798, 13849.307534623027, 12540.749185016066, 12656.74686506283, 12871.613851584467, 12993.870061299265, 13070.215787052808, 11875.762484750085, 12361.0, 12858.67853303675, 12942.41759120823, 12945.223286602833, 12342.13605047674, 12948.611541653765, 13077.019223558082, 13364.575715515055, 13470.797938031134, 10657.89342106569, 11265.605703800327, 11641.53433862636, 11678.532858685558, 11718.941405292919, 11350.318980861175, 11375.886241137483, 11473.254238474472, 11819.290842549475, 12175.14773965814], "value": 7500.984127092057, "unit": "score"}], "name": "dromaeo_css", "value": 7169.163232998886, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 112.0, 113.0, 112.0, 113.0, 113.0, 112.0, 111.0, 113.0, 111.0], "value": 111.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 124.0, 124.0, 168.0, 122.0, 124.0, 124.0, 123.0, 167.0, 126.0], "value": 135.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 161.0, 161.0, 163.0, 161.0, 160.0, 161.0, 160.0, 159.0], "value": 160.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 76.0, 106.0, 76.0, 77.0, 76.0, 76.0, 102.0, 75.0], "value": 81.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 116.0, 83.0, 84.0, 82.0, 101.0, 82.0, 81.0, 107.0], "value": 90.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 117.0, 118.0, 117.0, 117.0, 117.0, 116.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 147.0, 146.0, 146.0, 145.0, 146.0, 145.0, 145.0, 146.0], "value": 145.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 96.0, 95.0, 96.0, 95.0, 95.0, 95.0, 94.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 51.0, 52.0, 50.0, 53.0, 52.0, 52.0, 52.0, 52.0, 52.0], "value": 51.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 59.0, 60.0, 60.0, 62.0, 60.0, 60.0, 61.0, 62.0], "value": 60.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 81.0, 79.0, 80.0, 78.0, 79.0, 80.0, 79.0, 80.0, 79.0], "value": 80.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 131.0, 129.0, 134.0, 129.0, 140.0, 130.0, 132.0, 175.0, 141.0], "value": 137.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 163.0, 165.0, 163.0, 164.0, 166.0, 164.0, 164.0, 165.0, 164.0], "value": 164.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 66.0, 66.0, 65.0, 65.0, 65.0, 65.0, 64.0, 64.0], "value": 65.3, "unit": "score"}], "name": "kraken", "value": 1496.3999999999996, "alertThreshold": 2.0}]} 09:38:36 INFO - Return code: 0 09:38:36 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:38:36 INFO - # TBPL SUCCESS # 09:38:36 INFO - Running post-action listener: _resource_record_post_action 09:38:36 INFO - [mozharness: 2016-10-11 16:38:36.217255Z] Finished run-tests step (success) 09:38:36 INFO - Running post-run listener: _resource_record_post_run 09:38:36 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 4096; Write bytes: 393916416; Read time: 24; Write time: 520304 09:38:36 INFO - TinderboxPrint: CPU usage
13.1% 09:38:36 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 24 09:38:36 INFO - TinderboxPrint: I/O write bytes / time
393,916,416 / 520,304 09:38:36 INFO - TinderboxPrint: CPU idle
8,316.2 (86.9%) 09:38:36 INFO - TinderboxPrint: CPU user
1,197.0 (12.5%) 09:38:36 INFO - TinderboxPrint: Swap in / out
0 / 0 09:38:36 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 103874560; Read time: 0; Write time: 207372 09:38:36 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 0; Write bytes: 290041856; Read time: 0; Write time: 312932 09:38:36 INFO - Running post-run listener: _upload_blobber_files 09:38:36 INFO - Blob upload gear active. 09:38:36 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:38:36 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 09:38:36 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', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:38:36 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 Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:38:37 INFO - (blobuploader) - INFO - Open directory for files ... 09:38:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:38:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:38:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:38:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:38:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:38:38 INFO - (blobuploader) - INFO - Done attempting. 09:38:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:38:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:38:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:38:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:38:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:38:39 INFO - (blobuploader) - INFO - Done attempting. 09:38:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:38:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:38:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:38:42 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:38:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:38:42 INFO - (blobuploader) - INFO - Done attempting. 09:38:42 INFO - (blobuploader) - INFO - Iteration through files over. 09:38:42 INFO - Return code: 0 09:38:42 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:38:42 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:38:42 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2768bdb5ffaa87f37a406c3a8010a3a844dbba121e5fb5787d10f1e5e03c9e0e17484ba5700ba5486d9d652ad6a707f7cf6113a4ed502ba8bf0f3be36166f2e2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ac00cf6e22317ec1aa81f9d2c37a39c910a69c5a30aa308b54779e927684abc638c06463f15e26693fa45b3a73a208661a87e0ae48f69f59dcc4010ed17e7057", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d602b23c797cb425992432f6ba5bcdc13657f0df91027293702279934bfaa70ea2628e1fa5ec284451d0507f0337b8f673632519242d8b3249d82a5ec2753cbc"} 09:38:42 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:38:42 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:38:42 INFO - Contents: 09:38:42 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2768bdb5ffaa87f37a406c3a8010a3a844dbba121e5fb5787d10f1e5e03c9e0e17484ba5700ba5486d9d652ad6a707f7cf6113a4ed502ba8bf0f3be36166f2e2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ac00cf6e22317ec1aa81f9d2c37a39c910a69c5a30aa308b54779e927684abc638c06463f15e26693fa45b3a73a208661a87e0ae48f69f59dcc4010ed17e7057", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d602b23c797cb425992432f6ba5bcdc13657f0df91027293702279934bfaa70ea2628e1fa5ec284451d0507f0337b8f673632519242d8b3249d82a5ec2753cbc"} 09:38:42 INFO - Running post-run listener: copy_logs_to_upload_dir 09:38:42 INFO - Copying logs to upload dir... 09:38:42 INFO - mkdir: /builds/slave/test/build/upload/logs 09:38:42 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1242.657081 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-10-11 09:38:42.381587) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-11 09:38:42.385588) ========= 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=14ef55db36f7623abb31b9cf000001d5-1476202653.785782-48228851 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2768bdb5ffaa87f37a406c3a8010a3a844dbba121e5fb5787d10f1e5e03c9e0e17484ba5700ba5486d9d652ad6a707f7cf6113a4ed502ba8bf0f3be36166f2e2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ac00cf6e22317ec1aa81f9d2c37a39c910a69c5a30aa308b54779e927684abc638c06463f15e26693fa45b3a73a208661a87e0ae48f69f59dcc4010ed17e7057", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d602b23c797cb425992432f6ba5bcdc13657f0df91027293702279934bfaa70ea2628e1fa5ec284451d0507f0337b8f673632519242d8b3249d82a5ec2753cbc"} build_url:https://queue.taskcluster.net/v1/task/OXumNNtiRvOTYjaHkJGKOQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011539 build_url: 'https://queue.taskcluster.net/v1/task/OXumNNtiRvOTYjaHkJGKOQ/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/Fx-Team/sha512/2768bdb5ffaa87f37a406c3a8010a3a844dbba121e5fb5787d10f1e5e03c9e0e17484ba5700ba5486d9d652ad6a707f7cf6113a4ed502ba8bf0f3be36166f2e2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ac00cf6e22317ec1aa81f9d2c37a39c910a69c5a30aa308b54779e927684abc638c06463f15e26693fa45b3a73a208661a87e0ae48f69f59dcc4010ed17e7057", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d602b23c797cb425992432f6ba5bcdc13657f0df91027293702279934bfaa70ea2628e1fa5ec284451d0507f0337b8f673632519242d8b3249d82a5ec2753cbc"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-11 09:38:42.410768) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-11 09:38:42.411081) ========= 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=14ef55db36f7623abb31b9cf000001d5-1476202653.785782-48228851 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004444 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-11 09:38:42.496003) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-11 09:38:42.496341) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-11 09:38:42.496655) ========= ========= Total master_lag: 0.18 =========