builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-019 starttime: 1476271799.7 results: success (0) buildid: 20161012030047 builduid: 9b8d1d19239f487284ae5b83245a7830 revision: feb1c52ebe9ef8cff09dea275aa06d9441f5fe93 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-12 04:29:59.701655) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-12 04:29:59.702121) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-12 04:29:59.702393) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-12 04:29:59.717308) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-12 04:29:59.717686) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1476271799.191629-1009675222 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-12 04:30:00-- 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% 56.1M=0s 2016-10-12 04:30:00 (56.1 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.358158 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-12 04:30:00.091176) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-12 04:30:00.091766) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1476271799.191629-1009675222 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020496 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-12 04:30:00.142705) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-12 04:30:00.143077) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev feb1c52ebe9ef8cff09dea275aa06d9441f5fe93 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev feb1c52ebe9ef8cff09dea275aa06d9441f5fe93 --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=78329bfc0fd5309db0a6e0ac000001b4-1476271799.191629-1009675222 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-12 04:30:00,635 truncating revision to first 12 chars 2016-10-12 04:30:00,635 Setting DEBUG logging. 2016-10-12 04:30:00,636 attempt 1/10 2016-10-12 04:30:00,636 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/feb1c52ebe9e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-12 04:30:00,973 unpacking tar archive at: mozilla-central-feb1c52ebe9e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.739999 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-12 04:30:00.897420) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-12 04:30:00.898022) ========= script_repo_revision: feb1c52ebe9ef8cff09dea275aa06d9441f5fe93 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-12 04:30:00.898813) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-12 04:30:00.899279) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-12 04:30:00.911027) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-10-12 04:30:00.911666) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=78329bfc0fd5309db0a6e0ac000001b4-1476271799.191629-1009675222 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:30:01 INFO - MultiFileLogger online at 20161012 04:30:01 in /builds/slave/test 04:30:01 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 04:30:01 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:30:01 INFO - {'append_to_log': False, 04:30:01 INFO - 'base_work_dir': '/builds/slave/test', 04:30:01 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 04:30:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:30:01 INFO - 'branch': 'Firefox-Non-PGO', 04:30:01 INFO - 'buildbot_json_path': 'buildprops.json', 04:30:01 INFO - 'config_files': ('talos/linux_config.py',), 04:30:01 INFO - 'default_actions': ('clobber', 04:30:01 INFO - 'read-buildbot-config', 04:30:01 INFO - 'download-and-extract', 04:30:01 INFO - 'populate-webroot', 04:30:01 INFO - 'create-virtualenv', 04:30:01 INFO - 'install', 04:30:01 INFO - 'run-tests'), 04:30:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:30:01 INFO - 'download_minidump_stackwalk': True, 04:30:01 INFO - 'download_symbols': 'ondemand', 04:30:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:30:01 INFO - 'tooltool.py': '/tools/tooltool.py', 04:30:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:30:01 INFO - '/tools/misc-python/virtualenv.py')}, 04:30:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:30:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:30:01 INFO - 'installer_path': 'installer.exe', 04:30:01 INFO - 'log_level': 'info', 04:30:01 INFO - 'log_name': 'talos', 04:30:01 INFO - 'log_to_console': True, 04:30:01 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:30:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:30:01 INFO - 'opt_config_files': (), 04:30:01 INFO - 'pip_index': False, 04:30:01 INFO - 'sps_profile': False, 04:30:01 INFO - 'sps_profile_interval': 0, 04:30:01 INFO - 'suite': 'dromaeojs', 04:30:01 INFO - 'system_bits': '32', 04:30:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:30:01 INFO - 'title': 'talos-linux64-ix-019', 04:30:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:30:01 INFO - 'use_talos_json': True, 04:30:01 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:30:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:30:01 INFO - 'work_dir': 'build'} 04:30:01 INFO - [mozharness: 2016-10-12 11:30:01.503992Z] Running clobber step. 04:30:01 INFO - Running pre-action listener: _resource_record_pre_action 04:30:01 INFO - Running main action method: clobber 04:30:01 INFO - rmtree: /builds/slave/test/build 04:30:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:30:01 INFO - Running post-action listener: _resource_record_post_action 04:30:01 INFO - [mozharness: 2016-10-12 11:30:01.966172Z] Finished clobber step (success) 04:30:01 INFO - [mozharness: 2016-10-12 11:30:01.966273Z] Running read-buildbot-config step. 04:30:01 INFO - Running pre-action listener: _resource_record_pre_action 04:30:01 INFO - Running main action method: read_buildbot_config 04:30:01 INFO - Using buildbot properties: 04:30:01 INFO - { 04:30:01 INFO - "project": "", 04:30:01 INFO - "product": "firefox", 04:30:01 INFO - "script_repo_revision": "production", 04:30:01 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 04:30:01 INFO - "repository": "", 04:30:01 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 04:30:01 INFO - "buildid": "20161012030047", 04:30:01 INFO - "pgo_build": "False", 04:30:01 INFO - "basedir": "/builds/slave/test", 04:30:01 INFO - "buildnumber": 668, 04:30:01 INFO - "slavename": "talos-linux64-ix-019", 04:30:01 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 04:30:01 INFO - "platform": "ubuntu64_hw", 04:30:01 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 04:30:01 INFO - "branch": "mozilla-central", 04:30:01 INFO - "repo_path": "mozilla-central", 04:30:01 INFO - "revision": "feb1c52ebe9ef8cff09dea275aa06d9441f5fe93", 04:30:01 INFO - "stage_platform": "linux64", 04:30:01 INFO - "builduid": "9b8d1d19239f487284ae5b83245a7830", 04:30:01 INFO - "slavebuilddir": "test" 04:30:01 INFO - } 04:30:01 INFO - Found installer url https://queue.taskcluster.net/v1/task/KH-T8TvTT12rvCGfGBb32g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 04:30:01 INFO - Running post-action listener: _resource_record_post_action 04:30:01 INFO - [mozharness: 2016-10-12 11:30:01.968794Z] Finished read-buildbot-config step (success) 04:30:01 INFO - [mozharness: 2016-10-12 11:30:01.968900Z] Running download-and-extract step. 04:30:01 INFO - Running pre-action listener: _resource_record_pre_action 04:30:01 INFO - Running main action method: download_and_extract 04:30:01 INFO - mkdir: /builds/slave/test/build/tests 04:30: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')]} 04:30:01 INFO - trying https://queue.taskcluster.net/v1/task/KH-T8TvTT12rvCGfGBb32g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 04:30:01 INFO - Downloading https://queue.taskcluster.net/v1/task/KH-T8TvTT12rvCGfGBb32g/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 04:30:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KH-T8TvTT12rvCGfGBb32g/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 04:30:02 INFO - Downloaded 1361 bytes. 04:30:02 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 04:30:02 INFO - Using the following test package requirements: 04:30:02 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 04:30:02 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:30:02 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:30:02 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:30:02 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:30:02 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:30:02 INFO - u'jsshell-linux-x86_64.zip'], 04:30:02 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:30:02 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:30:02 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 04:30:02 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:30:02 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:30:02 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:30:02 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:30:02 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:30:02 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:30:02 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:30:02 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:30:02 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:30:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/KH-T8TvTT12rvCGfGBb32g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 04:30:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KH-T8TvTT12rvCGfGBb32g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:30:02 INFO - Fetch https://queue.taskcluster.net/v1/task/KH-T8TvTT12rvCGfGBb32g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 04:30:03 INFO - Http code: 200 04:30:03 INFO - via: 1.1 4c2196e36fd33f377384d605b4424e95.cloudfront.net (CloudFront) 04:30:03 INFO - x-amz-cf-id: 9eJjFv18T1xB1y5lz7SNmWDmlY8p9Vv-i--QbK-hZA5dGjc0nCl2qw== 04:30:03 INFO - x-amz-version-id: .TP7CWzv1iLu9qsWK_T62ACUe4ycl731 04:30:03 INFO - Expected file size: 20528383 04:30:03 INFO - Obtained file size: 20528383 04:30:07 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 04:30:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/KH-T8TvTT12rvCGfGBb32g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 04:30:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KH-T8TvTT12rvCGfGBb32g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:30:07 INFO - Fetch https://queue.taskcluster.net/v1/task/KH-T8TvTT12rvCGfGBb32g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 04:30:07 INFO - Http code: 200 04:30:07 INFO - via: 1.1 ba26a6eef2785fa2e20e601890b882b2.cloudfront.net (CloudFront) 04:30:07 INFO - x-amz-cf-id: cH2QjmR72j8C6q6OGIn9-Cx6nK_4vPIV5d6XPXhoMGCN_TZTs3Dsqg== 04:30:07 INFO - x-amz-version-id: .TP7CWzv1iLu9qsWK_T62ACUe4ycl731 04:30:08 INFO - Expected file size: 20528383 04:30:08 INFO - Obtained file size: 20528383 04:30:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/KH-T8TvTT12rvCGfGBb32g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 04:30:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KH-T8TvTT12rvCGfGBb32g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 04:30:12 INFO - Fetch https://queue.taskcluster.net/v1/task/KH-T8TvTT12rvCGfGBb32g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 04:30:13 INFO - Http code: 200 04:30:13 INFO - via: 1.1 41b2ee7cbe95749816a7586d9ab4629d.cloudfront.net (CloudFront) 04:30:13 INFO - x-amz-cf-id: Gq6H9dqFrAJqAuux7hQZODUILunLTgZn1WAnOG4yZ111tPsf204GQg== 04:30:13 INFO - x-amz-version-id: 1maPU56SWbOY0c4jsOA7CwB3421wdv46 04:30:13 INFO - Expected file size: 14409006 04:30:13 INFO - Obtained file size: 14409006 04:30: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')]} 04:30:13 INFO - trying https://queue.taskcluster.net/v1/task/KH-T8TvTT12rvCGfGBb32g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 04:30:13 INFO - Downloading https://queue.taskcluster.net/v1/task/KH-T8TvTT12rvCGfGBb32g/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 04:30:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KH-T8TvTT12rvCGfGBb32g/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 04:30:14 INFO - Downloaded 55910768 bytes. 04:30:14 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/KH-T8TvTT12rvCGfGBb32g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 04:30:14 INFO - mkdir: /builds/slave/test/properties 04:30:14 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:30:14 INFO - Writing to file /builds/slave/test/properties/build_url 04:30:14 INFO - Contents: 04:30:14 INFO - build_url:https://queue.taskcluster.net/v1/task/KH-T8TvTT12rvCGfGBb32g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 04:30:16 INFO - Running post-action listener: _resource_record_post_action 04:30:16 INFO - Running post-action listener: set_extra_try_arguments 04:30:16 INFO - [mozharness: 2016-10-12 11:30:16.469133Z] Finished download-and-extract step (success) 04:30:16 INFO - [mozharness: 2016-10-12 11:30:16.469429Z] Running populate-webroot step. 04:30:16 INFO - Running pre-action listener: _resource_record_pre_action 04:30:16 INFO - Running main action method: populate_webroot 04:30:16 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:30:16 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:30:16 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:30:16 INFO - '--tppagecycles', 04:30:16 INFO - '7'], 04:30:16 INFO - 'tests': ['tsvgm']}}, 04:30:16 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:30:16 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:30:16 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:30:16 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:30:16 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:30:16 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:30:16 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:30:16 INFO - 'talos_options': ['--disable-e10s'], 04:30:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:30:16 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:30:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:30:16 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:30:16 INFO - 'talos_options': ['--disable-e10s'], 04:30:16 INFO - 'tests': ['damp', 'tps']}, 04:30:16 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:30:16 INFO - 'tests': ['damp', 'tps']}, 04:30:16 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:30:16 INFO - 'tests': ['dromaeo_dom']}, 04:30:16 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:30:16 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:30:16 INFO - 'tests': ['basic_compositor_video']}, 04:30:16 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:30:16 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:30:16 INFO - 'tests': ['a11yr', 04:30:16 INFO - 'ts_paint', 04:30:16 INFO - 'tpaint', 04:30:16 INFO - 'sessionrestore', 04:30:16 INFO - 'sessionrestore_no_auto_restore', 04:30:16 INFO - 'tabpaint']}, 04:30:16 INFO - 'other-e10s': {'tests': ['a11yr', 04:30:16 INFO - 'ts_paint', 04:30:16 INFO - 'tpaint', 04:30:16 INFO - 'sessionrestore', 04:30:16 INFO - 'sessionrestore_no_auto_restore', 04:30:16 INFO - 'tabpaint']}, 04:30:16 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:30:16 INFO - 'ts_paint', 04:30:16 INFO - 'tpaint', 04:30:16 INFO - 'sessionrestore', 04:30:16 INFO - 'sessionrestore_no_auto_restore', 04:30:16 INFO - 'tabpaint']}, 04:30:16 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:30:16 INFO - 'ts_paint', 04:30:16 INFO - 'tpaint', 04:30:16 INFO - 'sessionrestore', 04:30:16 INFO - 'sessionrestore_no_auto_restore', 04:30:16 INFO - 'tabpaint']}, 04:30:16 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:30:16 INFO - 'tests': ['a11yr', 04:30:16 INFO - 'ts_paint', 04:30:16 INFO - 'tpaint', 04:30:16 INFO - 'sessionrestore', 04:30:16 INFO - 'sessionrestore_no_auto_restore', 04:30:16 INFO - 'tabpaint']}, 04:30:16 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:30:16 INFO - 'tests': ['a11yr', 04:30:16 INFO - 'ts_paint', 04:30:16 INFO - 'tpaint', 04:30:16 INFO - 'sessionrestore', 04:30:16 INFO - 'sessionrestore_no_auto_restore', 04:30:16 INFO - 'tabpaint']}, 04:30:16 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:30:16 INFO - 'tests': ['tsvgx', 04:30:16 INFO - 'tsvgr_opacity', 04:30:16 INFO - 'tart', 04:30:16 INFO - 'tscrollx', 04:30:16 INFO - 'cart']}, 04:30:16 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:30:16 INFO - 'tsvgr_opacity', 04:30:16 INFO - 'tart', 04:30:16 INFO - 'tscrollx', 04:30:16 INFO - 'cart']}, 04:30:16 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:30:16 INFO - 'talos_options': ['--disable-e10s'], 04:30:16 INFO - 'tests': ['tp5o']}, 04:30:16 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:30:16 INFO - 'tests': ['tp5o']}, 04:30:16 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:30:16 INFO - 'talos_options': ['--disable-e10s', 04:30:16 INFO - '--xperf_path', 04:30:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:30:16 INFO - 'tests': ['tp5n']}, 04:30:16 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:30:16 INFO - 'talos_options': ['--xperf_path', 04:30:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:30:16 INFO - 'tests': ['tp5n']}}, 04:30:16 INFO - 'talos.zip': {'path': '', 04:30:16 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:30:16 INFO - Running post-action listener: _resource_record_post_action 04:30:16 INFO - [mozharness: 2016-10-12 11:30:16.488498Z] Finished populate-webroot step (success) 04:30:16 INFO - [mozharness: 2016-10-12 11:30:16.488590Z] Running create-virtualenv step. 04:30:16 INFO - Running pre-action listener: _resource_record_pre_action 04:30:16 INFO - Running main action method: create_virtualenv 04:30:16 INFO - Creating virtualenv /builds/slave/test/build/venv 04:30:16 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 04:30:16 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:30:16 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:30:16 INFO - Using real prefix '/usr' 04:30:16 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:30:17 INFO - Installing distribute.............................................................................................................................................................................................done. 04:30:19 INFO - Installing pip.................done. 04:30:19 INFO - Return code: 0 04:30:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:30:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:30:19 INFO - Reading from file tmpfile_stdout 04:30:19 INFO - Output received: 04:30:19 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) 04:30:19 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:30:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:30:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:30:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:30:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:30:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30:19 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 0x7f472e256f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1552ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x154ff60>, '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 0x1550d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15511d0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1476271799.191629-1009675222', '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 04:30:19 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 04:30:19 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 04:30:19 INFO - Using env: {'DISPLAY': ':0', 04:30:19 INFO - 'HOME': '/home/cltbld', 04:30:19 INFO - 'LANG': 'en_US.UTF-8', 04:30:19 INFO - 'LANGUAGE': 'en_US:en', 04:30:19 INFO - 'LOGNAME': 'cltbld', 04:30:19 INFO - 'MAIL': '/var/mail/cltbld', 04:30:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:30:19 INFO - 'MOZ_NO_REMOTE': '1', 04:30:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:30:19 INFO - 'NO_EM_RESTART': '1', 04:30:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:30:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:30:19 INFO - 'PWD': '/builds/slave/test', 04:30:19 INFO - 'SHELL': '/bin/bash', 04:30:19 INFO - 'SHLVL': '1', 04:30:19 INFO - 'TERM': 'linux', 04:30:19 INFO - 'TMOUT': '86400', 04:30:19 INFO - 'USER': 'cltbld', 04:30:19 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1476271799.191629-1009675222', 04:30:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:30:19 INFO - '_': '/tools/buildbot/bin/python'} 04:30:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:30:19 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 04:30:19 INFO - Cleaning up... 04:30:19 INFO - Return code: 0 04:30:19 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:30:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:30:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:30:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:30:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:30:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30:19 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 0x7f472e256f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1552ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x154ff60>, '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 0x1550d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15511d0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1476271799.191629-1009675222', '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 04:30:19 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 04:30:19 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 04:30:19 INFO - Using env: {'DISPLAY': ':0', 04:30:19 INFO - 'HOME': '/home/cltbld', 04:30:19 INFO - 'LANG': 'en_US.UTF-8', 04:30:19 INFO - 'LANGUAGE': 'en_US:en', 04:30:19 INFO - 'LOGNAME': 'cltbld', 04:30:19 INFO - 'MAIL': '/var/mail/cltbld', 04:30:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:30:19 INFO - 'MOZ_NO_REMOTE': '1', 04:30:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:30:19 INFO - 'NO_EM_RESTART': '1', 04:30:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:30:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:30:19 INFO - 'PWD': '/builds/slave/test', 04:30:19 INFO - 'SHELL': '/bin/bash', 04:30:19 INFO - 'SHLVL': '1', 04:30:19 INFO - 'TERM': 'linux', 04:30:19 INFO - 'TMOUT': '86400', 04:30:19 INFO - 'USER': 'cltbld', 04:30:19 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1476271799.191629-1009675222', 04:30:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:30:19 INFO - '_': '/tools/buildbot/bin/python'} 04:30:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:30:19 INFO - Downloading/unpacking psutil>=3.1.1 04:30:19 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 04:30:19 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 04:30:19 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 04:30:19 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 04:30:19 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 04:30:19 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 04:30:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:30:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:30:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:30:21 INFO - Installing collected packages: psutil 04:30:21 INFO - Running setup.py install for psutil 04:30:21 INFO - building 'psutil._psutil_linux' extension 04:30:21 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 04:30:21 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 04:30:21 INFO - building 'psutil._psutil_posix' extension 04:30:21 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 04:30:22 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 04:30:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:30:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:30:22 INFO - Successfully installed psutil 04:30:22 INFO - Cleaning up... 04:30:22 INFO - Return code: 0 04:30:22 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:30:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:30:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:30:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:30:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:30:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30:22 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 0x7f472e256f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1552ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x154ff60>, '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 0x1550d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15511d0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1476271799.191629-1009675222', '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 04:30:22 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 04:30:22 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 04:30:22 INFO - Using env: {'DISPLAY': ':0', 04:30:22 INFO - 'HOME': '/home/cltbld', 04:30:22 INFO - 'LANG': 'en_US.UTF-8', 04:30:22 INFO - 'LANGUAGE': 'en_US:en', 04:30:22 INFO - 'LOGNAME': 'cltbld', 04:30:22 INFO - 'MAIL': '/var/mail/cltbld', 04:30:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:30:22 INFO - 'MOZ_NO_REMOTE': '1', 04:30:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:30:22 INFO - 'NO_EM_RESTART': '1', 04:30:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:30:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:30:22 INFO - 'PWD': '/builds/slave/test', 04:30:22 INFO - 'SHELL': '/bin/bash', 04:30:22 INFO - 'SHLVL': '1', 04:30:22 INFO - 'TERM': 'linux', 04:30:22 INFO - 'TMOUT': '86400', 04:30:22 INFO - 'USER': 'cltbld', 04:30:22 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1476271799.191629-1009675222', 04:30:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:30:22 INFO - '_': '/tools/buildbot/bin/python'} 04:30:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:30:22 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:30:22 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 04:30:22 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 04:30:22 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 04:30:22 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 04:30:22 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 04:30:22 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 04:30:24 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:30:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:30:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:30:24 INFO - Installing collected packages: mozsystemmonitor 04:30:24 INFO - Running setup.py install for mozsystemmonitor 04:30:24 INFO - Successfully installed mozsystemmonitor 04:30:24 INFO - Cleaning up... 04:30:24 INFO - Return code: 0 04:30:24 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:30:24 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')]} 04:30:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:30:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30:24 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')]} 04:30:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:30:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30:24 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 0x7f472e256f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1552ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x154ff60>, '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 0x1550d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15511d0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1476271799.191629-1009675222', '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 04:30:24 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 04:30:24 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 04:30:24 INFO - Using env: {'DISPLAY': ':0', 04:30:24 INFO - 'HOME': '/home/cltbld', 04:30:24 INFO - 'LANG': 'en_US.UTF-8', 04:30:24 INFO - 'LANGUAGE': 'en_US:en', 04:30:24 INFO - 'LOGNAME': 'cltbld', 04:30:24 INFO - 'MAIL': '/var/mail/cltbld', 04:30:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:30:24 INFO - 'MOZ_NO_REMOTE': '1', 04:30:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:30:24 INFO - 'NO_EM_RESTART': '1', 04:30:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:30:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:30:24 INFO - 'PWD': '/builds/slave/test', 04:30:24 INFO - 'SHELL': '/bin/bash', 04:30:24 INFO - 'SHLVL': '1', 04:30:24 INFO - 'TERM': 'linux', 04:30:24 INFO - 'TMOUT': '86400', 04:30:24 INFO - 'USER': 'cltbld', 04:30:24 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1476271799.191629-1009675222', 04:30:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:30:24 INFO - '_': '/tools/buildbot/bin/python'} 04:30:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:30:24 INFO - Downloading/unpacking jsonschema==2.5.1 04:30:24 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 04:30:24 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 04:30:24 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 04:30:24 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 04:30:24 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 04:30:24 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 04:30:26 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:30:26 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:30: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 04:30: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 04:30: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 04:30: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 04:30: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 04:30: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 04:30:26 INFO - Downloading functools32-3.2.3-2.tar.gz 04:30:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:30:27 INFO - warning: no files found matching '*.txt' 04:30:27 INFO - no previously-included directories found matching 'build' 04:30:27 INFO - no previously-included directories found matching 'dist' 04:30:27 INFO - no previously-included directories found matching '.git*' 04:30:27 INFO - Installing collected packages: jsonschema, functools32 04:30:27 INFO - Running setup.py install for functools32 04:30:27 INFO - warning: no files found matching '*.txt' 04:30:27 INFO - no previously-included directories found matching 'build' 04:30:27 INFO - no previously-included directories found matching 'dist' 04:30:27 INFO - no previously-included directories found matching '.git*' 04:30:27 INFO - Successfully installed jsonschema functools32 04:30:27 INFO - Cleaning up... 04:30:27 INFO - Return code: 0 04:30:27 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:30:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:30:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:30:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:30:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:30:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30:27 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 0x7f472e256f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1552ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x154ff60>, '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 0x1550d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15511d0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1476271799.191629-1009675222', '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 04:30:27 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 04:30:27 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 04:30:27 INFO - Using env: {'DISPLAY': ':0', 04:30:27 INFO - 'HOME': '/home/cltbld', 04:30:27 INFO - 'LANG': 'en_US.UTF-8', 04:30:27 INFO - 'LANGUAGE': 'en_US:en', 04:30:27 INFO - 'LOGNAME': 'cltbld', 04:30:27 INFO - 'MAIL': '/var/mail/cltbld', 04:30:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:30:27 INFO - 'MOZ_NO_REMOTE': '1', 04:30:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:30:27 INFO - 'NO_EM_RESTART': '1', 04:30:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:30:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:30:27 INFO - 'PWD': '/builds/slave/test', 04:30:27 INFO - 'SHELL': '/bin/bash', 04:30:27 INFO - 'SHLVL': '1', 04:30:27 INFO - 'TERM': 'linux', 04:30:27 INFO - 'TMOUT': '86400', 04:30:27 INFO - 'USER': 'cltbld', 04:30:27 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1476271799.191629-1009675222', 04:30:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:30:27 INFO - '_': '/tools/buildbot/bin/python'} 04:30:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:30:27 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:30:27 INFO - Cleaning up... 04:30:27 INFO - Return code: 0 04:30:27 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:30:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:30:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:30:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:30:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:30:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30:27 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 0x7f472e256f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1552ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x154ff60>, '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 0x1550d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15511d0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1476271799.191629-1009675222', '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 04:30:27 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 04:30:27 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 04:30:27 INFO - Using env: {'DISPLAY': ':0', 04:30:27 INFO - 'HOME': '/home/cltbld', 04:30:27 INFO - 'LANG': 'en_US.UTF-8', 04:30:27 INFO - 'LANGUAGE': 'en_US:en', 04:30:27 INFO - 'LOGNAME': 'cltbld', 04:30:27 INFO - 'MAIL': '/var/mail/cltbld', 04:30:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:30:27 INFO - 'MOZ_NO_REMOTE': '1', 04:30:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:30:27 INFO - 'NO_EM_RESTART': '1', 04:30:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:30:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:30:27 INFO - 'PWD': '/builds/slave/test', 04:30:27 INFO - 'SHELL': '/bin/bash', 04:30:27 INFO - 'SHLVL': '1', 04:30:27 INFO - 'TERM': 'linux', 04:30:27 INFO - 'TMOUT': '86400', 04:30:27 INFO - 'USER': 'cltbld', 04:30:27 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1476271799.191629-1009675222', 04:30:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:30:27 INFO - '_': '/tools/buildbot/bin/python'} 04:30:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:30:27 INFO - Downloading/unpacking blobuploader==1.2.4 04:30:27 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 04:30:27 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 04:30:27 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 04:30:27 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 04:30:27 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 04:30:27 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 04:30:29 INFO - Downloading blobuploader-1.2.4.tar.gz 04:30:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:30:29 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:30:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:30:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:30:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:30:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:30:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:30:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:30:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:30:30 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:30:30 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 04:30:30 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 04:30:30 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 04:30:30 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 04:30:30 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 04:30:30 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 04:30:30 INFO - Downloading docopt-0.6.1.tar.gz 04:30:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:30:30 INFO - Installing collected packages: blobuploader, requests, docopt 04:30:30 INFO - Running setup.py install for blobuploader 04:30:30 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:30:30 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:30:30 INFO - Running setup.py install for requests 04:30:30 INFO - Running setup.py install for docopt 04:30:30 INFO - Successfully installed blobuploader requests docopt 04:30:30 INFO - Cleaning up... 04:30:31 INFO - Return code: 0 04:30:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:30:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:30:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:30:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:30:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:30:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30:31 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 0x7f472e256f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1552ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x154ff60>, '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 0x1550d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15511d0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1476271799.191629-1009675222', '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 04:30:31 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 04:30:31 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 04:30:31 INFO - Using env: {'DISPLAY': ':0', 04:30:31 INFO - 'HOME': '/home/cltbld', 04:30:31 INFO - 'LANG': 'en_US.UTF-8', 04:30:31 INFO - 'LANGUAGE': 'en_US:en', 04:30:31 INFO - 'LOGNAME': 'cltbld', 04:30:31 INFO - 'MAIL': '/var/mail/cltbld', 04:30:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:30:31 INFO - 'MOZ_NO_REMOTE': '1', 04:30:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:30:31 INFO - 'NO_EM_RESTART': '1', 04:30:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:30:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:30:31 INFO - 'PWD': '/builds/slave/test', 04:30:31 INFO - 'SHELL': '/bin/bash', 04:30:31 INFO - 'SHLVL': '1', 04:30:31 INFO - 'TERM': 'linux', 04:30:31 INFO - 'TMOUT': '86400', 04:30:31 INFO - 'USER': 'cltbld', 04:30:31 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1476271799.191629-1009675222', 04:30:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:30:31 INFO - '_': '/tools/buildbot/bin/python'} 04:30:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:30:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:30:31 INFO - Running setup.py (path:/tmp/pip-I_vDEg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:30:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:30:31 INFO - Running setup.py (path:/tmp/pip-3nU85P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:30:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:30:31 INFO - Running setup.py (path:/tmp/pip-jAOZZJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:30:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:30:31 INFO - Running setup.py (path:/tmp/pip-KP_qVf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:30:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:30:31 INFO - Running setup.py (path:/tmp/pip-qjYdJM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:30:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:30:31 INFO - Running setup.py (path:/tmp/pip-yXdrQE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:30:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:30:31 INFO - Running setup.py (path:/tmp/pip-WYCjGI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:30:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:30:31 INFO - Running setup.py (path:/tmp/pip-1jzTcv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:30:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:30:31 INFO - Running setup.py (path:/tmp/pip-S9O8LX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:30:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:30:31 INFO - Running setup.py (path:/tmp/pip-uUtX4P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:30:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:30:31 INFO - Running setup.py (path:/tmp/pip-7ktTaa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:30:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:30:32 INFO - Running setup.py (path:/tmp/pip-njJE8Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:30:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:30:32 INFO - Running setup.py (path:/tmp/pip-a6DWD7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:30:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:30:32 INFO - Running setup.py (path:/tmp/pip-NMSJ7w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:30:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:30:32 INFO - Running setup.py (path:/tmp/pip-1IvzGk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:30:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:30:32 INFO - Running setup.py (path:/tmp/pip-a5k6eQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:30:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:30:32 INFO - Running setup.py (path:/tmp/pip-iLHr_y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:30:32 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:30:32 INFO - Running setup.py install for manifestparser 04:30:32 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:30:32 INFO - Running setup.py install for mozcrash 04:30:32 INFO - Running setup.py install for mozdebug 04:30:32 INFO - Running setup.py install for mozdevice 04:30:32 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:30:32 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:30:32 INFO - Running setup.py install for mozfile 04:30:32 INFO - Running setup.py install for mozhttpd 04:30:33 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:30:33 INFO - Running setup.py install for mozinfo 04:30:33 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:30:33 INFO - Running setup.py install for mozInstall 04:30:33 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:30:33 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:30:33 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:30:33 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:30:33 INFO - Running setup.py install for mozleak 04:30:33 INFO - Running setup.py install for mozlog 04:30:33 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:30:33 INFO - Running setup.py install for moznetwork 04:30:33 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:30:33 INFO - Running setup.py install for mozprocess 04:30:33 INFO - Running setup.py install for mozprofile 04:30:33 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:30:33 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:30:33 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:30:33 INFO - Running setup.py install for mozrunner 04:30:33 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:30:33 INFO - Running setup.py install for mozscreenshot 04:30:34 INFO - Running setup.py install for moztest 04:30:34 INFO - Running setup.py install for mozversion 04:30:34 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:30:34 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:30:34 INFO - Cleaning up... 04:30:34 INFO - Return code: 0 04:30:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:30:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:30:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:30:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:30:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:30:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30:34 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 0x7f472e256f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1552ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x154ff60>, '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 0x1550d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15511d0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1476271799.191629-1009675222', '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 04:30:34 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 04:30:34 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 04:30:34 INFO - Using env: {'DISPLAY': ':0', 04:30:34 INFO - 'HOME': '/home/cltbld', 04:30:34 INFO - 'LANG': 'en_US.UTF-8', 04:30:34 INFO - 'LANGUAGE': 'en_US:en', 04:30:34 INFO - 'LOGNAME': 'cltbld', 04:30:34 INFO - 'MAIL': '/var/mail/cltbld', 04:30:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:30:34 INFO - 'MOZ_NO_REMOTE': '1', 04:30:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:30:34 INFO - 'NO_EM_RESTART': '1', 04:30:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:30:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:30:34 INFO - 'PWD': '/builds/slave/test', 04:30:34 INFO - 'SHELL': '/bin/bash', 04:30:34 INFO - 'SHLVL': '1', 04:30:34 INFO - 'TERM': 'linux', 04:30:34 INFO - 'TMOUT': '86400', 04:30:34 INFO - 'USER': 'cltbld', 04:30:34 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1476271799.191629-1009675222', 04:30:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:30:34 INFO - '_': '/tools/buildbot/bin/python'} 04:30:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:30:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:30:34 INFO - Running setup.py (path:/tmp/pip-hWm0S8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:30:34 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)) 04:30:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:30:34 INFO - Running setup.py (path:/tmp/pip-mRZj5k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:30:34 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)) 04:30:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:30:34 INFO - Running setup.py (path:/tmp/pip-w6Yoat-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:30:34 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)) 04:30:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:30:34 INFO - Running setup.py (path:/tmp/pip-Ods63z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:30:34 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)) 04:30:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:30:34 INFO - Running setup.py (path:/tmp/pip-QvU5cl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:30:34 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)) 04:30:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:30:34 INFO - Running setup.py (path:/tmp/pip-Mo2Me5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:30:34 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)) 04:30:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:30:34 INFO - Running setup.py (path:/tmp/pip-JeV4Ks-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:30:34 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)) 04:30:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:30:34 INFO - Running setup.py (path:/tmp/pip-cc0UFK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:30:35 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)) 04:30:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:30:35 INFO - Running setup.py (path:/tmp/pip-tA_eoV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:30:35 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)) 04:30:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:30:35 INFO - Running setup.py (path:/tmp/pip-9RjRp2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:30:35 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)) 04:30:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:30:35 INFO - Running setup.py (path:/tmp/pip-7X8IPW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:30:35 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)) 04:30:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:30:35 INFO - Running setup.py (path:/tmp/pip-97mqhi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:30:35 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)) 04:30:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:30:35 INFO - Running setup.py (path:/tmp/pip-d1RwLP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:30:35 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)) 04:30:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:30:35 INFO - Running setup.py (path:/tmp/pip-rY2yMq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:30:35 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)) 04:30:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:30:35 INFO - Running setup.py (path:/tmp/pip-pZArwu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:30:35 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)) 04:30:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:30:35 INFO - Running setup.py (path:/tmp/pip-eDB6yK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:30:35 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)) 04:30:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:30:35 INFO - Running setup.py (path:/tmp/pip-1A2jyi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:30:35 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)) 04:30:35 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)) 04:30:35 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)) 04:30:35 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)) 04:30:35 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)) 04:30:35 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)) 04:30:35 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:30:35 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 04:30:35 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 04:30:35 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 04:30:35 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 04:30:35 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 04:30:35 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 04:30:37 INFO - Downloading blessings-1.6.tar.gz 04:30:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:30:37 INFO - Installing collected packages: blessings 04:30:37 INFO - Running setup.py install for blessings 04:30:37 INFO - Successfully installed blessings 04:30:37 INFO - Cleaning up... 04:30:37 INFO - Return code: 0 04:30:37 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:30:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:30:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:30:38 INFO - Reading from file tmpfile_stdout 04:30:38 INFO - Current package versions: 04:30:38 INFO - argparse == 1.2.1 04:30:38 INFO - blessings == 1.6 04:30:38 INFO - blobuploader == 1.2.4 04:30:38 INFO - docopt == 0.6.1 04:30:38 INFO - functools32 == 3.2.3-2 04:30:38 INFO - jsonschema == 2.5.1 04:30:38 INFO - manifestparser == 1.1 04:30:38 INFO - mozInstall == 1.12 04:30:38 INFO - mozcrash == 0.17 04:30:38 INFO - mozdebug == 0.1 04:30:38 INFO - mozdevice == 0.48 04:30:38 INFO - mozfile == 1.2 04:30:38 INFO - mozhttpd == 0.7 04:30:38 INFO - mozinfo == 0.9 04:30:38 INFO - mozleak == 0.1 04:30:38 INFO - mozlog == 3.4 04:30:38 INFO - moznetwork == 0.27 04:30:38 INFO - mozprocess == 0.23 04:30:38 INFO - mozprofile == 0.28 04:30:38 INFO - mozrunner == 6.12 04:30:38 INFO - mozscreenshot == 0.1 04:30:38 INFO - mozsystemmonitor == 0.3 04:30:38 INFO - moztest == 0.7 04:30:38 INFO - mozversion == 1.4 04:30:38 INFO - psutil == 3.1.1 04:30:38 INFO - requests == 1.2.3 04:30:38 INFO - wsgiref == 0.1.2 04:30:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:30:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:30:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:30:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:30:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:30:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30:38 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 0x7f472e256f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1552ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x154ff60>, '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 0x1550d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15511d0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1476271799.191629-1009675222', '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 04:30:38 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 04:30:38 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 04:30:38 INFO - Using env: {'DISPLAY': ':0', 04:30:38 INFO - 'HOME': '/home/cltbld', 04:30:38 INFO - 'LANG': 'en_US.UTF-8', 04:30:38 INFO - 'LANGUAGE': 'en_US:en', 04:30:38 INFO - 'LOGNAME': 'cltbld', 04:30:38 INFO - 'MAIL': '/var/mail/cltbld', 04:30:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:30:38 INFO - 'MOZ_NO_REMOTE': '1', 04:30:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:30:38 INFO - 'NO_EM_RESTART': '1', 04:30:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:30:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:30:38 INFO - 'PWD': '/builds/slave/test', 04:30:38 INFO - 'SHELL': '/bin/bash', 04:30:38 INFO - 'SHLVL': '1', 04:30:38 INFO - 'TERM': 'linux', 04:30:38 INFO - 'TMOUT': '86400', 04:30:38 INFO - 'USER': 'cltbld', 04:30:38 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1476271799.191629-1009675222', 04:30:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:30:38 INFO - '_': '/tools/buildbot/bin/python'} 04:30:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:30:38 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)) 04:30:38 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)) 04:30:38 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)) 04:30:38 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)) 04:30:38 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)) 04:30:38 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)) 04:30:38 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)) 04:30:38 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)) 04:30:38 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)) 04:30:38 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)) 04:30:38 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)) 04:30:38 INFO - Cleaning up... 04:30:38 INFO - Return code: 0 04:30:38 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:30:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:30:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:30:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:30:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:30:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30:38 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 0x7f472e256f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1552ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x154ff60>, '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 0x1550d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15511d0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1476271799.191629-1009675222', '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 04:30:38 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 04:30:38 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 04:30:38 INFO - Using env: {'DISPLAY': ':0', 04:30:38 INFO - 'HOME': '/home/cltbld', 04:30:38 INFO - 'LANG': 'en_US.UTF-8', 04:30:38 INFO - 'LANGUAGE': 'en_US:en', 04:30:38 INFO - 'LOGNAME': 'cltbld', 04:30:38 INFO - 'MAIL': '/var/mail/cltbld', 04:30:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:30:38 INFO - 'MOZ_NO_REMOTE': '1', 04:30:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:30:38 INFO - 'NO_EM_RESTART': '1', 04:30:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:30:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:30:38 INFO - 'PWD': '/builds/slave/test', 04:30:38 INFO - 'SHELL': '/bin/bash', 04:30:38 INFO - 'SHLVL': '1', 04:30:38 INFO - 'TERM': 'linux', 04:30:38 INFO - 'TMOUT': '86400', 04:30:38 INFO - 'USER': 'cltbld', 04:30:38 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1476271799.191629-1009675222', 04:30:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:30:38 INFO - '_': '/tools/buildbot/bin/python'} 04:30:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:30:38 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:30:38 INFO - Cleaning up... 04:30:38 INFO - Return code: 0 04:30:38 INFO - Running post-action listener: _resource_record_post_action 04:30:38 INFO - Running post-action listener: _start_resource_monitoring 04:30:38 INFO - Starting resource monitoring. 04:30:38 INFO - [mozharness: 2016-10-12 11:30:38.630927Z] Finished create-virtualenv step (success) 04:30:38 INFO - [mozharness: 2016-10-12 11:30:38.631382Z] Running install step. 04:30:38 INFO - Running pre-action listener: _resource_record_pre_action 04:30:38 INFO - Running main action method: install 04:30:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:30:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:30:38 INFO - Reading from file tmpfile_stdout 04:30:38 INFO - Detecting whether we're running mozinstall >=1.0... 04:30:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:30:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:30:38 INFO - Reading from file tmpfile_stdout 04:30:38 INFO - Output received: 04:30:38 INFO - Usage: mozinstall [options] installer 04:30:38 INFO - Options: 04:30:38 INFO - -h, --help show this help message and exit 04:30:38 INFO - -d DEST, --destination=DEST 04:30:38 INFO - Directory to install application into. [default: 04:30:38 INFO - "/builds/slave/test"] 04:30:38 INFO - --app=APP Application being installed. [default: firefox] 04:30:38 INFO - mkdir: /builds/slave/test/build/application 04:30:38 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'] 04:30:38 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 04:30:55 INFO - Reading from file tmpfile_stdout 04:30:55 INFO - Output received: 04:30:55 INFO - /builds/slave/test/build/application/firefox/firefox 04:30:55 INFO - Running post-action listener: _resource_record_post_action 04:30:55 INFO - [mozharness: 2016-10-12 11:30:55.083391Z] Finished install step (success) 04:30:55 INFO - [mozharness: 2016-10-12 11:30:55.083634Z] Running run-tests step. 04:30:55 INFO - Running pre-action listener: _resource_record_pre_action 04:30:55 INFO - Running main action method: run_tests 04:30:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:30:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:30:55 INFO - Python 2.7.3 04:30:55 INFO - Return code: 0 04:30:55 INFO - grabbing minidump binary from tooltool 04:30:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:30:55 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 0x154ff60>, '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 0x1550d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15511d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:30:55 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 04:30:55 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 04:30:55 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 04:30:55 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:30:55 INFO - Return code: 0 04:30:55 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:30:55 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:30:55 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:30:55 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:30:55 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:30:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/KH-T8TvTT12rvCGfGBb32g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-019', '--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 04:30:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/KH-T8TvTT12rvCGfGBb32g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-019 --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 04:30:55 INFO - Using env: {'DISPLAY': ':0', 04:30:55 INFO - 'HOME': '/home/cltbld', 04:30:55 INFO - 'LANG': 'en_US.UTF-8', 04:30:55 INFO - 'LANGUAGE': 'en_US:en', 04:30:55 INFO - 'LOGNAME': 'cltbld', 04:30:55 INFO - 'MAIL': '/var/mail/cltbld', 04:30:55 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:30:55 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:30:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:30:55 INFO - 'MOZ_NO_REMOTE': '1', 04:30:55 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:30:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:30:55 INFO - 'NO_EM_RESTART': '1', 04:30:55 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:30:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:30:55 INFO - 'PWD': '/builds/slave/test', 04:30:55 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:30:55 INFO - 'SHELL': '/bin/bash', 04:30:55 INFO - 'SHLVL': '1', 04:30:55 INFO - 'TERM': 'linux', 04:30:55 INFO - 'TMOUT': '86400', 04:30:55 INFO - 'USER': 'cltbld', 04:30:55 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1476271799.191629-1009675222', 04:30:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:30:55 INFO - '_': '/tools/buildbot/bin/python'} 04:30:55 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/KH-T8TvTT12rvCGfGBb32g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-019', '--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 04:30:55 INFO - mozversion application_buildid: 20161012030047 04:30:55 INFO - mozversion application_changeset: feb1c52ebe9ef8cff09dea275aa06d9441f5fe93 04:30:55 INFO - mozversion application_display_name: Nightly 04:30:55 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:30:55 INFO - mozversion application_name: Firefox 04:30:55 INFO - mozversion application_remotingname: firefox 04:30:55 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:30:55 INFO - mozversion application_vendor: Mozilla 04:30:55 INFO - mozversion application_version: 52.0a1 04:30:55 INFO - mozversion platform_buildid: 20161012030047 04:30:55 INFO - mozversion platform_changeset: feb1c52ebe9ef8cff09dea275aa06d9441f5fe93 04:30:55 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:30:55 INFO - mozversion platform_version: 52.0a1 04:30:55 INFO - using testdate: 1476271855 04:30:55 INFO - actual date: 1476271855 04:30:55 INFO - starting webserver on 'localhost:39086' 04:30:55 INFO - SUITE-START | Running 2 tests 04:30:55 INFO - TEST-START | dromaeo_css 04:30:55 INFO - operating with platform_type : linux_ 04:30:55 INFO - Initialising browser for dromaeo_css test... 04:30:55 INFO - TEST-INFO | started process 12150 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpt7Eep4/profile http://localhost:39086/getInfo.html) 04:31:00 INFO - PROCESS | 12150 | __metrics Screen width/height:1600/1200 04:31:00 INFO - PROCESS | 12150 | colorDepth:24 04:31:00 INFO - PROCESS | 12150 | Browser inner width/height: 1024/697 04:31:00 INFO - PROCESS | 12150 | __metrics 04:31:00 INFO - PROCESS | 12150 | 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" 04:31:00 INFO - PROCESS | 12150 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:31:01 INFO - PROCESS | 12150 | console.error: PushService: 04:31:01 INFO - PROCESS | 12150 | stateChangeProcessEnqueue: Error transitioning state 04:31:01 INFO - PROCESS | 12150 | UnknownError 04:31:02 INFO - TEST-INFO | 12150: exit 0 04:31:02 INFO - Browser initialized. 04:31:02 INFO - Running cycle 1/1 for dromaeo_css test... 04:31:02 INFO - TEST-INFO | started process 12234 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpt7Eep4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:31:14 INFO - PROCESS | 12234 | RSS: Main: 174727168 04:31:14 INFO - PROCESS | 12234 | 04:32:05 INFO - PROCESS | 12234 | 1476271925967 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] 04:34:19 INFO - PROCESS | 12234 | Cycle 1(1): loaded http://localhost:39086/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39086/tests/dromaeo/cssquery-ext.html) 04:34:20 INFO - PROCESS | 12234 | RSS: Main: 307728384 04:34:20 INFO - PROCESS | 12234 | 04:37:23 INFO - PROCESS | 12234 | Cycle 1(1): loaded http://localhost:39086/tests/dromaeo/cssquery-ext.html (next: http://localhost:39086/tests/dromaeo/cssquery-jquery.html) 04:37:24 INFO - PROCESS | 12234 | RSS: Main: 274948096 04:37:24 INFO - PROCESS | 12234 | 04:40:26 INFO - PROCESS | 12234 | Cycle 1(1): loaded http://localhost:39086/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39086/tests/dromaeo/cssquery-mootools.html) 04:40:27 INFO - PROCESS | 12234 | RSS: Main: 222261248 04:40:27 INFO - PROCESS | 12234 | 04:43:29 INFO - PROCESS | 12234 | Cycle 1(1): loaded http://localhost:39086/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39086/tests/dromaeo/cssquery-prototype.html) 04:43:29 INFO - PROCESS | 12234 | RSS: Main: 253386752 04:43:29 INFO - PROCESS | 12234 | 04:46:33 INFO - PROCESS | 12234 | Cycle 1(1): loaded http://localhost:39086/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39086/tests/dromaeo/cssquery-yui.html) 04:46:33 INFO - PROCESS | 12234 | RSS: Main: 220712960 04:46:33 INFO - PROCESS | 12234 | 04:49:36 INFO - PROCESS | 12234 | Cycle 1(1): loaded http://localhost:39086/tests/dromaeo/cssquery-yui.html (next: http://localhost:39086/tests/dromaeo/cssquery-dojo.html) 04:49:36 INFO - PROCESS | 12234 | RSS: Main: 313155584 04:49:36 INFO - PROCESS | 12234 | 04:49:36 INFO - PROCESS | 12234 | __start_tp_report 04:49:36 INFO - PROCESS | 12234 | _x_x_mozilla_page_load 04:49:36 INFO - PROCESS | 12234 | _x_x_mozilla_page_load_details 04:49:36 INFO - PROCESS | 12234 | |i|pagename|runs| 04:49:36 INFO - PROCESS | 12234 | |0;dojo.html;2511.171313466556;2560.5263026340135;2560.9487810243786;2602.622619720141;2609.725978772228;4311.762853043081;4363.323684828857;4491.303847903576;4503.437070366204;4517.412736344275;4359.128174365123;4379.2336341140335;4386.8903277418085;4419.403380543626;4426.97786511067;4028.053407449247;4048.736832105904;4057.6348128668415;4083.958590559403;4140.399642051901;4163.875083747493;4172.33242681171;4185.979070104645;4188.497380314351;4189.392538081976;4129.855455059073;4160.375943608453;4180.937285940713;4181.3309870420735;4219.451471308741;4224.619784219404;4232.174725928445;4234.470691163605;4246.469191351066;4271.508776490681;4044.3529035354495;4060.4112403701297;4124.443200167969;4160.063985603245;4219.303814870543;4367.061081867382;4374.1689079075195;4378.321360189176;4385.079133381993;4411.470623525198;4636.397268355092;4666.2767271073035;4672.462666793328;4722.315264286659;4734.171519983989;4659.231226847566;4695.929561056587;4699.342092107107;4703.129920964632;4718.41019872516;4458.398116254329;4459.843905463325;4468.798904049326;4469.709468884512;4476.6418686505;4866.197077482247;4874.561289483892;4876.609871210295;4881.658283920092;4882.365292512021;4604.493505714368;4651.302304654261;4654.162250794821;4676.415448068991;4717.834875779331;4728.787204575802;4731.952680473151;4732.550407711262;4779.856604301876;4795.640326975421;4638.605718513897;4687.367205427292;4692.671512994058;4718.693284936468;4739;4566.06395688883;4609.216433206363;4613.492515823256;4655.837045703384;4664.300354946785;4014.2573623879675;4055.209234199303;4100.220958017967;4108.157827645326;4109.157622687342;3557.0573797943566;3561.4123669594746;3567.35787558242;3600.3159399713973;3604.1530240394013;4139.710220284612;4218.156368726267;4245.787710614519;4254.234237837157;4277.893052673646;4709.976450117728;4757.333973243749;4759.762011899391;4762.071396077801;4765.356676848581;4186.874393768131;4187.6440502557625;4214.3678448232395;4215.367694845798;4222.78886055696;4340.696151269381;4396.560343965578;4400.647948164139;4412.4043254160915;4413.13943780966;4612.3542704021465;4616.422947131608;4622.6764126510825;4623.144718227139;4679.836205732715;4641.466231383299;4827.444843843003;4847.151748443937;4850.53919877611;4898.387701537308;4475.149721552894;4527.90944181108;4532.3654688342995;4572.908541829212;4583.358329833759;4720.291956206596;4723.244280915037;4767.809287628456;4778.283257511401;4782.593479554277;4692.272697731721;4792.784324705327;4795.304680821331;4795.808167673254;4847.321375007572;4581.083783243432;4644.210484217759;4651.395318608695;4657.93013104797;4704.905901882012;4692.014676917749;4723.480417154179;4745.359376484131;4745.83389581363;4808.9519104808505;4663.067386522641;4673.485916549245;4678.321643361762;4682.789274482725;4733.952660473351;4582.518835522222;4743.66794324394;4767.237242041257;4771.403574553181;4834.516548345137;4523.502414734442;4584.991301913574;4588.128255631419;4588.88527786808;4591.3572099906705 04:49:36 INFO - PROCESS | 12234 | |1;ext.html;517.4954419441044;532.882765791526;538.1201735163008;561.4189314059946;570.076476108704;27069.72930270699;36982.8150859246;38585.614143858555;38640.61359386405;43250.7837460813;32506.77411936451;32824.17939551512;32901.67098329016;32912.341753164925;32926.17684557887;7633.1985141560035;7785.805354866117;7787.454878158531;7789.026371703537;7792.259735325163;7658.885116723253;7727.188645192258;7739.993800805887;7742.574158421285;7750.224977502233;7744.535327880317;7786.649600767951;7786.922130778705;7794.727184548542;7795.883061754078;7457.627118644074;7461.850762984737;7492.100947886289;7496.362809161228;7500.212477689818;7567.6756567601;7643.541387516767;7643.579603121826;7648.617569121521;7653.732119375851;36863;36932.26135477302;37173.442398364044;37173.814130929175;37264.627353726384;2621.279148234232;2624.593188055854;2769.9723002770115;2794.720527947209;3142.591463109781;24700.382490437703;26650.73349266502;26745.598816017777;27260.45479090427;27426.451470970667;3436.7937923724658;3488.2849015951924;3519.489673997256;3529.100079479742;3567.9821600892087;253662;254096;254840;254850.72574637193;255356;50586.241206381936;50666;50720.492795072314;51019;51039.7448012765;31610.841945790584;32782.672173278435;32973.50539741906;34981;35012.12469688278;13985.230812305217;14232.074915130483;14232.85767142336;14234.786478202835;14238.074525155831;10593.84109238362;10789.784204315869;10803.13574914005;10803.83794243087;10816.621418250481;17347.739783903253;17354.39259625907;17409.82590174082;17531.82468175302;17581.82418175802;6605.768798092044;6650.3349665034075;6732.966335168391;6795.558288711317;6802.319768023257;756.4629113329597;880.2078129683337;935.2564711054728;958.7746879483316;977.6089564174387;26547.86726066396;27233.45533089327;27684.40872835528;27832.304192395353;28008.159755207376;775.6393277126164;787.9330256928225;793.6031984007996;798.2895223251311;870.1081391573688;14026;14506.782398264035;14546.41814327415;14660.56018319452;14768;367619;368886;369449;370752;370795;47343.28985065227;47843;47917.76041119772;47942.52057479381;47981.280280795814;947.9146876781123;995.4176806568094;1006.0342071611335;1014.9545967653181;1064.7817197474499;25902.481950361263;27239.86380068087;27754.583681244392;28379;28715.569266461436;38730.6126938727;39063.2187356257;39172.2165556693;39184.608153918096;39235.2152956945;292166;294609;295872;296117;367353;21102.894485527475;23174.652380213975;24298.878505607358;24317.27048188557;25674.229773106836;39442.21115577615;39446.60553394429;39735.602643974344;39997.80001100092;41222;34391.31217375689;34610.65389346175;34690.82654586711;34732.131696706776;34766.13084672904;29395;29427.705722942497;29599;30268.09195724132;30556.472176391537;34058.489122663676;34307.4853877197;34622;34855.12862178466;34861.12847178841;29897.850510747307;33661.15847103842;35309;35464.290714186085;35515.46726799048;24753.752462475146;24913.50172996566;25210.621840672036;25219.495610088063;25377.49245015126 04:49:36 INFO - PROCESS | 12234 | |2;jquery.html;318.5492528072777;345.6871531264206;346.4387691939059;347.4527619000075;368.4602057985051;12109.15235933484;13112.082154249207;15159.39362425503;15687.372505099782;16850.410235641753;14707;14846.109233446;15683.529494115166;16206.837931620681;16481;4629.583337499625;4854.538818812216;5058.49415058493;5068.594512438996;5076.111680455924;4712.976435117836;5010.924836127461;5020.899582008357;5028.522290382408;5035.370578677665;5003.599712023048;5006.249062640615;5010.949890501085;5011.646855349054;5012.9749351253195;4795.736234507101;4948.529889660476;4955.653104282702;4973.925391119136;4977.054359671687;4427.468703755538;4429.601335879786;4437.378766972626;4440.578145076212;4441.222786012435;18361;18735;19356;19631;19647.607047858965;1709.3419033672;1770.5927636643514;1782.0466050662833;1787.865910056738;1986.612610540945;8492.74521764348;8510.191531804468;8629.439086459422;8783.12168783123;8918.464892106495;1635.8445947634955;1661.5264649574933;1687.9156042197842;1691.5094622559443;1790.2965333438983;62485.6875715623;62767.686161569356;63392.68303658498;64109.3589064108;64905.67547162281;8927.776805579913;9652.565634546463;9793.804123917482;9877.259205559612;10045.69862904114;13475.865241347658;13569.52506662262;13576.728465430637;13580.3703555572;13580.796288055688;6877.690503927335;6987.336203060701;6997.7200911962955;7146.857062858714;7186.951718760233;6542.901856472156;6554.246261679968;6648.33516648341;6671.032700258435;6773.390394864486;4142.316517774533;4205.158968206371;4214.325707886724;4283.357496375506;4309.159713855831;1744.6772347115825;1806.1601355369817;1811.293595497757;1830.7620009398693;1853.7126745354492;809.1018968944467;819.3035919468523;822.2763967708498;844.3076677124822;902.2988790671586;16421.91789041047;16777.328906843588;16813.57966050834;17145.399911003304;17314.220860061327;717.6770453295933;750.0249675422039;830.9875351869727;847.3856454070749;871.7820544863785;8861.778455538533;8876.733697989072;9229.123233292827;9395.671151509665;9619.038096190325;305323;390862;393083;393250;393468;68191;78273;79483;80189;80773;372.179344545277;395.54117224020575;395.5826602933875;395.87529928072564;397.73550588858086;8792.384533082879;9197.264218862609;9216.539173041187;9480.715578532656;9591.520423978913;32785.672143278265;34949.82525087358;35811.462828058124;35870.10324741902;36680;44608;48684.21052631562;48956.041758329266;49102;52277.215841763165;6518.706658200297;6612.7435787200275;6723.966380168068;6757.391834734897;6844.076049733222;8507.787305317417;9862.950685246527;9893.258005649748;10063.094321511098;10270.589176432859;8806.691765788166;8987.865182022406;9118.772030699285;9272.211861991806;9324.393914395543;8291.927018245438;8603.52680602573;8702.260307873901;8982.730518084469;9085.682001129928;9105.362624616213;9222.584983675617;9256.676016339396;9323.01663467711;9369.765755856159;6472.902906456313;6663.233728121328;6670.699818508276;6783.084283621648;6810.693518791765;8819.779505512157;8918.687845925362;8946.910530894607;9158.816823663623;9329.533523323942 04:49:36 INFO - PROCESS | 12234 | |3;mootools.html;1089.003561741007;1306.059637061316;1352.7429788340216;1355.3020194599783;1655.2551351891643;6377.649229292387;7172.497925145235;7470.813229669247;7479.551226926388;7687.654055567499;7221.27787221279;7304.160021597518;7312.488125831194;7313.232110628374;7317;2032.1668116072412;2052.8152466278034;2053.640612892745;2054.589082183562;2059.1042896340064;1983.1076015792878;1984.533634595876;1985.5333996510808;2021.353166986565;2028.1785876719953;1988.0755448716343;1995.9201631934777;2002.3192114681005;2005.8295044921126;2013.1142297389101;1987.6521608718417;1993.1728332741895;1994.2322205950813;1994.2421879685626;1998.5902889907534;1961.3135402609116;1987.701844723303;2016.8588198826087;2018.8687735297306;2021.848361372903;6974.407175390098;7164.498485106044;7270.636468176623;7270.927290727131;7276.599787011713;4103.835846566134;4286.014216730169;4289.506706728735;4291.506476755182;4292.935605965913;2683.2352779457956;2805.5370863807448;2821.915342539727;2838.0918106206022;2839.5030869597945;848.5417874347845;861.4831101339147;866.1728049712509;1663.0853030832993;1725.1546742096407;9730.610775568968;9838.163756080741;9886.90113098867;9905.771201479682;9918.752031199205;3665.138692407282;3665.578458477256;3737.1404576947452;3807.0672685191753;3828.8659896903473;7859.292663660298;7876.606169691492;7880.921190788019;7884.408669349822;7893.763187104396;4192.3082691355585;4193.39195816611;4194.916101678011;4197.034682023152;4202.600752928467;3309.7352211822995;3405.2338223899424;3734.9066273343383;3864.6521813036397;3868.8259028343227;3112.42420152268;3151.5430262612254;3246.610406751158;3248.5776849009476;3260.168656992452;983.8671779309844;989.312427862643;993.4188499727596;1003.3377970539409;1005.6580762540772;658.6377492379172;738.1326940844593;759.544273435934;761.3186198352444;814.686345756876;4736.786844592001;4952.232403977389;4959.752012399365;4969.751512424436;5048.697078175322;752.1913942511821;780.898483197192;820.5117954816874;856.9271611912933;859.673324136824;3095.3190298134373;3097.07087873637;3225.70968612826;3234.1267857678295;3420.4698271767916;8248.587570621565;8660.047394786568;8672.523011234443;8672.913270867337;8680.262177714838;8623.655053797778;8635.395522313504;8638.56807159652;8647.956760216159;8667.783305417415;6858.417034552019;6998.545094568837;7009.334113259232;7015.719371225094;7028.543144695681;4695.154872123051;4730.9763451182525;4792.856214313576;4844.636652251025;4923.138450771029;7916.683332666629;8300.377471689526;8323.001239851015;8366.83266334682;8617.439866408915;7961.601919903866;8125.553094579855;8559;8677.956610217161;8683.2185103341;5467.535259502987;6244.313125556276;6392.93607063942;6404.391582799627;6416.326285740117;6040.154378386941;6758.7296508139125;6899.551529150589;6912.827179320558;6943.930560694531;6203.875922481616;6436.485081193399;6461.838454038687;6487.318831522811;6499.740010399721;6390.201224846895;6441.774537891151;6467.417932386108;6494.9025764612625;6587.703553340016;5661.547076233809;5724.284464441945;5727.825795711786;5745.166950792028;5786.623869448641;4287.3997640331;4297.570242975802;4304.763238021814;4330.7401555906745;4499.347594598699;4273.786310684515;4299.548547402478;4340.9131817364105;4503.459584849839;4625.722456652612 04:49:36 INFO - PROCESS | 12234 | |4;prototype.html;270.2743134683374;271.83383285704326;282.51830628777924;283.35253944736274;284.84048932597733;4484.5201083642405;4632.166210082184;4686.742229177398;4731.503192164825;4757.928631070532;4421.447319085114;4532.410786597746;4570.840020599279;4589.65577581681;4618.8152473901;3637.290728307981;3644.489771432002;3650.1057240975865;3655.1227705350657;3661.816909154545;3442.8294379910826;3563.3585954528176;3631.5279013728177;3632.6185750496215;3640.7815531068222;3467.9479807802904;3567.5897271813815;3576.946345804815;3587.802670853102;3612.7832330060282;3585.551806024247;3588.8923332300205;3591.5331006969186;3592.946105808415;3618.4210526315796;3144.795588286754;3162.3359094590164;3162.4940009598354;3174.761892858045;3179.60254968129;4317.935230971507;4428.424304840382;4479.574440428154;4513.638908887314;4521.485302423692;4008.2985477541606;4024.9132734161612;4037.8788636340955;4050.18996200761;4058.553559108496;4744.288356746481;4746.359241502388;4761.6904901181315;4765.404324459442;4775.498572649856;3412.1128506588216;3414.23179784549;3418.897433076987;3422.863085476578;3424.520567120605;4820.25286080658;4973.925391119136;4982.327385802906;4992.90014199714;5055.974720126413;3483.3729928613093;3486.145894255873;3487.6746836202083;3490.5462289902657;3497.178163131662;3542.1662669864004;3548.254866478017;3551.9289614208087;3557.1818481748824;3565.286942611436;3967.3453880110037;3982.522097348337;4089.161721847014;4090.8977275567754;4091.774952377648;4783.7129772213775;4817.482493014689;4818.759062046884;4835.709857408567;4855.441624213261;1137.670075678044;1164.9708757281135;1200.9191727445195;1218.4760552962134;1233.9814902776466;844.8099177685094;846.2087947768856;865.000923932846;872.267295471794;872.5680788009976;4376.890577735582;4382;4396.4284642996845;4398.714083584557;4402.471703395613;4958.305837182797;4965.32968049316;4992.2511623256805;4997.725125118153;5004.549590536869;4376.540463251313;4378.605925466723;4382.561743825656;4389;4401.6478681705385;2262.739784924722;2283.5318759654233;2310.3646497213063;2329.998100816665;2340.694416000272;4211.831526738896;4214.789260536961;4215.156968606291;4222.9577704223175;4236.428082208924;4491;4492.742032230981;4510.571495707903;4548.999220171557;4597.793099310472;4019.658329042064;4168.333066709312;4203.62167404935;4232.746035237896;4232.978835105805;4364.214441400578;4364.716293440916;4374.978125109354;4384.027187765454;4397.340398940057;4322.308430651081;4331.675124365622;4332.1985432695055;4378.372976214246;4386.903274181454;4016.0445397995586;4126.628603425706;4135.2763266427655;4163.791810409407;4187.602177793105;3197.58431403916;3204.1736210359873;3216.182856685965;3220.663424678732;3227.4351988402404;4384.517703052597;4396.659018999236;4404.678596420997;4438.535283356549;4473.686841921034;4679.438467383936;4731.172044892199;4796.856094317176;4802.4632117723395;4860.270959356125;4837.2260438329695;4869.537393947569;4887.120318342732;4887.144749668865;4893.290472881484;4817.397825271841;4846.539578740014;4859.392575928009;4862.246351815475;4883.194272944925;4697.788599513098;4920.45874953762;4941.876453088702;4951.554360107608;4955;4832;4846.612271018381;4847.636427267898;4849.442314133919;4873.171560834596 04:49:36 INFO - PROCESS | 12234 | |5;yui.html;527.2355085126567;570.1618620627677;581.6510093943634;586.4868240289746;603.3483837455549;12362.196457230286;13233.338333083355;13295.135816171942;13354.66613334667;13356.532521361754;12924.93537532311;13507.324633768321;13587.456501739918;13600.659983500418;13662.590122296322;616.1404840247851;770.7880332908439;788.2354116507008;790.6876783670447;790.7113903425266;638.1671918146817;756.825930036092;776.8601651702692;783.0094929913664;783.8941742864725;815.8939337886067;816.102287483769;819.0580832043139;819.1112642782558;819.3772732723144;649.4414803269185;810.7324582887633;811.5495899775622;811.6712731343786;811.8335741173075;492.6034542193533;582.3564960718387;595.5206059122405;596.31126049413;598.0520874414059;11774.587889423829;11777.882221177764;11816.822747658705;11830.645080647595;11832.053435725207;11465.426728663617;11626.883731162665;11775.7056073598;12015.639530814002;12499.187552809039;10955.945220273848;10982.890171098266;11093.55625774968;11140.108791296676;11258.605948791836;3949.1706741584303;3953.5651078381356;3956.5845586213322;4032.8185231664647;4041.8383264669674;57787.71106144485;59435.70282148605;60215;60709.39290607082;61127.69436152835;9435.905640943503;9456.14894659484;9490.430574165433;9645.565949532287;9917.206623470105;18433.446996590123;18450.446486605422;18451.630967380577;18458.077096145138;18524.44426667202;6679;6679.165104361955;6696.263411024784;6809.114815074008;6883.311668833177;3394.35507253621;3423.281110966725;3447.3277710846146;3459.7924124552605;3508.2808024354945;2830.589564513134;2941.911742647724;2952.5571164325524;2955.12823717004;2955.940881182364;479.453423097662;494.71801073387826;500.3470471035261;500.86977385879936;522.5271129627693;483.66143699410554;541.38823129863;541.553218594661;546.6091744402771;546.9316335458068;7732.497387669783;7905.802354941173;8086.5148091114725;8147.981502312211;8332;469.7815515785108;523.1107117899586;557.3757391721298;558.5447859994092;559.3986464550625;3637.781733096023;3660.3228402745576;3741.43878418234;3978;3984.2629113614075;55306;83978.5801071003;92077.61883571751;95860.52069739606;96792.51603741937;49430.75284623554;49528;49804.75097624489;49884.25173622399;50318.496815032115;67714;72306.99999999895;72542;72668.27331726615;73751;7172.139343278631;7311.780646580611;7374.557526548424;7456.925430745623;7560.281773231534;43558.56441435545;44691.32963005493;45873;46325.305120423895;46339.76830115828;58876.41123588881;58941;61857.69071154615;62584.687076564325;62646;8905.599248033983;9189.540522973959;9238.353315268136;9453.196478299147;9801.50992450389;10008.949955250177;10591.682249532527;10679.786404271716;10904.890951090387;11282.717932051764;9779.217662587118;9799.167070798776;9832.557534910804;9934.056264654846;9962.50187490608;9989.100980911753;10095.44475053879;10109.14072303833;10237;10790.514426850968;9679.516024198621;9697.22422206236;9747.707568772948;9806.901930980885;10355.534000969823;8073.031236251687;8177.304929081095;8384.83230335402;8561.529115898686;8569.10024447424;7854.1360450349275;8177.67289308421;8185.304249138651;8241;8316.293115085286 04:49:36 INFO - PROCESS | 12234 | __end_tp_report 04:49:36 INFO - PROCESS | 12234 | __start_cc_report 04:49:36 INFO - PROCESS | 12234 | _x_x_mozilla_cycle_collect,1340 04:49:36 INFO - PROCESS | 12234 | __end_cc_report 04:49:36 INFO - PROCESS | 12234 | __startTimestamp1476272976889__endTimestamp 04:49:36 INFO - PROCESS | 12234 | 04:49:36 INFO - PROCESS | 12234 | ------- Summary: start ------- 04:49:36 INFO - PROCESS | 12234 | Number of tests: 6 04:49:36 INFO - PROCESS | 12234 | 04:49:36 INFO - PROCESS | 12234 | [#0] dojo.html Cycles:165 Average:4429.56 Median:4582.52 stddev:438.68 (9.6%) stddev-sans-first:413.41 04:49:36 INFO - PROCESS | 12234 | Values: 2511.2 2560.5 2560.9 2602.6 2609.7 4311.8 4363.3 4491.3 4503.4 4517.4 4359.1 4379.2 4386.9 4419.4 4427.0 4028.1 4048.7 4057.6 4084.0 4140.4 4163.9 4172.3 4186.0 4188.5 4189.4 4129.9 4160.4 4180.9 4181.3 4219.5 4224.6 4232.2 4234.5 4246.5 4271.5 4044.4 4060.4 4124.4 4160.1 4219.3 4367.1 4374.2 4378.3 4385.1 4411.5 4636.4 4666.3 4672.5 4722.3 4734.2 4659.2 4695.9 4699.3 4703.1 4718.4 4458.4 4459.8 4468.8 4469.7 4476.6 4866.2 4874.6 4876.6 4881.7 4882.4 4604.5 4651.3 4654.2 4676.4 4717.8 4728.8 4732.0 4732.6 4779.9 4795.6 4638.6 4687.4 4692.7 4718.7 4739.0 4566.1 4609.2 4613.5 4655.8 4664.3 4014.3 4055.2 4100.2 4108.2 4109.2 3557.1 3561.4 3567.4 3600.3 3604.2 4139.7 4218.2 4245.8 4254.2 4277.9 4710.0 4757.3 4759.8 4762.1 4765.4 4186.9 4187.6 4214.4 4215.4 4222.8 4340.7 4396.6 4400.6 4412.4 4413.1 4612.4 4616.4 4622.7 4623.1 4679.8 4641.5 4827.4 4847.2 4850.5 4898.4 4475.1 4527.9 4532.4 4572.9 4583.4 4720.3 4723.2 4767.8 4778.3 4782.6 4692.3 4792.8 4795.3 4795.8 4847.3 4581.1 4644.2 4651.4 4657.9 4704.9 4692.0 4723.5 4745.4 4745.8 4809.0 4663.1 4673.5 4678.3 4682.8 4734.0 4582.5 4743.7 4767.2 4771.4 4834.5 4523.5 4585.0 4588.1 4588.9 4591.4 04:49:36 INFO - PROCESS | 12234 | 04:49:36 INFO - PROCESS | 12234 | [#1] ext.html Cycles:180 Average:45171.68 Median:34996.56 stddev:82954.05 (237.0%) stddev-sans-first:83119.01 04:49:36 INFO - PROCESS | 12234 | Values: 517.5 532.9 538.1 561.4 570.1 27069.7 36982.8 38585.6 38640.6 43250.8 32506.8 32824.2 32901.7 32912.3 32926.2 7633.2 7785.8 7787.5 7789.0 7792.3 7658.9 7727.2 7740.0 7742.6 7750.2 7744.5 7786.6 7786.9 7794.7 7795.9 7457.6 7461.9 7492.1 7496.4 7500.2 7567.7 7643.5 7643.6 7648.6 7653.7 36863.0 36932.3 37173.4 37173.8 37264.6 2621.3 2624.6 2770.0 2794.7 3142.6 24700.4 26650.7 26745.6 27260.5 27426.5 3436.8 3488.3 3519.5 3529.1 3568.0 253662.0 254096.0 254840.0 254850.7 255356.0 50586.2 50666.0 50720.5 51019.0 51039.7 31610.8 32782.7 32973.5 34981.0 35012.1 13985.2 14232.1 14232.9 14234.8 14238.1 10593.8 10789.8 10803.1 10803.8 10816.6 17347.7 17354.4 17409.8 17531.8 17581.8 6605.8 6650.3 6733.0 6795.6 6802.3 756.5 880.2 935.3 958.8 977.6 26547.9 27233.5 27684.4 27832.3 28008.2 775.6 787.9 793.6 798.3 870.1 14026.0 14506.8 14546.4 14660.6 14768.0 367619.0 368886.0 369449.0 370752.0 370795.0 47343.3 47843.0 47917.8 47942.5 47981.3 947.9 995.4 1006.0 1015.0 1064.8 25902.5 27239.9 27754.6 28379.0 28715.6 38730.6 39063.2 39172.2 39184.6 39235.2 292166.0 294609.0 295872.0 296117.0 367353.0 21102.9 23174.7 24298.9 24317.3 25674.2 39442.2 39446.6 39735.6 39997.8 41222.0 34391.3 34610.7 34690.8 34732.1 34766.1 29395.0 29427.7 29599.0 30268.1 30556.5 34058.5 34307.5 34622.0 34855.1 34861.1 29897.9 33661.2 35309.0 35464.3 35515.5 24753.8 24913.5 25210.6 25219.5 25377.5 04:49:36 INFO - PROCESS | 12234 | 04:49:36 INFO - PROCESS | 12234 | [#2] jquery.html Cycles:180 Average:22935.79 Median:5016.94 stddev:62336.17 (1242.5%) stddev-sans-first:62487.91 04:49:36 INFO - PROCESS | 12234 | Values: 318.5 345.7 346.4 347.5 368.5 12109.2 13112.1 15159.4 15687.4 16850.4 14707.0 14846.1 15683.5 16206.8 16481.0 4629.6 4854.5 5058.5 5068.6 5076.1 4713.0 5010.9 5020.9 5028.5 5035.4 5003.6 5006.2 5010.9 5011.6 5013.0 4795.7 4948.5 4955.7 4973.9 4977.1 4427.5 4429.6 4437.4 4440.6 4441.2 18361.0 18735.0 19356.0 19631.0 19647.6 1709.3 1770.6 1782.0 1787.9 1986.6 8492.7 8510.2 8629.4 8783.1 8918.5 1635.8 1661.5 1687.9 1691.5 1790.3 62485.7 62767.7 63392.7 64109.4 64905.7 8927.8 9652.6 9793.8 9877.3 10045.7 13475.9 13569.5 13576.7 13580.4 13580.8 6877.7 6987.3 6997.7 7146.9 7187.0 6542.9 6554.2 6648.3 6671.0 6773.4 4142.3 4205.2 4214.3 4283.4 4309.2 1744.7 1806.2 1811.3 1830.8 1853.7 809.1 819.3 822.3 844.3 902.3 16421.9 16777.3 16813.6 17145.4 17314.2 717.7 750.0 831.0 847.4 871.8 8861.8 8876.7 9229.1 9395.7 9619.0 305323.0 390862.0 393083.0 393250.0 393468.0 68191.0 78273.0 79483.0 80189.0 80773.0 372.2 395.5 395.6 395.9 397.7 8792.4 9197.3 9216.5 9480.7 9591.5 32785.7 34949.8 35811.5 35870.1 36680.0 44608.0 48684.2 48956.0 49102.0 52277.2 6518.7 6612.7 6724.0 6757.4 6844.1 8507.8 9863.0 9893.3 10063.1 10270.6 8806.7 8987.9 9118.8 9272.2 9324.4 8291.9 8603.5 8702.3 8982.7 9085.7 9105.4 9222.6 9256.7 9323.0 9369.8 6472.9 6663.2 6670.7 6783.1 6810.7 8819.8 8918.7 8946.9 9158.8 9329.5 04:49:36 INFO - PROCESS | 12234 | 04:49:36 INFO - PROCESS | 12234 | [#3] mootools.html Cycles:180 Average:4738.00 Median:5692.92 stddev:2632.00 (46.2%) stddev-sans-first:2625.10 04:49:36 INFO - PROCESS | 12234 | Values: 1089.0 1306.1 1352.7 1355.3 1655.3 6377.6 7172.5 7470.8 7479.6 7687.7 7221.3 7304.2 7312.5 7313.2 7317.0 2032.2 2052.8 2053.6 2054.6 2059.1 1983.1 1984.5 1985.5 2021.4 2028.2 1988.1 1995.9 2002.3 2005.8 2013.1 1987.7 1993.2 1994.2 1994.2 1998.6 1961.3 1987.7 2016.9 2018.9 2021.8 6974.4 7164.5 7270.6 7270.9 7276.6 4103.8 4286.0 4289.5 4291.5 4292.9 2683.2 2805.5 2821.9 2838.1 2839.5 848.5 861.5 866.2 1663.1 1725.2 9730.6 9838.2 9886.9 9905.8 9918.8 3665.1 3665.6 3737.1 3807.1 3828.9 7859.3 7876.6 7880.9 7884.4 7893.8 4192.3 4193.4 4194.9 4197.0 4202.6 3309.7 3405.2 3734.9 3864.7 3868.8 3112.4 3151.5 3246.6 3248.6 3260.2 983.9 989.3 993.4 1003.3 1005.7 658.6 738.1 759.5 761.3 814.7 4736.8 4952.2 4959.8 4969.8 5048.7 752.2 780.9 820.5 856.9 859.7 3095.3 3097.1 3225.7 3234.1 3420.5 8248.6 8660.0 8672.5 8672.9 8680.3 8623.7 8635.4 8638.6 8648.0 8667.8 6858.4 6998.5 7009.3 7015.7 7028.5 4695.2 4731.0 4792.9 4844.6 4923.1 7916.7 8300.4 8323.0 8366.8 8617.4 7961.6 8125.6 8559.0 8678.0 8683.2 5467.5 6244.3 6392.9 6404.4 6416.3 6040.2 6758.7 6899.6 6912.8 6943.9 6203.9 6436.5 6461.8 6487.3 6499.7 6390.2 6441.8 6467.4 6494.9 6587.7 5661.5 5724.3 5727.8 5745.2 5786.6 4287.4 4297.6 4304.8 4330.7 4499.3 4273.8 4299.5 4340.9 4503.5 4625.7 04:49:36 INFO - PROCESS | 12234 | 04:49:36 INFO - PROCESS | 12234 | [#4] prototype.html Cycles:180 Average:3898.52 Median:4369.85 stddev:1130.52 (25.9%) stddev-sans-first:1100.40 04:49:36 INFO - PROCESS | 12234 | Values: 270.3 271.8 282.5 283.4 284.8 4484.5 4632.2 4686.7 4731.5 4757.9 4421.4 4532.4 4570.8 4589.7 4618.8 3637.3 3644.5 3650.1 3655.1 3661.8 3442.8 3563.4 3631.5 3632.6 3640.8 3467.9 3567.6 3576.9 3587.8 3612.8 3585.6 3588.9 3591.5 3592.9 3618.4 3144.8 3162.3 3162.5 3174.8 3179.6 4317.9 4428.4 4479.6 4513.6 4521.5 4008.3 4024.9 4037.9 4050.2 4058.6 4744.3 4746.4 4761.7 4765.4 4775.5 3412.1 3414.2 3418.9 3422.9 3424.5 4820.3 4973.9 4982.3 4992.9 5056.0 3483.4 3486.1 3487.7 3490.5 3497.2 3542.2 3548.3 3551.9 3557.2 3565.3 3967.3 3982.5 4089.2 4090.9 4091.8 4783.7 4817.5 4818.8 4835.7 4855.4 1137.7 1165.0 1200.9 1218.5 1234.0 844.8 846.2 865.0 872.3 872.6 4376.9 4382.0 4396.4 4398.7 4402.5 4958.3 4965.3 4992.3 4997.7 5004.5 4376.5 4378.6 4382.6 4389.0 4401.6 2262.7 2283.5 2310.4 2330.0 2340.7 4211.8 4214.8 4215.2 4223.0 4236.4 4491.0 4492.7 4510.6 4549.0 4597.8 4019.7 4168.3 4203.6 4232.7 4233.0 4364.2 4364.7 4375.0 4384.0 4397.3 4322.3 4331.7 4332.2 4378.4 4386.9 4016.0 4126.6 4135.3 4163.8 4187.6 3197.6 3204.2 3216.2 3220.7 3227.4 4384.5 4396.7 4404.7 4438.5 4473.7 4679.4 4731.2 4796.9 4802.5 4860.3 4837.2 4869.5 4887.1 4887.1 4893.3 4817.4 4846.5 4859.4 4862.2 4883.2 4697.8 4920.5 4941.9 4951.6 4955.0 4832.0 4846.6 4847.6 4849.4 4873.2 04:49:36 INFO - PROCESS | 12234 | 04:49:36 INFO - PROCESS | 12234 | [#5] yui.html Cycles:180 Average:15850.06 Median:582.00 stddev:22068.11 (3791.7%) stddev-sans-first:22100.02 04:49:36 INFO - PROCESS | 12234 | Values: 527.2 570.2 581.7 586.5 603.3 12362.2 13233.3 13295.1 13354.7 13356.5 12924.9 13507.3 13587.5 13600.7 13662.6 616.1 770.8 788.2 790.7 790.7 638.2 756.8 776.9 783.0 783.9 815.9 816.1 819.1 819.1 819.4 649.4 810.7 811.5 811.7 811.8 492.6 582.4 595.5 596.3 598.1 11774.6 11777.9 11816.8 11830.6 11832.1 11465.4 11626.9 11775.7 12015.6 12499.2 10955.9 10982.9 11093.6 11140.1 11258.6 3949.2 3953.6 3956.6 4032.8 4041.8 57787.7 59435.7 60215.0 60709.4 61127.7 9435.9 9456.1 9490.4 9645.6 9917.2 18433.4 18450.4 18451.6 18458.1 18524.4 6679.0 6679.2 6696.3 6809.1 6883.3 3394.4 3423.3 3447.3 3459.8 3508.3 2830.6 2941.9 2952.6 2955.1 2955.9 479.5 494.7 500.3 500.9 522.5 483.7 541.4 541.6 546.6 546.9 7732.5 7905.8 8086.5 8148.0 8332.0 469.8 523.1 557.4 558.5 559.4 3637.8 3660.3 3741.4 3978.0 3984.3 55306.0 83978.6 92077.6 95860.5 96792.5 49430.8 49528.0 49804.8 49884.3 50318.5 67714.0 72307.0 72542.0 72668.3 73751.0 7172.1 7311.8 7374.6 7456.9 7560.3 43558.6 44691.3 45873.0 46325.3 46339.8 58876.4 58941.0 61857.7 62584.7 62646.0 8905.6 9189.5 9238.4 9453.2 9801.5 10008.9 10591.7 10679.8 10904.9 11282.7 9779.2 9799.2 9832.6 9934.1 9962.5 9989.1 10095.4 10109.1 10237.0 10790.5 9679.5 9697.2 9747.7 9806.9 10355.5 8073.0 8177.3 8384.8 8561.5 8569.1 7854.1 8177.7 8185.3 8241.0 8316.3 04:49:36 INFO - PROCESS | 12234 | -------- Summary: end -------- 04:49:36 INFO - PROCESS | 12234 | 04:49:37 INFO - TEST-INFO | 12234: exit 0 04:49:37 INFO - TEST-OK | dromaeo_css | took 1122592ms 04:49:37 INFO - TEST-START | kraken 04:49:37 INFO - operating with platform_type : linux_ 04:49:37 INFO - Initialising browser for kraken test... 04:49:37 INFO - TEST-INFO | started process 12548 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdlswH3/profile http://localhost:39086/getInfo.html) 04:49:42 INFO - PROCESS | 12548 | __metrics Screen width/height:1600/1200 04:49:42 INFO - PROCESS | 12548 | colorDepth:24 04:49:42 INFO - PROCESS | 12548 | Browser inner width/height: 1024/697 04:49:42 INFO - PROCESS | 12548 | __metrics 04:49:43 INFO - PROCESS | 12548 | 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" 04:49:43 INFO - PROCESS | 12548 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:49:43 INFO - PROCESS | 12548 | console.error: PushService: 04:49:43 INFO - PROCESS | 12548 | stateChangeProcessEnqueue: Error transitioning state 04:49:43 INFO - PROCESS | 12548 | UnknownError 04:49:44 INFO - TEST-INFO | 12548: exit 0 04:49:44 INFO - Browser initialized. 04:49:44 INFO - Running cycle 1/1 for kraken test... 04:49:44 INFO - TEST-INFO | started process 12631 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdlswH3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:49:56 INFO - PROCESS | 12631 | RSS: Main: 175194112 04:49:56 INFO - PROCESS | 12631 | 04:49:59 INFO - PROCESS | 12631 | Cycle 1(1): loaded http://localhost:39086/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39086/tests/kraken/driver.html?testName=audio-beat-detection) 04:50:00 INFO - PROCESS | 12631 | RSS: Main: 237768704 04:50:00 INFO - PROCESS | 12631 | 04:50:03 INFO - PROCESS | 12631 | Cycle 1(1): loaded http://localhost:39086/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39086/tests/kraken/driver.html?testName=audio-dft) 04:50:04 INFO - PROCESS | 12631 | RSS: Main: 218374144 04:50:04 INFO - PROCESS | 12631 | 04:50:07 INFO - PROCESS | 12631 | Cycle 1(1): loaded http://localhost:39086/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39086/tests/kraken/driver.html?testName=audio-fft) 04:50:07 INFO - PROCESS | 12631 | RSS: Main: 300130304 04:50:07 INFO - PROCESS | 12631 | 04:50:10 INFO - PROCESS | 12631 | Cycle 1(1): loaded http://localhost:39086/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39086/tests/kraken/driver.html?testName=audio-oscillator) 04:50:10 INFO - PROCESS | 12631 | RSS: Main: 210665472 04:50:10 INFO - PROCESS | 12631 | 04:50:13 INFO - PROCESS | 12631 | Cycle 1(1): loaded http://localhost:39086/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39086/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:50:13 INFO - PROCESS | 12631 | RSS: Main: 214093824 04:50:13 INFO - PROCESS | 12631 | 04:50:16 INFO - PROCESS | 12631 | Cycle 1(1): loaded http://localhost:39086/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39086/tests/kraken/driver.html?testName=imaging-darkroom) 04:50:17 INFO - PROCESS | 12631 | RSS: Main: 249737216 04:50:17 INFO - PROCESS | 12631 | 04:50:21 INFO - PROCESS | 12631 | Cycle 1(1): loaded http://localhost:39086/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39086/tests/kraken/driver.html?testName=imaging-desaturate) 04:50:21 INFO - PROCESS | 12631 | RSS: Main: 243863552 04:50:21 INFO - PROCESS | 12631 | 04:50:24 INFO - PROCESS | 12631 | Cycle 1(1): loaded http://localhost:39086/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39086/tests/kraken/driver.html?testName=json-parse-financial) 04:50:25 INFO - PROCESS | 12631 | RSS: Main: 247148544 04:50:25 INFO - PROCESS | 12631 | 04:50:26 INFO - PROCESS | 12631 | Cycle 1(1): loaded http://localhost:39086/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39086/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:50:27 INFO - PROCESS | 12631 | RSS: Main: 210522112 04:50:27 INFO - PROCESS | 12631 | 04:50:29 INFO - PROCESS | 12631 | Cycle 1(1): loaded http://localhost:39086/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39086/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:50:30 INFO - PROCESS | 12631 | RSS: Main: 217231360 04:50:30 INFO - PROCESS | 12631 | 04:50:32 INFO - PROCESS | 12631 | Cycle 1(1): loaded http://localhost:39086/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39086/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:50:32 INFO - PROCESS | 12631 | RSS: Main: 226906112 04:50:32 INFO - PROCESS | 12631 | 04:50:35 INFO - PROCESS | 12631 | Cycle 1(1): loaded http://localhost:39086/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39086/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:50:36 INFO - PROCESS | 12631 | RSS: Main: 235503616 04:50:36 INFO - PROCESS | 12631 | 04:50:39 INFO - PROCESS | 12631 | Cycle 1(1): loaded http://localhost:39086/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39086/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:50:40 INFO - PROCESS | 12631 | RSS: Main: 231968768 04:50:40 INFO - PROCESS | 12631 | 04:50:41 INFO - PROCESS | 12631 | Cycle 1(1): loaded http://localhost:39086/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39086/tests/kraken/driver.html?testName=ai-astar) 04:50:42 INFO - PROCESS | 12631 | RSS: Main: 283316224 04:50:42 INFO - PROCESS | 12631 | 04:50:42 INFO - PROCESS | 12631 | __start_tp_report 04:50:42 INFO - PROCESS | 12631 | _x_x_mozilla_page_load 04:50:42 INFO - PROCESS | 12631 | _x_x_mozilla_page_load_details 04:50:42 INFO - PROCESS | 12631 | |i|pagename|runs| 04:50:42 INFO - PROCESS | 12631 | |0;ai-astar;112;117;114;116;114;114;114;115;114;113 04:50:42 INFO - PROCESS | 12631 | |1;audio-beat-detection;156;132;132;168;131;128;131;130;165;128 04:50:42 INFO - PROCESS | 12631 | |2;audio-dft;163;163;164;163;162;159;162;162;162;161 04:50:42 INFO - PROCESS | 12631 | |3;audio-fft;76;75;76;106;76;76;76;77;125;76 04:50:42 INFO - PROCESS | 12631 | |4;audio-oscillator;84;83;115;84;84;84;119;92;82;118 04:50:42 INFO - PROCESS | 12631 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;117;117 04:50:42 INFO - PROCESS | 12631 | |6;imaging-darkroom;147;146;146;147;148;146;147;146;147;146 04:50:42 INFO - PROCESS | 12631 | |7;imaging-desaturate;95;95;95;95;95;95;95;94;94;94 04:50:42 INFO - PROCESS | 12631 | |8;json-parse-financial;65;67;67;66;75;67;67;68;67;66 04:50:42 INFO - PROCESS | 12631 | |9;json-stringify-tinderbox;66;68;66;66;66;68;66;68;67;67 04:50:42 INFO - PROCESS | 12631 | |10;stanford-crypto-aes;84;83;83;83;84;83;83;82;82;83 04:50:42 INFO - PROCESS | 12631 | |11;stanford-crypto-ccm;145;154;140;139;145;137;138;138;196;146 04:50:42 INFO - PROCESS | 12631 | |12;stanford-crypto-pbkdf2;174;176;173;174;173;173;174;175;176;178 04:50:42 INFO - PROCESS | 12631 | |13;stanford-crypto-sha256-iterative;73;75;71;69;70;70;69;70;69;68 04:50:42 INFO - PROCESS | 12631 | __end_tp_report 04:50:42 INFO - PROCESS | 12631 | __start_cc_report 04:50:42 INFO - PROCESS | 12631 | _x_x_mozilla_cycle_collect,1995 04:50:42 INFO - PROCESS | 12631 | __end_cc_report 04:50:42 INFO - PROCESS | 12631 | __startTimestamp1476273042174__endTimestamp 04:50:42 INFO - PROCESS | 12631 | 04:50:42 INFO - PROCESS | 12631 | ------- Summary: start ------- 04:50:42 INFO - PROCESS | 12631 | Number of tests: 14 04:50:42 INFO - PROCESS | 12631 | 04:50:42 INFO - PROCESS | 12631 | [#0] ai-astar Cycles:10 Average:114.30 Median:114.00 stddev:1.42 (1.2%) stddev-sans-first:1.24 04:50:42 INFO - PROCESS | 12631 | Values: 112.0 117.0 114.0 116.0 114.0 114.0 114.0 115.0 114.0 113.0 04:50:42 INFO - PROCESS | 12631 | 04:50:42 INFO - PROCESS | 12631 | [#1] audio-beat-detection Cycles:10 Average:140.10 Median:132.00 stddev:16.13 (12.2%) stddev-sans-first:16.05 04:50:42 INFO - PROCESS | 12631 | Values: 156.0 132.0 132.0 168.0 131.0 128.0 131.0 130.0 165.0 128.0 04:50:42 INFO - PROCESS | 12631 | 04:50:42 INFO - PROCESS | 12631 | [#2] audio-dft Cycles:10 Average:162.10 Median:162.50 stddev:1.37 (0.8%) stddev-sans-first:1.41 04:50:42 INFO - PROCESS | 12631 | Values: 163.0 163.0 164.0 163.0 162.0 159.0 162.0 162.0 162.0 161.0 04:50:42 INFO - PROCESS | 12631 | 04:50:42 INFO - PROCESS | 12631 | [#3] audio-fft Cycles:10 Average:83.90 Median:76.00 stddev:17.25 (22.7%) stddev-sans-first:18.06 04:50:42 INFO - PROCESS | 12631 | Values: 76.0 75.0 76.0 106.0 76.0 76.0 76.0 77.0 125.0 76.0 04:50:42 INFO - PROCESS | 12631 | 04:50:42 INFO - PROCESS | 12631 | [#4] audio-oscillator Cycles:10 Average:94.50 Median:84.00 stddev:16.02 (19.1%) stddev-sans-first:16.53 04:50:42 INFO - PROCESS | 12631 | Values: 84.0 83.0 115.0 84.0 84.0 84.0 119.0 92.0 82.0 118.0 04:50:42 INFO - PROCESS | 12631 | 04:50:42 INFO - PROCESS | 12631 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 04:50:42 INFO - PROCESS | 12631 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 04:50:42 INFO - PROCESS | 12631 | 04:50:42 INFO - PROCESS | 12631 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:147.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 04:50:42 INFO - PROCESS | 12631 | Values: 147.0 146.0 146.0 147.0 148.0 146.0 147.0 146.0 147.0 146.0 04:50:42 INFO - PROCESS | 12631 | 04:50:42 INFO - PROCESS | 12631 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 04:50:42 INFO - PROCESS | 12631 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 94.0 94.0 94.0 04:50:42 INFO - PROCESS | 12631 | 04:50:42 INFO - PROCESS | 12631 | [#8] json-parse-financial Cycles:10 Average:67.50 Median:67.00 stddev:2.76 (4.1%) stddev-sans-first:2.77 04:50:42 INFO - PROCESS | 12631 | Values: 65.0 67.0 67.0 66.0 75.0 67.0 67.0 68.0 67.0 66.0 04:50:42 INFO - PROCESS | 12631 | 04:50:42 INFO - PROCESS | 12631 | [#9] json-stringify-tinderbox Cycles:10 Average:66.80 Median:67.00 stddev:0.92 (1.4%) stddev-sans-first:0.93 04:50:42 INFO - PROCESS | 12631 | Values: 66.0 68.0 66.0 66.0 66.0 68.0 66.0 68.0 67.0 67.0 04:50:42 INFO - PROCESS | 12631 | 04:50:42 INFO - PROCESS | 12631 | [#10] stanford-crypto-aes Cycles:10 Average:83.00 Median:83.00 stddev:0.67 (0.8%) stddev-sans-first:0.60 04:50:42 INFO - PROCESS | 12631 | Values: 84.0 83.0 83.0 83.0 84.0 83.0 83.0 82.0 82.0 83.0 04:50:42 INFO - PROCESS | 12631 | 04:50:42 INFO - PROCESS | 12631 | [#11] stanford-crypto-ccm Cycles:10 Average:147.80 Median:145.00 stddev:17.73 (12.2%) stddev-sans-first:18.77 04:50:42 INFO - PROCESS | 12631 | Values: 145.0 154.0 140.0 139.0 145.0 137.0 138.0 138.0 196.0 146.0 04:50:42 INFO - PROCESS | 12631 | 04:50:42 INFO - PROCESS | 12631 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.60 Median:174.50 stddev:1.65 (0.9%) stddev-sans-first:1.73 04:50:42 INFO - PROCESS | 12631 | Values: 174.0 176.0 173.0 174.0 173.0 173.0 174.0 175.0 176.0 178.0 04:50:42 INFO - PROCESS | 12631 | 04:50:42 INFO - PROCESS | 12631 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.40 Median:70.00 stddev:2.12 (3.0%) stddev-sans-first:2.03 04:50:42 INFO - PROCESS | 12631 | Values: 73.0 75.0 71.0 69.0 70.0 70.0 69.0 70.0 69.0 68.0 04:50:42 INFO - PROCESS | 12631 | -------- Summary: end -------- 04:50:42 INFO - PROCESS | 12631 | 04:50:43 INFO - TEST-INFO | 12631: exit 0 04:50:43 INFO - TEST-OK | kraken | took 65458ms 04:50:43 INFO - SUITE-END | took 1188s 04:50:43 INFO - Completed test suite (00:19:48) 04:50:43 INFO - javascript benchmark 04:50:43 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2511.171313466556, 2560.5263026340135, 2560.9487810243786, 2602.622619720141, 2609.725978772228, 4311.762853043081, 4363.323684828857, 4491.303847903576, 4503.437070366204, 4517.412736344275, 4359.128174365123, 4379.2336341140335, 4386.8903277418085, 4419.403380543626, 4426.97786511067, 4028.053407449247, 4048.736832105904, 4057.6348128668415, 4083.958590559403, 4140.399642051901, 4163.875083747493, 4172.33242681171, 4185.979070104645, 4188.497380314351, 4189.392538081976, 4129.855455059073, 4160.375943608453, 4180.937285940713, 4181.3309870420735, 4219.451471308741, 4224.619784219404, 4232.174725928445, 4234.470691163605, 4246.469191351066, 4271.508776490681, 4044.3529035354495, 4060.4112403701297, 4124.443200167969, 4160.063985603245, 4219.303814870543, 4367.061081867382, 4374.1689079075195, 4378.321360189176, 4385.079133381993, 4411.470623525198, 4636.397268355092, 4666.2767271073035, 4672.462666793328, 4722.315264286659, 4734.171519983989, 4659.231226847566, 4695.929561056587, 4699.342092107107, 4703.129920964632, 4718.41019872516, 4458.398116254329, 4459.843905463325, 4468.798904049326, 4469.709468884512, 4476.6418686505, 4866.197077482247, 4874.561289483892, 4876.609871210295, 4881.658283920092, 4882.365292512021, 4604.493505714368, 4651.302304654261, 4654.162250794821, 4676.415448068991, 4717.834875779331, 4728.787204575802, 4731.952680473151, 4732.550407711262, 4779.856604301876, 4795.640326975421, 4638.605718513897, 4687.367205427292, 4692.671512994058, 4718.693284936468, 4739.0, 4566.06395688883, 4609.216433206363, 4613.492515823256, 4655.837045703384, 4664.300354946785, 4014.2573623879675, 4055.209234199303, 4100.220958017967, 4108.157827645326, 4109.157622687342, 3557.0573797943566, 3561.4123669594746, 3567.35787558242, 3600.3159399713973, 3604.1530240394013, 4139.710220284612, 4218.156368726267, 4245.787710614519, 4254.234237837157, 4277.893052673646, 4709.976450117728, 4757.333973243749, 4759.762011899391, 4762.071396077801, 4765.356676848581, 4186.874393768131, 4187.6440502557625, 4214.3678448232395, 4215.367694845798, 4222.78886055696, 4340.696151269381, 4396.560343965578, 4400.647948164139, 4412.4043254160915, 4413.13943780966, 4612.3542704021465, 4616.422947131608, 4622.6764126510825, 4623.144718227139, 4679.836205732715, 4641.466231383299, 4827.444843843003, 4847.151748443937, 4850.53919877611, 4898.387701537308, 4475.149721552894, 4527.90944181108, 4532.3654688342995, 4572.908541829212, 4583.358329833759, 4720.291956206596, 4723.244280915037, 4767.809287628456, 4778.283257511401, 4782.593479554277, 4692.272697731721, 4792.784324705327, 4795.304680821331, 4795.808167673254, 4847.321375007572, 4581.083783243432, 4644.210484217759, 4651.395318608695, 4657.93013104797, 4704.905901882012, 4692.014676917749, 4723.480417154179, 4745.359376484131, 4745.83389581363, 4808.9519104808505, 4663.067386522641, 4673.485916549245, 4678.321643361762, 4682.789274482725, 4733.952660473351, 4582.518835522222, 4743.66794324394, 4767.237242041257, 4771.403574553181, 4834.516548345137, 4523.502414734442, 4584.991301913574, 4588.128255631419, 4588.88527786808, 4591.3572099906705], "value": 4403.089311491211, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [517.4954419441044, 532.882765791526, 538.1201735163008, 561.4189314059946, 570.076476108704, 27069.72930270699, 36982.8150859246, 38585.614143858555, 38640.61359386405, 43250.7837460813, 32506.77411936451, 32824.17939551512, 32901.67098329016, 32912.341753164925, 32926.17684557887, 7633.1985141560035, 7785.805354866117, 7787.454878158531, 7789.026371703537, 7792.259735325163, 7658.885116723253, 7727.188645192258, 7739.993800805887, 7742.574158421285, 7750.224977502233, 7744.535327880317, 7786.649600767951, 7786.922130778705, 7794.727184548542, 7795.883061754078, 7457.627118644074, 7461.850762984737, 7492.100947886289, 7496.362809161228, 7500.212477689818, 7567.6756567601, 7643.541387516767, 7643.579603121826, 7648.617569121521, 7653.732119375851, 36863.0, 36932.26135477302, 37173.442398364044, 37173.814130929175, 37264.627353726384, 2621.279148234232, 2624.593188055854, 2769.9723002770115, 2794.720527947209, 3142.591463109781, 24700.382490437703, 26650.73349266502, 26745.598816017777, 27260.45479090427, 27426.451470970667, 3436.7937923724658, 3488.2849015951924, 3519.489673997256, 3529.100079479742, 3567.9821600892087, 253662.0, 254096.0, 254840.0, 254850.72574637193, 255356.0, 50586.241206381936, 50666.0, 50720.492795072314, 51019.0, 51039.7448012765, 31610.841945790584, 32782.672173278435, 32973.50539741906, 34981.0, 35012.12469688278, 13985.230812305217, 14232.074915130483, 14232.85767142336, 14234.786478202835, 14238.074525155831, 10593.84109238362, 10789.784204315869, 10803.13574914005, 10803.83794243087, 10816.621418250481, 17347.739783903253, 17354.39259625907, 17409.82590174082, 17531.82468175302, 17581.82418175802, 6605.768798092044, 6650.3349665034075, 6732.966335168391, 6795.558288711317, 6802.319768023257, 756.4629113329597, 880.2078129683337, 935.2564711054728, 958.7746879483316, 977.6089564174387, 26547.86726066396, 27233.45533089327, 27684.40872835528, 27832.304192395353, 28008.159755207376, 775.6393277126164, 787.9330256928225, 793.6031984007996, 798.2895223251311, 870.1081391573688, 14026.0, 14506.782398264035, 14546.41814327415, 14660.56018319452, 14768.0, 367619.0, 368886.0, 369449.0, 370752.0, 370795.0, 47343.28985065227, 47843.0, 47917.76041119772, 47942.52057479381, 47981.280280795814, 947.9146876781123, 995.4176806568094, 1006.0342071611335, 1014.9545967653181, 1064.7817197474499, 25902.481950361263, 27239.86380068087, 27754.583681244392, 28379.0, 28715.569266461436, 38730.6126938727, 39063.2187356257, 39172.2165556693, 39184.608153918096, 39235.2152956945, 292166.0, 294609.0, 295872.0, 296117.0, 367353.0, 21102.894485527475, 23174.652380213975, 24298.878505607358, 24317.27048188557, 25674.229773106836, 39442.21115577615, 39446.60553394429, 39735.602643974344, 39997.80001100092, 41222.0, 34391.31217375689, 34610.65389346175, 34690.82654586711, 34732.131696706776, 34766.13084672904, 29395.0, 29427.705722942497, 29599.0, 30268.09195724132, 30556.472176391537, 34058.489122663676, 34307.4853877197, 34622.0, 34855.12862178466, 34861.12847178841, 29897.850510747307, 33661.15847103842, 35309.0, 35464.290714186085, 35515.46726799048, 24753.752462475146, 24913.50172996566, 25210.621840672036, 25219.495610088063, 25377.49245015126], "value": 16482.99988625189, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [318.5492528072777, 345.6871531264206, 346.4387691939059, 347.4527619000075, 368.4602057985051, 12109.15235933484, 13112.082154249207, 15159.39362425503, 15687.372505099782, 16850.410235641753, 14707.0, 14846.109233446, 15683.529494115166, 16206.837931620681, 16481.0, 4629.583337499625, 4854.538818812216, 5058.49415058493, 5068.594512438996, 5076.111680455924, 4712.976435117836, 5010.924836127461, 5020.899582008357, 5028.522290382408, 5035.370578677665, 5003.599712023048, 5006.249062640615, 5010.949890501085, 5011.646855349054, 5012.9749351253195, 4795.736234507101, 4948.529889660476, 4955.653104282702, 4973.925391119136, 4977.054359671687, 4427.468703755538, 4429.601335879786, 4437.378766972626, 4440.578145076212, 4441.222786012435, 18361.0, 18735.0, 19356.0, 19631.0, 19647.607047858965, 1709.3419033672, 1770.5927636643514, 1782.0466050662833, 1787.865910056738, 1986.612610540945, 8492.74521764348, 8510.191531804468, 8629.439086459422, 8783.12168783123, 8918.464892106495, 1635.8445947634955, 1661.5264649574933, 1687.9156042197842, 1691.5094622559443, 1790.2965333438983, 62485.6875715623, 62767.686161569356, 63392.68303658498, 64109.3589064108, 64905.67547162281, 8927.776805579913, 9652.565634546463, 9793.804123917482, 9877.259205559612, 10045.69862904114, 13475.865241347658, 13569.52506662262, 13576.728465430637, 13580.3703555572, 13580.796288055688, 6877.690503927335, 6987.336203060701, 6997.7200911962955, 7146.857062858714, 7186.951718760233, 6542.901856472156, 6554.246261679968, 6648.33516648341, 6671.032700258435, 6773.390394864486, 4142.316517774533, 4205.158968206371, 4214.325707886724, 4283.357496375506, 4309.159713855831, 1744.6772347115825, 1806.1601355369817, 1811.293595497757, 1830.7620009398693, 1853.7126745354492, 809.1018968944467, 819.3035919468523, 822.2763967708498, 844.3076677124822, 902.2988790671586, 16421.91789041047, 16777.328906843588, 16813.57966050834, 17145.399911003304, 17314.220860061327, 717.6770453295933, 750.0249675422039, 830.9875351869727, 847.3856454070749, 871.7820544863785, 8861.778455538533, 8876.733697989072, 9229.123233292827, 9395.671151509665, 9619.038096190325, 305323.0, 390862.0, 393083.0, 393250.0, 393468.0, 68191.0, 78273.0, 79483.0, 80189.0, 80773.0, 372.179344545277, 395.54117224020575, 395.5826602933875, 395.87529928072564, 397.73550588858086, 8792.384533082879, 9197.264218862609, 9216.539173041187, 9480.715578532656, 9591.520423978913, 32785.672143278265, 34949.82525087358, 35811.462828058124, 35870.10324741902, 36680.0, 44608.0, 48684.21052631562, 48956.041758329266, 49102.0, 52277.215841763165, 6518.706658200297, 6612.7435787200275, 6723.966380168068, 6757.391834734897, 6844.076049733222, 8507.787305317417, 9862.950685246527, 9893.258005649748, 10063.094321511098, 10270.589176432859, 8806.691765788166, 8987.865182022406, 9118.772030699285, 9272.211861991806, 9324.393914395543, 8291.927018245438, 8603.52680602573, 8702.260307873901, 8982.730518084469, 9085.682001129928, 9105.362624616213, 9222.584983675617, 9256.676016339396, 9323.01663467711, 9369.765755856159, 6472.902906456313, 6663.233728121328, 6670.699818508276, 6783.084283621648, 6810.693518791765, 8819.779505512157, 8918.687845925362, 8946.910530894607, 9158.816823663623, 9329.533523323942], "value": 7376.9946023720495, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1089.003561741007, 1306.059637061316, 1352.7429788340216, 1355.3020194599783, 1655.2551351891643, 6377.649229292387, 7172.497925145235, 7470.813229669247, 7479.551226926388, 7687.654055567499, 7221.27787221279, 7304.160021597518, 7312.488125831194, 7313.232110628374, 7317.0, 2032.1668116072412, 2052.8152466278034, 2053.640612892745, 2054.589082183562, 2059.1042896340064, 1983.1076015792878, 1984.533634595876, 1985.5333996510808, 2021.353166986565, 2028.1785876719953, 1988.0755448716343, 1995.9201631934777, 2002.3192114681005, 2005.8295044921126, 2013.1142297389101, 1987.6521608718417, 1993.1728332741895, 1994.2322205950813, 1994.2421879685626, 1998.5902889907534, 1961.3135402609116, 1987.701844723303, 2016.8588198826087, 2018.8687735297306, 2021.848361372903, 6974.407175390098, 7164.498485106044, 7270.636468176623, 7270.927290727131, 7276.599787011713, 4103.835846566134, 4286.014216730169, 4289.506706728735, 4291.506476755182, 4292.935605965913, 2683.2352779457956, 2805.5370863807448, 2821.915342539727, 2838.0918106206022, 2839.5030869597945, 848.5417874347845, 861.4831101339147, 866.1728049712509, 1663.0853030832993, 1725.1546742096407, 9730.610775568968, 9838.163756080741, 9886.90113098867, 9905.771201479682, 9918.752031199205, 3665.138692407282, 3665.578458477256, 3737.1404576947452, 3807.0672685191753, 3828.8659896903473, 7859.292663660298, 7876.606169691492, 7880.921190788019, 7884.408669349822, 7893.763187104396, 4192.3082691355585, 4193.39195816611, 4194.916101678011, 4197.034682023152, 4202.600752928467, 3309.7352211822995, 3405.2338223899424, 3734.9066273343383, 3864.6521813036397, 3868.8259028343227, 3112.42420152268, 3151.5430262612254, 3246.610406751158, 3248.5776849009476, 3260.168656992452, 983.8671779309844, 989.312427862643, 993.4188499727596, 1003.3377970539409, 1005.6580762540772, 658.6377492379172, 738.1326940844593, 759.544273435934, 761.3186198352444, 814.686345756876, 4736.786844592001, 4952.232403977389, 4959.752012399365, 4969.751512424436, 5048.697078175322, 752.1913942511821, 780.898483197192, 820.5117954816874, 856.9271611912933, 859.673324136824, 3095.3190298134373, 3097.07087873637, 3225.70968612826, 3234.1267857678295, 3420.4698271767916, 8248.587570621565, 8660.047394786568, 8672.523011234443, 8672.913270867337, 8680.262177714838, 8623.655053797778, 8635.395522313504, 8638.56807159652, 8647.956760216159, 8667.783305417415, 6858.417034552019, 6998.545094568837, 7009.334113259232, 7015.719371225094, 7028.543144695681, 4695.154872123051, 4730.9763451182525, 4792.856214313576, 4844.636652251025, 4923.138450771029, 7916.683332666629, 8300.377471689526, 8323.001239851015, 8366.83266334682, 8617.439866408915, 7961.601919903866, 8125.553094579855, 8559.0, 8677.956610217161, 8683.2185103341, 5467.535259502987, 6244.313125556276, 6392.93607063942, 6404.391582799627, 6416.326285740117, 6040.154378386941, 6758.7296508139125, 6899.551529150589, 6912.827179320558, 6943.930560694531, 6203.875922481616, 6436.485081193399, 6461.838454038687, 6487.318831522811, 6499.740010399721, 6390.201224846895, 6441.774537891151, 6467.417932386108, 6494.9025764612625, 6587.703553340016, 5661.547076233809, 5724.284464441945, 5727.825795711786, 5745.166950792028, 5786.623869448641, 4287.3997640331, 4297.570242975802, 4304.763238021814, 4330.7401555906745, 4499.347594598699, 4273.786310684515, 4299.548547402478, 4340.9131817364105, 4503.459584849839, 4625.722456652612], "value": 3838.3802158398744, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [270.2743134683374, 271.83383285704326, 282.51830628777924, 283.35253944736274, 284.84048932597733, 4484.5201083642405, 4632.166210082184, 4686.742229177398, 4731.503192164825, 4757.928631070532, 4421.447319085114, 4532.410786597746, 4570.840020599279, 4589.65577581681, 4618.8152473901, 3637.290728307981, 3644.489771432002, 3650.1057240975865, 3655.1227705350657, 3661.816909154545, 3442.8294379910826, 3563.3585954528176, 3631.5279013728177, 3632.6185750496215, 3640.7815531068222, 3467.9479807802904, 3567.5897271813815, 3576.946345804815, 3587.802670853102, 3612.7832330060282, 3585.551806024247, 3588.8923332300205, 3591.5331006969186, 3592.946105808415, 3618.4210526315796, 3144.795588286754, 3162.3359094590164, 3162.4940009598354, 3174.761892858045, 3179.60254968129, 4317.935230971507, 4428.424304840382, 4479.574440428154, 4513.638908887314, 4521.485302423692, 4008.2985477541606, 4024.9132734161612, 4037.8788636340955, 4050.18996200761, 4058.553559108496, 4744.288356746481, 4746.359241502388, 4761.6904901181315, 4765.404324459442, 4775.498572649856, 3412.1128506588216, 3414.23179784549, 3418.897433076987, 3422.863085476578, 3424.520567120605, 4820.25286080658, 4973.925391119136, 4982.327385802906, 4992.90014199714, 5055.974720126413, 3483.3729928613093, 3486.145894255873, 3487.6746836202083, 3490.5462289902657, 3497.178163131662, 3542.1662669864004, 3548.254866478017, 3551.9289614208087, 3557.1818481748824, 3565.286942611436, 3967.3453880110037, 3982.522097348337, 4089.161721847014, 4090.8977275567754, 4091.774952377648, 4783.7129772213775, 4817.482493014689, 4818.759062046884, 4835.709857408567, 4855.441624213261, 1137.670075678044, 1164.9708757281135, 1200.9191727445195, 1218.4760552962134, 1233.9814902776466, 844.8099177685094, 846.2087947768856, 865.000923932846, 872.267295471794, 872.5680788009976, 4376.890577735582, 4382.0, 4396.4284642996845, 4398.714083584557, 4402.471703395613, 4958.305837182797, 4965.32968049316, 4992.2511623256805, 4997.725125118153, 5004.549590536869, 4376.540463251313, 4378.605925466723, 4382.561743825656, 4389.0, 4401.6478681705385, 2262.739784924722, 2283.5318759654233, 2310.3646497213063, 2329.998100816665, 2340.694416000272, 4211.831526738896, 4214.789260536961, 4215.156968606291, 4222.9577704223175, 4236.428082208924, 4491.0, 4492.742032230981, 4510.571495707903, 4548.999220171557, 4597.793099310472, 4019.658329042064, 4168.333066709312, 4203.62167404935, 4232.746035237896, 4232.978835105805, 4364.214441400578, 4364.716293440916, 4374.978125109354, 4384.027187765454, 4397.340398940057, 4322.308430651081, 4331.675124365622, 4332.1985432695055, 4378.372976214246, 4386.903274181454, 4016.0445397995586, 4126.628603425706, 4135.2763266427655, 4163.791810409407, 4187.602177793105, 3197.58431403916, 3204.1736210359873, 3216.182856685965, 3220.663424678732, 3227.4351988402404, 4384.517703052597, 4396.659018999236, 4404.678596420997, 4438.535283356549, 4473.686841921034, 4679.438467383936, 4731.172044892199, 4796.856094317176, 4802.4632117723395, 4860.270959356125, 4837.2260438329695, 4869.537393947569, 4887.120318342732, 4887.144749668865, 4893.290472881484, 4817.397825271841, 4846.539578740014, 4859.392575928009, 4862.246351815475, 4883.194272944925, 4697.788599513098, 4920.45874953762, 4941.876453088702, 4951.554360107608, 4955.0, 4832.0, 4846.612271018381, 4847.636427267898, 4849.442314133919, 4873.171560834596], "value": 3542.396687937942, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [527.2355085126567, 570.1618620627677, 581.6510093943634, 586.4868240289746, 603.3483837455549, 12362.196457230286, 13233.338333083355, 13295.135816171942, 13354.66613334667, 13356.532521361754, 12924.93537532311, 13507.324633768321, 13587.456501739918, 13600.659983500418, 13662.590122296322, 616.1404840247851, 770.7880332908439, 788.2354116507008, 790.6876783670447, 790.7113903425266, 638.1671918146817, 756.825930036092, 776.8601651702692, 783.0094929913664, 783.8941742864725, 815.8939337886067, 816.102287483769, 819.0580832043139, 819.1112642782558, 819.3772732723144, 649.4414803269185, 810.7324582887633, 811.5495899775622, 811.6712731343786, 811.8335741173075, 492.6034542193533, 582.3564960718387, 595.5206059122405, 596.31126049413, 598.0520874414059, 11774.587889423829, 11777.882221177764, 11816.822747658705, 11830.645080647595, 11832.053435725207, 11465.426728663617, 11626.883731162665, 11775.7056073598, 12015.639530814002, 12499.187552809039, 10955.945220273848, 10982.890171098266, 11093.55625774968, 11140.108791296676, 11258.605948791836, 3949.1706741584303, 3953.5651078381356, 3956.5845586213322, 4032.8185231664647, 4041.8383264669674, 57787.71106144485, 59435.70282148605, 60215.0, 60709.39290607082, 61127.69436152835, 9435.905640943503, 9456.14894659484, 9490.430574165433, 9645.565949532287, 9917.206623470105, 18433.446996590123, 18450.446486605422, 18451.630967380577, 18458.077096145138, 18524.44426667202, 6679.0, 6679.165104361955, 6696.263411024784, 6809.114815074008, 6883.311668833177, 3394.35507253621, 3423.281110966725, 3447.3277710846146, 3459.7924124552605, 3508.2808024354945, 2830.589564513134, 2941.911742647724, 2952.5571164325524, 2955.12823717004, 2955.940881182364, 479.453423097662, 494.71801073387826, 500.3470471035261, 500.86977385879936, 522.5271129627693, 483.66143699410554, 541.38823129863, 541.553218594661, 546.6091744402771, 546.9316335458068, 7732.497387669783, 7905.802354941173, 8086.5148091114725, 8147.981502312211, 8332.0, 469.7815515785108, 523.1107117899586, 557.3757391721298, 558.5447859994092, 559.3986464550625, 3637.781733096023, 3660.3228402745576, 3741.43878418234, 3978.0, 3984.2629113614075, 55306.0, 83978.5801071003, 92077.61883571751, 95860.52069739606, 96792.51603741937, 49430.75284623554, 49528.0, 49804.75097624489, 49884.25173622399, 50318.496815032115, 67714.0, 72306.99999999895, 72542.0, 72668.27331726615, 73751.0, 7172.139343278631, 7311.780646580611, 7374.557526548424, 7456.925430745623, 7560.281773231534, 43558.56441435545, 44691.32963005493, 45873.0, 46325.305120423895, 46339.76830115828, 58876.41123588881, 58941.0, 61857.69071154615, 62584.687076564325, 62646.0, 8905.599248033983, 9189.540522973959, 9238.353315268136, 9453.196478299147, 9801.50992450389, 10008.949955250177, 10591.682249532527, 10679.786404271716, 10904.890951090387, 11282.717932051764, 9779.217662587118, 9799.167070798776, 9832.557534910804, 9934.056264654846, 9962.50187490608, 9989.100980911753, 10095.44475053879, 10109.14072303833, 10237.0, 10790.514426850968, 9679.516024198621, 9697.22422206236, 9747.707568772948, 9806.901930980885, 10355.534000969823, 8073.031236251687, 8177.304929081095, 8384.83230335402, 8561.529115898686, 8569.10024447424, 7854.1360450349275, 8177.67289308421, 8185.304249138651, 8241.0, 8316.293115085286], "value": 6084.153424793472, "unit": "score"}], "name": "dromaeo_css", "value": 5948.332576106965, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 117.0, 114.0, 116.0, 114.0, 114.0, 114.0, 115.0, 114.0, 113.0], "value": 114.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 132.0, 132.0, 168.0, 131.0, 128.0, 131.0, 130.0, 165.0, 128.0], "value": 140.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 164.0, 163.0, 162.0, 159.0, 162.0, 162.0, 162.0, 161.0], "value": 162.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 76.0, 106.0, 76.0, 76.0, 76.0, 77.0, 125.0, 76.0], "value": 83.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 115.0, 84.0, 84.0, 84.0, 119.0, 92.0, 82.0, 118.0], "value": 94.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 146.0, 147.0, 148.0, 146.0, 147.0, 146.0, 147.0, 146.0], "value": 146.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 94.0, 94.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 67.0, 67.0, 66.0, 75.0, 67.0, 67.0, 68.0, 67.0, 66.0], "value": 67.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 68.0, 66.0, 66.0, 66.0, 68.0, 66.0, 68.0, 67.0, 67.0], "value": 66.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 83.0, 83.0, 84.0, 83.0, 83.0, 82.0, 82.0, 83.0], "value": 83.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 154.0, 140.0, 139.0, 145.0, 137.0, 138.0, 138.0, 196.0, 146.0], "value": 147.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 176.0, 173.0, 174.0, 173.0, 173.0, 174.0, 175.0, 176.0, 178.0], "value": 174.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 75.0, 71.0, 69.0, 70.0, 70.0, 69.0, 70.0, 69.0, 68.0], "value": 70.4, "unit": "score"}], "name": "kraken", "value": 1563.3, "alertThreshold": 2.0}]} 04:50:43 INFO - Return code: 0 04:50:43 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:50:43 INFO - # TBPL SUCCESS # 04:50:43 INFO - Running post-action listener: _resource_record_post_action 04:50:43 INFO - [mozharness: 2016-10-12 11:50:43.975314Z] Finished run-tests step (success) 04:50:43 INFO - Running post-run listener: _resource_record_post_run 04:50:44 INFO - Total resource usage - Wall time: 1205s; CPU: 13.0%; Read bytes: 4096; Write bytes: 390385664; Read time: 12; Write time: 253412 04:50:44 INFO - TinderboxPrint: CPU usage
13.1% 04:50:44 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 04:50:44 INFO - TinderboxPrint: I/O write bytes / time
390,385,664 / 253,412 04:50:44 INFO - TinderboxPrint: CPU idle
8,357.5 (86.9%) 04:50:44 INFO - TinderboxPrint: CPU user
1,207.5 (12.6%) 04:50:44 INFO - TinderboxPrint: Swap in / out
0 / 0 04:50:44 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 99266560; Read time: 0; Write time: 55644 04:50:44 INFO - run-tests - Wall time: 1189s; CPU: 13.0%; Read bytes: 0; Write bytes: 291119104; Read time: 0; Write time: 197768 04:50:44 INFO - Running post-run listener: _upload_blobber_files 04:50:44 INFO - Blob upload gear active. 04:50:44 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:50:44 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 04:50:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:50:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:50:45 INFO - (blobuploader) - INFO - Open directory for files ... 04:50:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:50:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:50:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:50:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:50:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:50:45 INFO - (blobuploader) - INFO - Done attempting. 04:50:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:50:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:50:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:50:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:50:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:50:46 INFO - (blobuploader) - INFO - Done attempting. 04:50:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:50:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:50:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:50:50 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:50:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:50:50 INFO - (blobuploader) - INFO - Done attempting. 04:50:50 INFO - (blobuploader) - INFO - Iteration through files over. 04:50:50 INFO - Return code: 0 04:50:50 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:50:50 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:50:50 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3467b4f507d0396e3481b29a8b71983416d3e8c713955fefc61878191747ebe095851326feee8e806e649a6b31a27a0af477e4c9a6eb617d8b12485391b10991", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6ecc51748c8afb5f9f25caee1cee670da860221390dbaad8b09afc871a026daf81769e3588d641cdfc2ca57031c0f56630be0273c13fcadb6e73a9735661fc71", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0aa8a9e9971f59c395b6e0034bdd36751f1577b513a9ea35d2935005f4cbf3fb488be7ab552976c15022e797371522ee9ffdd97282adf3ed440ecb6d6081851e"} 04:50:50 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:50:50 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:50:50 INFO - Contents: 04:50:50 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3467b4f507d0396e3481b29a8b71983416d3e8c713955fefc61878191747ebe095851326feee8e806e649a6b31a27a0af477e4c9a6eb617d8b12485391b10991", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6ecc51748c8afb5f9f25caee1cee670da860221390dbaad8b09afc871a026daf81769e3588d641cdfc2ca57031c0f56630be0273c13fcadb6e73a9735661fc71", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0aa8a9e9971f59c395b6e0034bdd36751f1577b513a9ea35d2935005f4cbf3fb488be7ab552976c15022e797371522ee9ffdd97282adf3ed440ecb6d6081851e"} 04:50:50 INFO - Running post-run listener: copy_logs_to_upload_dir 04:50:50 INFO - Copying logs to upload dir... 04:50:50 INFO - mkdir: /builds/slave/test/build/upload/logs 04:50:50 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.738603 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-10-12 04:50:49.665891) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-12 04:50:49.669092) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1476271799.191629-1009675222 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3467b4f507d0396e3481b29a8b71983416d3e8c713955fefc61878191747ebe095851326feee8e806e649a6b31a27a0af477e4c9a6eb617d8b12485391b10991", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6ecc51748c8afb5f9f25caee1cee670da860221390dbaad8b09afc871a026daf81769e3588d641cdfc2ca57031c0f56630be0273c13fcadb6e73a9735661fc71", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0aa8a9e9971f59c395b6e0034bdd36751f1577b513a9ea35d2935005f4cbf3fb488be7ab552976c15022e797371522ee9ffdd97282adf3ed440ecb6d6081851e"} build_url:https://queue.taskcluster.net/v1/task/KH-T8TvTT12rvCGfGBb32g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011389 build_url: 'https://queue.taskcluster.net/v1/task/KH-T8TvTT12rvCGfGBb32g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3467b4f507d0396e3481b29a8b71983416d3e8c713955fefc61878191747ebe095851326feee8e806e649a6b31a27a0af477e4c9a6eb617d8b12485391b10991", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6ecc51748c8afb5f9f25caee1cee670da860221390dbaad8b09afc871a026daf81769e3588d641cdfc2ca57031c0f56630be0273c13fcadb6e73a9735661fc71", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0aa8a9e9971f59c395b6e0034bdd36751f1577b513a9ea35d2935005f4cbf3fb488be7ab552976c15022e797371522ee9ffdd97282adf3ed440ecb6d6081851e"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-12 04:50:49.694233) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-12 04:50:49.694529) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1476271799.191629-1009675222 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004674 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-12 04:50:49.745898) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-12 04:50:49.746224) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-12 04:50:49.746503) ========= ========= Total master_lag: 0.14 =========