builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-042 starttime: 1476895667.47 results: success (0) buildid: 20161019080123 builduid: 6daa10e34df8480fbb36fa797353b9f7 revision: 2e74103df7d22aace4daa0dee2684e9fb79caaef ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-19 09:47:47.471074) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-19 09:47:47.471548) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-19 09:47:47.471831) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-19 09:47:47.486630) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-19 09:47:47.486993) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1476895667.609550-1496114129 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-19 09:47:48-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.5M=0s 2016-10-19 09:47:48 (43.5 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.082705 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-19 09:47:47.584116) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-19 09:47:47.584442) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1476895667.609550-1496114129 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016615 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-19 09:47:47.634060) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-19 09:47:47.634425) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 2e74103df7d22aace4daa0dee2684e9fb79caaef --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 2e74103df7d22aace4daa0dee2684e9fb79caaef --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=74d6aec007b0fa31a864ebd7000001f8-1476895667.609550-1496114129 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-19 09:47:48,471 truncating revision to first 12 chars 2016-10-19 09:47:48,471 Setting DEBUG logging. 2016-10-19 09:47:48,472 attempt 1/10 2016-10-19 09:47:48,472 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/2e74103df7d2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-19 09:47:49,287 unpacking tar archive at: mozilla-central-2e74103df7d2/testing/mozharness/ program finished with exit code 0 elapsedTime=1.209595 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-19 09:47:48.857241) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-19 09:47:48.857565) ========= script_repo_revision: 2e74103df7d22aace4daa0dee2684e9fb79caaef ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-19 09:47:48.857954) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-19 09:47:48.858241) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-19 09:47:48.867465) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-10-19 09:47:48.867734) ========= /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=74d6aec007b0fa31a864ebd7000001f8-1476895667.609550-1496114129 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:47:49 INFO - MultiFileLogger online at 20161019 09:47:49 in /builds/slave/test 09:47:49 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 09:47:49 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:47:49 INFO - {'append_to_log': False, 09:47:49 INFO - 'base_work_dir': '/builds/slave/test', 09:47:49 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 09:47:49 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:47:49 INFO - 'branch': 'Firefox-Non-PGO', 09:47:49 INFO - 'buildbot_json_path': 'buildprops.json', 09:47:49 INFO - 'config_files': ('talos/linux_config.py',), 09:47:49 INFO - 'default_actions': ('clobber', 09:47:49 INFO - 'read-buildbot-config', 09:47:49 INFO - 'download-and-extract', 09:47:49 INFO - 'populate-webroot', 09:47:49 INFO - 'create-virtualenv', 09:47:49 INFO - 'install', 09:47:49 INFO - 'run-tests'), 09:47:49 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:47:49 INFO - 'download_minidump_stackwalk': True, 09:47:49 INFO - 'download_symbols': 'ondemand', 09:47:49 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:47:49 INFO - 'tooltool.py': '/tools/tooltool.py', 09:47:49 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:47:49 INFO - '/tools/misc-python/virtualenv.py')}, 09:47:49 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:47:49 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:47:49 INFO - 'installer_path': 'installer.exe', 09:47:49 INFO - 'log_level': 'info', 09:47:49 INFO - 'log_name': 'talos', 09:47:49 INFO - 'log_to_console': True, 09:47:49 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:47:49 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:47:49 INFO - 'opt_config_files': (), 09:47:49 INFO - 'pip_index': False, 09:47:49 INFO - 'sps_profile': False, 09:47:49 INFO - 'sps_profile_interval': 0, 09:47:49 INFO - 'suite': 'dromaeojs', 09:47:49 INFO - 'system_bits': '32', 09:47:49 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:47:49 INFO - 'title': 'talos-linux64-ix-042', 09:47:49 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:47:49 INFO - 'use_talos_json': True, 09:47:49 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:47:49 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:47:49 INFO - 'work_dir': 'build'} 09:47:49 INFO - [mozharness: 2016-10-19 16:47:49.808321Z] Running clobber step. 09:47:49 INFO - Running pre-action listener: _resource_record_pre_action 09:47:49 INFO - Running main action method: clobber 09:47:49 INFO - rmtree: /builds/slave/test/build 09:47:49 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:47:50 INFO - Running post-action listener: _resource_record_post_action 09:47:50 INFO - [mozharness: 2016-10-19 16:47:50.785810Z] Finished clobber step (success) 09:47:50 INFO - [mozharness: 2016-10-19 16:47:50.785910Z] Running read-buildbot-config step. 09:47:50 INFO - Running pre-action listener: _resource_record_pre_action 09:47:50 INFO - Running main action method: read_buildbot_config 09:47:50 INFO - Using buildbot properties: 09:47:50 INFO - { 09:47:50 INFO - "project": "", 09:47:50 INFO - "product": "firefox", 09:47:50 INFO - "script_repo_revision": "production", 09:47:50 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 09:47:50 INFO - "repository": "", 09:47:50 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 09:47:50 INFO - "buildid": "20161019080123", 09:47:50 INFO - "pgo_build": "False", 09:47:50 INFO - "basedir": "/builds/slave/test", 09:47:50 INFO - "buildnumber": 261, 09:47:50 INFO - "slavename": "talos-linux64-ix-042", 09:47:50 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 09:47:50 INFO - "platform": "ubuntu64_hw", 09:47:50 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 09:47:50 INFO - "branch": "mozilla-central", 09:47:50 INFO - "repo_path": "mozilla-central", 09:47:50 INFO - "revision": "2e74103df7d22aace4daa0dee2684e9fb79caaef", 09:47:50 INFO - "stage_platform": "linux64", 09:47:50 INFO - "builduid": "6daa10e34df8480fbb36fa797353b9f7", 09:47:50 INFO - "slavebuilddir": "test" 09:47:50 INFO - } 09:47:50 INFO - Found installer url https://queue.taskcluster.net/v1/task/En5USTLdR6i7ropWeaTD3g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 09:47:50 INFO - Running post-action listener: _resource_record_post_action 09:47:50 INFO - [mozharness: 2016-10-19 16:47:50.788375Z] Finished read-buildbot-config step (success) 09:47:50 INFO - [mozharness: 2016-10-19 16:47:50.788463Z] Running download-and-extract step. 09:47:50 INFO - Running pre-action listener: _resource_record_pre_action 09:47:50 INFO - Running main action method: download_and_extract 09:47:50 INFO - mkdir: /builds/slave/test/build/tests 09:47:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:47:50 INFO - trying https://queue.taskcluster.net/v1/task/En5USTLdR6i7ropWeaTD3g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 09:47:50 INFO - Downloading https://queue.taskcluster.net/v1/task/En5USTLdR6i7ropWeaTD3g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 09:47:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/En5USTLdR6i7ropWeaTD3g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 09:47:51 INFO - Downloaded 1361 bytes. 09:47:51 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 09:47:51 INFO - Using the following test package requirements: 09:47:51 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 09:47:51 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:47:51 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:47:51 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:47:51 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 09:47:51 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:47:51 INFO - u'jsshell-linux-x86_64.zip'], 09:47:51 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:47:51 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:47:51 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 09:47:51 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:47:51 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:47:51 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:47:51 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:47:51 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:47:51 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:47:51 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:47:51 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:47:51 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:47:51 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/En5USTLdR6i7ropWeaTD3g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 09:47:51 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/En5USTLdR6i7ropWeaTD3g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:47:51 INFO - Fetch https://queue.taskcluster.net/v1/task/En5USTLdR6i7ropWeaTD3g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 09:47:51 INFO - Http code: 200 09:47:51 INFO - via: 1.1 9baadab4e4d95afe7af7bcba342b29c6.cloudfront.net (CloudFront) 09:47:51 INFO - x-amz-cf-id: wSFhpoedCBIat6GOm2DY1kFe22ORSfv1JN_pHes8f1ry4cuIqb4WUw== 09:47:51 INFO - x-amz-version-id: VMICheNiJN46nKPCt12Ygg2Bven7YXI1 09:47:52 INFO - Expected file size: 20541625 09:47:52 INFO - Obtained file size: 20541625 09:47:56 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 09:47:56 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/En5USTLdR6i7ropWeaTD3g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 09:47:56 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/En5USTLdR6i7ropWeaTD3g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:47:56 INFO - Fetch https://queue.taskcluster.net/v1/task/En5USTLdR6i7ropWeaTD3g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 09:47:56 INFO - Http code: 200 09:47:56 INFO - via: 1.1 8008015354a3ca72f56c382a1d1cfe9f.cloudfront.net (CloudFront) 09:47:56 INFO - x-amz-cf-id: 8VQsfwbgT1MLBf12pPoHx2YgB4PXdFScgtHPb2-0myx6sBMavIVaZg== 09:47:56 INFO - x-amz-version-id: VMICheNiJN46nKPCt12Ygg2Bven7YXI1 09:47:57 INFO - Expected file size: 20541625 09:47:57 INFO - Obtained file size: 20541625 09:48:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/En5USTLdR6i7ropWeaTD3g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 09:48:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/En5USTLdR6i7ropWeaTD3g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 09:48:01 INFO - Fetch https://queue.taskcluster.net/v1/task/En5USTLdR6i7ropWeaTD3g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 09:48:02 INFO - Http code: 200 09:48:02 INFO - via: 1.1 76bce8bb4fbd102fc0b3aa2e41094b79.cloudfront.net (CloudFront) 09:48:02 INFO - x-amz-cf-id: sBIATgZRQ2e6eV3FzGF9uA4QnQRHrg0iIKC0OqdWjjpBbgWNRRSUPg== 09:48:02 INFO - x-amz-version-id: OqaeovYkdIop7wmBwzQ.skNOwYEyATBs 09:48:02 INFO - Expected file size: 14409028 09:48:02 INFO - Obtained file size: 14409028 09:48:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:48:02 INFO - trying https://queue.taskcluster.net/v1/task/En5USTLdR6i7ropWeaTD3g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 09:48:02 INFO - Downloading https://queue.taskcluster.net/v1/task/En5USTLdR6i7ropWeaTD3g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 09:48:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/En5USTLdR6i7ropWeaTD3g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 09:48:03 INFO - Downloaded 55599672 bytes. 09:48:03 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/En5USTLdR6i7ropWeaTD3g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 09:48:03 INFO - mkdir: /builds/slave/test/properties 09:48:03 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:48:03 INFO - Writing to file /builds/slave/test/properties/build_url 09:48:03 INFO - Contents: 09:48:03 INFO - build_url:https://queue.taskcluster.net/v1/task/En5USTLdR6i7ropWeaTD3g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 09:48:04 INFO - Running post-action listener: _resource_record_post_action 09:48:04 INFO - Running post-action listener: set_extra_try_arguments 09:48:04 INFO - [mozharness: 2016-10-19 16:48:04.396595Z] Finished download-and-extract step (success) 09:48:04 INFO - [mozharness: 2016-10-19 16:48:04.396821Z] Running populate-webroot step. 09:48:04 INFO - Running pre-action listener: _resource_record_pre_action 09:48:04 INFO - Running main action method: populate_webroot 09:48:04 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:48:04 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:48:04 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:48:04 INFO - '--tppagecycles', 09:48:04 INFO - '7'], 09:48:04 INFO - 'tests': ['tsvgm']}}, 09:48:04 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:48:04 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:48:04 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:48:04 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:48:04 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:48:04 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:48:04 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:48:04 INFO - 'talos_options': ['--disable-e10s'], 09:48:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:48:04 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:48:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:48:04 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:48:04 INFO - 'talos_options': ['--disable-e10s'], 09:48:04 INFO - 'tests': ['damp', 'tps']}, 09:48:04 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:48:04 INFO - 'tests': ['damp', 'tps']}, 09:48:04 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:48:04 INFO - 'tests': ['dromaeo_dom']}, 09:48:04 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:48:04 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:48:04 INFO - 'tests': ['basic_compositor_video']}, 09:48:04 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:48:04 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:48:04 INFO - 'tests': ['a11yr', 09:48:04 INFO - 'ts_paint', 09:48:04 INFO - 'tpaint', 09:48:04 INFO - 'sessionrestore', 09:48:04 INFO - 'sessionrestore_no_auto_restore', 09:48:04 INFO - 'tabpaint']}, 09:48:04 INFO - 'other-e10s': {'tests': ['a11yr', 09:48:04 INFO - 'ts_paint', 09:48:04 INFO - 'tpaint', 09:48:04 INFO - 'sessionrestore', 09:48:04 INFO - 'sessionrestore_no_auto_restore', 09:48:04 INFO - 'tabpaint']}, 09:48:04 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:48:04 INFO - 'ts_paint', 09:48:04 INFO - 'tpaint', 09:48:04 INFO - 'sessionrestore', 09:48:04 INFO - 'sessionrestore_no_auto_restore', 09:48:04 INFO - 'tabpaint']}, 09:48:04 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:48:04 INFO - 'ts_paint', 09:48:04 INFO - 'tpaint', 09:48:04 INFO - 'sessionrestore', 09:48:04 INFO - 'sessionrestore_no_auto_restore', 09:48:04 INFO - 'tabpaint']}, 09:48:04 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:48:04 INFO - 'tests': ['a11yr', 09:48:04 INFO - 'ts_paint', 09:48:04 INFO - 'tpaint', 09:48:04 INFO - 'sessionrestore', 09:48:04 INFO - 'sessionrestore_no_auto_restore', 09:48:04 INFO - 'tabpaint']}, 09:48:04 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:48:04 INFO - 'tests': ['a11yr', 09:48:04 INFO - 'ts_paint', 09:48:04 INFO - 'tpaint', 09:48:04 INFO - 'sessionrestore', 09:48:04 INFO - 'sessionrestore_no_auto_restore', 09:48:04 INFO - 'tabpaint']}, 09:48:04 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:48:04 INFO - 'tests': ['tsvgx', 09:48:04 INFO - 'tsvgr_opacity', 09:48:04 INFO - 'tart', 09:48:04 INFO - 'tscrollx', 09:48:04 INFO - 'cart']}, 09:48:04 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:48:04 INFO - 'tsvgr_opacity', 09:48:04 INFO - 'tart', 09:48:04 INFO - 'tscrollx', 09:48:04 INFO - 'cart']}, 09:48:04 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:48:04 INFO - 'talos_options': ['--disable-e10s'], 09:48:04 INFO - 'tests': ['tp5o']}, 09:48:04 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:48:04 INFO - 'tests': ['tp5o']}, 09:48:04 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:48:04 INFO - 'talos_options': ['--disable-e10s', 09:48:04 INFO - '--xperf_path', 09:48:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:48:04 INFO - 'tests': ['tp5n']}, 09:48:04 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:48:04 INFO - 'talos_options': ['--xperf_path', 09:48:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:48:04 INFO - 'tests': ['tp5n']}}, 09:48:04 INFO - 'talos.zip': {'path': '', 09:48:04 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:48:04 INFO - Running post-action listener: _resource_record_post_action 09:48:04 INFO - [mozharness: 2016-10-19 16:48:04.416901Z] Finished populate-webroot step (success) 09:48:04 INFO - [mozharness: 2016-10-19 16:48:04.416989Z] Running create-virtualenv step. 09:48:04 INFO - Running pre-action listener: _resource_record_pre_action 09:48:04 INFO - Running main action method: create_virtualenv 09:48:04 INFO - Creating virtualenv /builds/slave/test/build/venv 09:48:04 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 09:48:04 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:48:04 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:48:04 INFO - Using real prefix '/usr' 09:48:04 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:48:05 INFO - Installing distribute.............................................................................................................................................................................................done. 09:48:06 INFO - Installing pip.................done. 09:48:07 INFO - Return code: 0 09:48:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:48:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:48:07 INFO - Reading from file tmpfile_stdout 09:48:07 INFO - Output received: 09:48:07 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 09:48:07 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:48:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:48:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:48:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:48:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:48:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f957349bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bde8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cabca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ca8f60>, '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 0x1ca9d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1caa1d0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1476895667.609550-1496114129', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:48:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 09:48:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:48:07 INFO - Using env: {'DISPLAY': ':0', 09:48:07 INFO - 'HOME': '/home/cltbld', 09:48:07 INFO - 'LANG': 'en_US.UTF-8', 09:48:07 INFO - 'LANGUAGE': 'en_US:en', 09:48:07 INFO - 'LOGNAME': 'cltbld', 09:48:07 INFO - 'MAIL': '/var/mail/cltbld', 09:48:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:48:07 INFO - 'MOZ_NO_REMOTE': '1', 09:48:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:48:07 INFO - 'NO_EM_RESTART': '1', 09:48:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:48:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:48:07 INFO - 'PWD': '/builds/slave/test', 09:48:07 INFO - 'SHELL': '/bin/bash', 09:48:07 INFO - 'SHLVL': '1', 09:48:07 INFO - 'TERM': 'linux', 09:48:07 INFO - 'TMOUT': '86400', 09:48:07 INFO - 'USER': 'cltbld', 09:48:07 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1476895667.609550-1496114129', 09:48:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:48:07 INFO - '_': '/tools/buildbot/bin/python'} 09:48:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:48:07 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 09:48:07 INFO - Cleaning up... 09:48:07 INFO - Return code: 0 09:48:07 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:48:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:48:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:48:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:48:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:48:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f957349bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bde8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cabca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ca8f60>, '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 0x1ca9d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1caa1d0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1476895667.609550-1496114129', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:48:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 09:48:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 09:48:07 INFO - Using env: {'DISPLAY': ':0', 09:48:07 INFO - 'HOME': '/home/cltbld', 09:48:07 INFO - 'LANG': 'en_US.UTF-8', 09:48:07 INFO - 'LANGUAGE': 'en_US:en', 09:48:07 INFO - 'LOGNAME': 'cltbld', 09:48:07 INFO - 'MAIL': '/var/mail/cltbld', 09:48:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:48:07 INFO - 'MOZ_NO_REMOTE': '1', 09:48:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:48:07 INFO - 'NO_EM_RESTART': '1', 09:48:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:48:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:48:07 INFO - 'PWD': '/builds/slave/test', 09:48:07 INFO - 'SHELL': '/bin/bash', 09:48:07 INFO - 'SHLVL': '1', 09:48:07 INFO - 'TERM': 'linux', 09:48:07 INFO - 'TMOUT': '86400', 09:48:07 INFO - 'USER': 'cltbld', 09:48:07 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1476895667.609550-1496114129', 09:48:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:48:07 INFO - '_': '/tools/buildbot/bin/python'} 09:48:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:48:07 INFO - Downloading/unpacking psutil>=3.1.1 09:48:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:48:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:48:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:48:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:48:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:48:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:48:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:48:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:48:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:48:09 INFO - Installing collected packages: psutil 09:48:09 INFO - Running setup.py install for psutil 09:48:09 INFO - building 'psutil._psutil_linux' extension 09:48:09 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 09:48:09 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 09:48:09 INFO - building 'psutil._psutil_posix' extension 09:48:09 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 09:48:10 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 09:48:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:48:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:48:10 INFO - Successfully installed psutil 09:48:10 INFO - Cleaning up... 09:48:10 INFO - Return code: 0 09:48:10 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:48:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:48:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:48:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:48:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:48:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f957349bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bde8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cabca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ca8f60>, '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 0x1ca9d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1caa1d0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1476895667.609550-1496114129', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:48:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 09:48:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 09:48:10 INFO - Using env: {'DISPLAY': ':0', 09:48:10 INFO - 'HOME': '/home/cltbld', 09:48:10 INFO - 'LANG': 'en_US.UTF-8', 09:48:10 INFO - 'LANGUAGE': 'en_US:en', 09:48:10 INFO - 'LOGNAME': 'cltbld', 09:48:10 INFO - 'MAIL': '/var/mail/cltbld', 09:48:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:48:10 INFO - 'MOZ_NO_REMOTE': '1', 09:48:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:48:10 INFO - 'NO_EM_RESTART': '1', 09:48:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:48:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:48:10 INFO - 'PWD': '/builds/slave/test', 09:48:10 INFO - 'SHELL': '/bin/bash', 09:48:10 INFO - 'SHLVL': '1', 09:48:10 INFO - 'TERM': 'linux', 09:48:10 INFO - 'TMOUT': '86400', 09:48:10 INFO - 'USER': 'cltbld', 09:48:10 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1476895667.609550-1496114129', 09:48:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:48:10 INFO - '_': '/tools/buildbot/bin/python'} 09:48:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:48:10 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:48:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:48:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:48:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:48:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:48:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:48:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:48:12 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:48:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:48:12 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:48:12 INFO - Installing collected packages: mozsystemmonitor 09:48:12 INFO - Running setup.py install for mozsystemmonitor 09:48:12 INFO - Successfully installed mozsystemmonitor 09:48:12 INFO - Cleaning up... 09:48:12 INFO - Return code: 0 09:48:12 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:48:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:48:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:48:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:48:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:48:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f957349bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bde8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cabca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ca8f60>, '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 0x1ca9d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1caa1d0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1476895667.609550-1496114129', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:48:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 09:48:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 09:48:12 INFO - Using env: {'DISPLAY': ':0', 09:48:12 INFO - 'HOME': '/home/cltbld', 09:48:12 INFO - 'LANG': 'en_US.UTF-8', 09:48:12 INFO - 'LANGUAGE': 'en_US:en', 09:48:12 INFO - 'LOGNAME': 'cltbld', 09:48:12 INFO - 'MAIL': '/var/mail/cltbld', 09:48:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:48:12 INFO - 'MOZ_NO_REMOTE': '1', 09:48:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:48:12 INFO - 'NO_EM_RESTART': '1', 09:48:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:48:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:48:12 INFO - 'PWD': '/builds/slave/test', 09:48:12 INFO - 'SHELL': '/bin/bash', 09:48:12 INFO - 'SHLVL': '1', 09:48:12 INFO - 'TERM': 'linux', 09:48:12 INFO - 'TMOUT': '86400', 09:48:12 INFO - 'USER': 'cltbld', 09:48:12 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1476895667.609550-1496114129', 09:48:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:48:12 INFO - '_': '/tools/buildbot/bin/python'} 09:48:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:48:12 INFO - Downloading/unpacking jsonschema==2.5.1 09:48:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:48:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:48:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:48:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:48:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:48:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:48:14 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:48:14 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:48:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:48:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:48:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:48:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:48:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:48:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:48:14 INFO - Downloading functools32-3.2.3-2.tar.gz 09:48:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:48:15 INFO - warning: no files found matching '*.txt' 09:48:15 INFO - no previously-included directories found matching 'build' 09:48:15 INFO - no previously-included directories found matching 'dist' 09:48:15 INFO - no previously-included directories found matching '.git*' 09:48:15 INFO - Installing collected packages: jsonschema, functools32 09:48:15 INFO - Running setup.py install for functools32 09:48:15 INFO - warning: no files found matching '*.txt' 09:48:15 INFO - no previously-included directories found matching 'build' 09:48:15 INFO - no previously-included directories found matching 'dist' 09:48:15 INFO - no previously-included directories found matching '.git*' 09:48:15 INFO - Successfully installed jsonschema functools32 09:48:15 INFO - Cleaning up... 09:48:15 INFO - Return code: 0 09:48:15 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:48:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:48:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:48:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:48:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:48:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:15 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 0x7f957349bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bde8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cabca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ca8f60>, '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 0x1ca9d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1caa1d0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1476895667.609550-1496114129', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:48:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 09:48:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 09:48:15 INFO - Using env: {'DISPLAY': ':0', 09:48:15 INFO - 'HOME': '/home/cltbld', 09:48:15 INFO - 'LANG': 'en_US.UTF-8', 09:48:15 INFO - 'LANGUAGE': 'en_US:en', 09:48:15 INFO - 'LOGNAME': 'cltbld', 09:48:15 INFO - 'MAIL': '/var/mail/cltbld', 09:48:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:48:15 INFO - 'MOZ_NO_REMOTE': '1', 09:48:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:48:15 INFO - 'NO_EM_RESTART': '1', 09:48:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:48:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:48:15 INFO - 'PWD': '/builds/slave/test', 09:48:15 INFO - 'SHELL': '/bin/bash', 09:48:15 INFO - 'SHLVL': '1', 09:48:15 INFO - 'TERM': 'linux', 09:48:15 INFO - 'TMOUT': '86400', 09:48:15 INFO - 'USER': 'cltbld', 09:48:15 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1476895667.609550-1496114129', 09:48:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:48:15 INFO - '_': '/tools/buildbot/bin/python'} 09:48:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:48:15 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:48:15 INFO - Cleaning up... 09:48:15 INFO - Return code: 0 09:48:15 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:48:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:48:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:48:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:48:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:48:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:15 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 0x7f957349bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bde8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cabca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ca8f60>, '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 0x1ca9d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1caa1d0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1476895667.609550-1496114129', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:48:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:48:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:48:15 INFO - Using env: {'DISPLAY': ':0', 09:48:15 INFO - 'HOME': '/home/cltbld', 09:48:15 INFO - 'LANG': 'en_US.UTF-8', 09:48:15 INFO - 'LANGUAGE': 'en_US:en', 09:48:15 INFO - 'LOGNAME': 'cltbld', 09:48:15 INFO - 'MAIL': '/var/mail/cltbld', 09:48:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:48:15 INFO - 'MOZ_NO_REMOTE': '1', 09:48:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:48:15 INFO - 'NO_EM_RESTART': '1', 09:48:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:48:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:48:15 INFO - 'PWD': '/builds/slave/test', 09:48:15 INFO - 'SHELL': '/bin/bash', 09:48:15 INFO - 'SHLVL': '1', 09:48:15 INFO - 'TERM': 'linux', 09:48:15 INFO - 'TMOUT': '86400', 09:48:15 INFO - 'USER': 'cltbld', 09:48:15 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1476895667.609550-1496114129', 09:48:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:48:15 INFO - '_': '/tools/buildbot/bin/python'} 09:48:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:48:15 INFO - Downloading/unpacking blobuploader==1.2.4 09:48:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:48:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:48:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:48:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:48:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:48:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:48:17 INFO - Downloading blobuploader-1.2.4.tar.gz 09:48:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:48:17 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:48:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:48:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:48:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:48:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:48:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:48:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:48:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:48:18 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:48:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:48:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:48:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:48:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:48:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:48:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:48:18 INFO - Downloading docopt-0.6.1.tar.gz 09:48:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:48:18 INFO - Installing collected packages: blobuploader, requests, docopt 09:48:18 INFO - Running setup.py install for blobuploader 09:48:18 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:48:18 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:48:18 INFO - Running setup.py install for requests 09:48:18 INFO - Running setup.py install for docopt 09:48:18 INFO - Successfully installed blobuploader requests docopt 09:48:18 INFO - Cleaning up... 09:48:18 INFO - Return code: 0 09:48:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:48:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:48:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:48:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:48:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:48:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:18 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 0x7f957349bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bde8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cabca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ca8f60>, '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 0x1ca9d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1caa1d0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1476895667.609550-1496114129', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:48:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:48:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:48:18 INFO - Using env: {'DISPLAY': ':0', 09:48:18 INFO - 'HOME': '/home/cltbld', 09:48:18 INFO - 'LANG': 'en_US.UTF-8', 09:48:18 INFO - 'LANGUAGE': 'en_US:en', 09:48:18 INFO - 'LOGNAME': 'cltbld', 09:48:18 INFO - 'MAIL': '/var/mail/cltbld', 09:48:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:48:18 INFO - 'MOZ_NO_REMOTE': '1', 09:48:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:48:18 INFO - 'NO_EM_RESTART': '1', 09:48:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:48:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:48:18 INFO - 'PWD': '/builds/slave/test', 09:48:18 INFO - 'SHELL': '/bin/bash', 09:48:18 INFO - 'SHLVL': '1', 09:48:18 INFO - 'TERM': 'linux', 09:48:18 INFO - 'TMOUT': '86400', 09:48:18 INFO - 'USER': 'cltbld', 09:48:18 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1476895667.609550-1496114129', 09:48:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:48:18 INFO - '_': '/tools/buildbot/bin/python'} 09:48:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:48:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:48:19 INFO - Running setup.py (path:/tmp/pip-5b7zqP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:48:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:48:19 INFO - Running setup.py (path:/tmp/pip-CK34CO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:48:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:48:19 INFO - Running setup.py (path:/tmp/pip-FI8hq1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:48:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:48:19 INFO - Running setup.py (path:/tmp/pip-8_8kbZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:48:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:48:19 INFO - Running setup.py (path:/tmp/pip-RgP31q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:48:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:48:19 INFO - Running setup.py (path:/tmp/pip-uJ_koW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:48:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:48:19 INFO - Running setup.py (path:/tmp/pip-tBhrfL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:48:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:48:19 INFO - Running setup.py (path:/tmp/pip-1sQdb6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:48:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:48:19 INFO - Running setup.py (path:/tmp/pip-sH35SG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:48:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:48:19 INFO - Running setup.py (path:/tmp/pip-hKvplL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:48:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:48:19 INFO - Running setup.py (path:/tmp/pip-2Pkoal-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:48:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:48:19 INFO - Running setup.py (path:/tmp/pip-neA6Rq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:48:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:48:20 INFO - Running setup.py (path:/tmp/pip-FZjZQf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:48:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:48:20 INFO - Running setup.py (path:/tmp/pip-HEhSvD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:48:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:48:20 INFO - Running setup.py (path:/tmp/pip-sGsj6j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:48:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:48:20 INFO - Running setup.py (path:/tmp/pip-IBgR3G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:48:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:48:20 INFO - Running setup.py (path:/tmp/pip-d8PgP0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:48:20 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:48:20 INFO - Running setup.py install for manifestparser 09:48:20 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:48:20 INFO - Running setup.py install for mozcrash 09:48:20 INFO - Running setup.py install for mozdebug 09:48:20 INFO - Running setup.py install for mozdevice 09:48:20 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:48:20 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:48:20 INFO - Running setup.py install for mozfile 09:48:20 INFO - Running setup.py install for mozhttpd 09:48:21 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:48:21 INFO - Running setup.py install for mozinfo 09:48:21 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:48:21 INFO - Running setup.py install for mozInstall 09:48:21 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:48:21 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:48:21 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:48:21 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:48:21 INFO - Running setup.py install for mozleak 09:48:21 INFO - Running setup.py install for mozlog 09:48:21 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:48:21 INFO - Running setup.py install for moznetwork 09:48:21 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:48:21 INFO - Running setup.py install for mozprocess 09:48:21 INFO - Running setup.py install for mozprofile 09:48:21 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:48:21 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:48:21 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:48:21 INFO - Running setup.py install for mozrunner 09:48:21 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:48:21 INFO - Running setup.py install for mozscreenshot 09:48:21 INFO - Running setup.py install for moztest 09:48:22 INFO - Running setup.py install for mozversion 09:48:22 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:48:22 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:48:22 INFO - Cleaning up... 09:48:22 INFO - Return code: 0 09:48:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:48: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')]} 09:48:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:48:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48: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')]} 09:48:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:48:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:22 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 0x7f957349bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bde8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cabca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ca8f60>, '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 0x1ca9d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1caa1d0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1476895667.609550-1496114129', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:48:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:48:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:48:22 INFO - Using env: {'DISPLAY': ':0', 09:48:22 INFO - 'HOME': '/home/cltbld', 09:48:22 INFO - 'LANG': 'en_US.UTF-8', 09:48:22 INFO - 'LANGUAGE': 'en_US:en', 09:48:22 INFO - 'LOGNAME': 'cltbld', 09:48:22 INFO - 'MAIL': '/var/mail/cltbld', 09:48:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:48:22 INFO - 'MOZ_NO_REMOTE': '1', 09:48:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:48:22 INFO - 'NO_EM_RESTART': '1', 09:48:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:48:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:48:22 INFO - 'PWD': '/builds/slave/test', 09:48:22 INFO - 'SHELL': '/bin/bash', 09:48:22 INFO - 'SHLVL': '1', 09:48:22 INFO - 'TERM': 'linux', 09:48:22 INFO - 'TMOUT': '86400', 09:48:22 INFO - 'USER': 'cltbld', 09:48:22 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1476895667.609550-1496114129', 09:48:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:48:22 INFO - '_': '/tools/buildbot/bin/python'} 09:48:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:48:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:48:22 INFO - Running setup.py (path:/tmp/pip-yNfn7_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:48:22 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 09:48:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:48:22 INFO - Running setup.py (path:/tmp/pip-m04C6x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:48:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:48:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:48:22 INFO - Running setup.py (path:/tmp/pip-xgSTuj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:48:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:48:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:48:22 INFO - Running setup.py (path:/tmp/pip-BhwjaY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:48:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:48:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:48:22 INFO - Running setup.py (path:/tmp/pip-Ky6ynt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:48:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 09:48:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:48:22 INFO - Running setup.py (path:/tmp/pip-ObFTmT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:48:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 09:48:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:48:22 INFO - Running setup.py (path:/tmp/pip-fY9nYK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:48:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 09:48:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:48:22 INFO - Running setup.py (path:/tmp/pip-I34OXQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:48:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 09:48:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:48:23 INFO - Running setup.py (path:/tmp/pip-SJuF7a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:48:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 09:48:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:48:23 INFO - Running setup.py (path:/tmp/pip-LoFtA4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:48:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:48:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:48:23 INFO - Running setup.py (path:/tmp/pip-mVhDfL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:48:23 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 09:48:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:48:23 INFO - Running setup.py (path:/tmp/pip-srJHnb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:48:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 09:48:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:48:23 INFO - Running setup.py (path:/tmp/pip-Bsotoj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:48:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 09:48:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:48:23 INFO - Running setup.py (path:/tmp/pip-O6_JW6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:48:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 09:48:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:48:23 INFO - Running setup.py (path:/tmp/pip-3kK6D4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:48:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 09:48:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:48:23 INFO - Running setup.py (path:/tmp/pip-heWsRM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:48:23 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 09:48:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:48:23 INFO - Running setup.py (path:/tmp/pip-SjWc9F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:48:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 09:48:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:48:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:48:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:48:23 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:48:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:48:23 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:48:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:48:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:48:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:48:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:48:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:48:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:48:25 INFO - Downloading blessings-1.6.tar.gz 09:48:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:48:25 INFO - Installing collected packages: blessings 09:48:25 INFO - Running setup.py install for blessings 09:48:25 INFO - Successfully installed blessings 09:48:25 INFO - Cleaning up... 09:48:25 INFO - Return code: 0 09:48:25 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:48:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:48:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:48:26 INFO - Reading from file tmpfile_stdout 09:48:26 INFO - Current package versions: 09:48:26 INFO - argparse == 1.2.1 09:48:26 INFO - blessings == 1.6 09:48:26 INFO - blobuploader == 1.2.4 09:48:26 INFO - docopt == 0.6.1 09:48:26 INFO - functools32 == 3.2.3-2 09:48:26 INFO - jsonschema == 2.5.1 09:48:26 INFO - manifestparser == 1.1 09:48:26 INFO - mozInstall == 1.12 09:48:26 INFO - mozcrash == 0.17 09:48:26 INFO - mozdebug == 0.1 09:48:26 INFO - mozdevice == 0.48 09:48:26 INFO - mozfile == 1.2 09:48:26 INFO - mozhttpd == 0.7 09:48:26 INFO - mozinfo == 0.9 09:48:26 INFO - mozleak == 0.1 09:48:26 INFO - mozlog == 3.4 09:48:26 INFO - moznetwork == 0.27 09:48:26 INFO - mozprocess == 0.23 09:48:26 INFO - mozprofile == 0.28 09:48:26 INFO - mozrunner == 6.12 09:48:26 INFO - mozscreenshot == 0.1 09:48:26 INFO - mozsystemmonitor == 0.3 09:48:26 INFO - moztest == 0.7 09:48:26 INFO - mozversion == 1.4 09:48:26 INFO - psutil == 3.1.1 09:48:26 INFO - requests == 1.2.3 09:48:26 INFO - wsgiref == 0.1.2 09:48:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:48:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:48:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:48:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:48:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:48:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:26 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 0x7f957349bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bde8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cabca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ca8f60>, '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 0x1ca9d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1caa1d0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1476895667.609550-1496114129', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:48:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 09:48:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:48:26 INFO - Using env: {'DISPLAY': ':0', 09:48:26 INFO - 'HOME': '/home/cltbld', 09:48:26 INFO - 'LANG': 'en_US.UTF-8', 09:48:26 INFO - 'LANGUAGE': 'en_US:en', 09:48:26 INFO - 'LOGNAME': 'cltbld', 09:48:26 INFO - 'MAIL': '/var/mail/cltbld', 09:48:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:48:26 INFO - 'MOZ_NO_REMOTE': '1', 09:48:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:48:26 INFO - 'NO_EM_RESTART': '1', 09:48:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:48:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:48:26 INFO - 'PWD': '/builds/slave/test', 09:48:26 INFO - 'SHELL': '/bin/bash', 09:48:26 INFO - 'SHLVL': '1', 09:48:26 INFO - 'TERM': 'linux', 09:48:26 INFO - 'TMOUT': '86400', 09:48:26 INFO - 'USER': 'cltbld', 09:48:26 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1476895667.609550-1496114129', 09:48:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:48:26 INFO - '_': '/tools/buildbot/bin/python'} 09:48:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:48:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:48:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 09:48:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 09:48:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:48:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 09:48:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 09:48:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 09:48:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 09:48:26 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 09:48:26 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:48:26 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:48:26 INFO - Cleaning up... 09:48:26 INFO - Return code: 0 09:48:26 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:48:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:48:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:48:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:48:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:48:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:26 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 0x7f957349bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bde8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cabca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ca8f60>, '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 0x1ca9d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1caa1d0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1476895667.609550-1496114129', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:48:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:48:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:48:26 INFO - Using env: {'DISPLAY': ':0', 09:48:26 INFO - 'HOME': '/home/cltbld', 09:48:26 INFO - 'LANG': 'en_US.UTF-8', 09:48:26 INFO - 'LANGUAGE': 'en_US:en', 09:48:26 INFO - 'LOGNAME': 'cltbld', 09:48:26 INFO - 'MAIL': '/var/mail/cltbld', 09:48:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:48:26 INFO - 'MOZ_NO_REMOTE': '1', 09:48:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:48:26 INFO - 'NO_EM_RESTART': '1', 09:48:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:48:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:48:26 INFO - 'PWD': '/builds/slave/test', 09:48:26 INFO - 'SHELL': '/bin/bash', 09:48:26 INFO - 'SHLVL': '1', 09:48:26 INFO - 'TERM': 'linux', 09:48:26 INFO - 'TMOUT': '86400', 09:48:26 INFO - 'USER': 'cltbld', 09:48:26 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1476895667.609550-1496114129', 09:48:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:48:26 INFO - '_': '/tools/buildbot/bin/python'} 09:48:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:48:26 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:48:26 INFO - Cleaning up... 09:48:26 INFO - Return code: 0 09:48:26 INFO - Running post-action listener: _resource_record_post_action 09:48:26 INFO - Running post-action listener: _start_resource_monitoring 09:48:26 INFO - Starting resource monitoring. 09:48:26 INFO - [mozharness: 2016-10-19 16:48:26.589052Z] Finished create-virtualenv step (success) 09:48:26 INFO - [mozharness: 2016-10-19 16:48:26.589517Z] Running install step. 09:48:26 INFO - Running pre-action listener: _resource_record_pre_action 09:48:26 INFO - Running main action method: install 09:48:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:48:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:48:26 INFO - Reading from file tmpfile_stdout 09:48:26 INFO - Detecting whether we're running mozinstall >=1.0... 09:48:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:48:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:48:26 INFO - Reading from file tmpfile_stdout 09:48:26 INFO - Output received: 09:48:26 INFO - Usage: mozinstall [options] installer 09:48:26 INFO - Options: 09:48:26 INFO - -h, --help show this help message and exit 09:48:26 INFO - -d DEST, --destination=DEST 09:48:26 INFO - Directory to install application into. [default: 09:48:26 INFO - "/builds/slave/test"] 09:48:26 INFO - --app=APP Application being installed. [default: firefox] 09:48:26 INFO - mkdir: /builds/slave/test/build/application 09:48:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 09:48:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 09:48:42 INFO - Reading from file tmpfile_stdout 09:48:42 INFO - Output received: 09:48:42 INFO - /builds/slave/test/build/application/firefox/firefox 09:48:42 INFO - Running post-action listener: _resource_record_post_action 09:48:42 INFO - [mozharness: 2016-10-19 16:48:42.924652Z] Finished install step (success) 09:48:42 INFO - [mozharness: 2016-10-19 16:48:42.924895Z] Running run-tests step. 09:48:42 INFO - Running pre-action listener: _resource_record_pre_action 09:48:42 INFO - Running main action method: run_tests 09:48:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:48:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:48:42 INFO - Python 2.7.3 09:48:42 INFO - Return code: 0 09:48:42 INFO - grabbing minidump binary from tooltool 09:48:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:48:42 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 0x1ca8f60>, '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 0x1ca9d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1caa1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:48:42 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 09:48:42 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 09:48:42 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 09:48:42 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:48:43 INFO - Return code: 0 09:48:43 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:48:43 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:48:43 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:48:43 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:48:43 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:48:43 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/En5USTLdR6i7ropWeaTD3g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 09:48:43 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/En5USTLdR6i7ropWeaTD3g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-042 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 09:48:43 INFO - Using env: {'DISPLAY': ':0', 09:48:43 INFO - 'HOME': '/home/cltbld', 09:48:43 INFO - 'LANG': 'en_US.UTF-8', 09:48:43 INFO - 'LANGUAGE': 'en_US:en', 09:48:43 INFO - 'LOGNAME': 'cltbld', 09:48:43 INFO - 'MAIL': '/var/mail/cltbld', 09:48:43 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:48:43 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:48:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:48:43 INFO - 'MOZ_NO_REMOTE': '1', 09:48:43 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:48:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:48:43 INFO - 'NO_EM_RESTART': '1', 09:48:43 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:48:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:48:43 INFO - 'PWD': '/builds/slave/test', 09:48:43 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:48:43 INFO - 'SHELL': '/bin/bash', 09:48:43 INFO - 'SHLVL': '1', 09:48:43 INFO - 'TERM': 'linux', 09:48:43 INFO - 'TMOUT': '86400', 09:48:43 INFO - 'USER': 'cltbld', 09:48:43 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1476895667.609550-1496114129', 09:48:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:48:43 INFO - '_': '/tools/buildbot/bin/python'} 09:48:43 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/En5USTLdR6i7ropWeaTD3g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 09:48:43 INFO - mozversion application_buildid: 20161019080123 09:48:43 INFO - mozversion application_changeset: 2e74103df7d22aace4daa0dee2684e9fb79caaef 09:48:43 INFO - mozversion application_display_name: Nightly 09:48:43 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:48:43 INFO - mozversion application_name: Firefox 09:48:43 INFO - mozversion application_remotingname: firefox 09:48:43 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 09:48:43 INFO - mozversion application_vendor: Mozilla 09:48:43 INFO - mozversion application_version: 52.0a1 09:48:43 INFO - mozversion platform_buildid: 20161019080123 09:48:43 INFO - mozversion platform_changeset: 2e74103df7d22aace4daa0dee2684e9fb79caaef 09:48:43 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 09:48:43 INFO - mozversion platform_version: 52.0a1 09:48:43 INFO - using testdate: 1476895723 09:48:43 INFO - actual date: 1476895723 09:48:43 INFO - starting webserver on 'localhost:35378' 09:48:43 INFO - SUITE-START | Running 2 tests 09:48:43 INFO - TEST-START | dromaeo_css 09:48:43 INFO - operating with platform_type : linux_ 09:48:43 INFO - Initialising browser for dromaeo_css test... 09:48:43 INFO - TEST-INFO | started process 31143 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8Sx2Rj/profile http://localhost:35378/getInfo.html) 09:48:47 INFO - PROCESS | 31143 | __metrics Screen width/height:1600/1200 09:48:47 INFO - PROCESS | 31143 | colorDepth:24 09:48:47 INFO - PROCESS | 31143 | Browser inner width/height: 1024/697 09:48:47 INFO - PROCESS | 31143 | __metrics 09:48:47 INFO - PROCESS | 31143 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:48:47 INFO - PROCESS | 31143 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:48:48 INFO - PROCESS | 31143 | console.error: PushService: 09:48:48 INFO - PROCESS | 31143 | stateChangeProcessEnqueue: Error transitioning state 09:48:48 INFO - PROCESS | 31143 | UnknownError 09:48:49 INFO - TEST-INFO | 31143: exit 0 09:48:49 INFO - Browser initialized. 09:48:49 INFO - Running cycle 1/1 for dromaeo_css test... 09:48:49 INFO - TEST-INFO | started process 31224 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8Sx2Rj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:49:01 INFO - PROCESS | 31224 | RSS: Main: 173223936 09:49:01 INFO - PROCESS | 31224 | 09:49:52 INFO - PROCESS | 31224 | 1476895792557 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 09:52:06 INFO - PROCESS | 31224 | Cycle 1(1): loaded http://localhost:35378/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35378/tests/dromaeo/cssquery-ext.html) 09:52:08 INFO - PROCESS | 31224 | RSS: Main: 315117568 09:52:08 INFO - PROCESS | 31224 | 09:55:10 INFO - PROCESS | 31224 | Cycle 1(1): loaded http://localhost:35378/tests/dromaeo/cssquery-ext.html (next: http://localhost:35378/tests/dromaeo/cssquery-jquery.html) 09:55:11 INFO - PROCESS | 31224 | RSS: Main: 275464192 09:55:11 INFO - PROCESS | 31224 | 09:58:13 INFO - PROCESS | 31224 | Cycle 1(1): loaded http://localhost:35378/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35378/tests/dromaeo/cssquery-mootools.html) 09:58:14 INFO - PROCESS | 31224 | RSS: Main: 215506944 09:58:14 INFO - PROCESS | 31224 | 10:01:16 INFO - PROCESS | 31224 | Cycle 1(1): loaded http://localhost:35378/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35378/tests/dromaeo/cssquery-prototype.html) 10:01:17 INFO - PROCESS | 31224 | RSS: Main: 217407488 10:01:17 INFO - PROCESS | 31224 | 10:04:20 INFO - PROCESS | 31224 | Cycle 1(1): loaded http://localhost:35378/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35378/tests/dromaeo/cssquery-yui.html) 10:04:20 INFO - PROCESS | 31224 | RSS: Main: 216473600 10:04:20 INFO - PROCESS | 31224 | 10:07:23 INFO - PROCESS | 31224 | Cycle 1(1): loaded http://localhost:35378/tests/dromaeo/cssquery-yui.html (next: http://localhost:35378/tests/dromaeo/cssquery-dojo.html) 10:07:24 INFO - PROCESS | 31224 | RSS: Main: 308068352 10:07:24 INFO - PROCESS | 31224 | 10:07:24 INFO - PROCESS | 31224 | __start_tp_report 10:07:24 INFO - PROCESS | 31224 | _x_x_mozilla_page_load 10:07:24 INFO - PROCESS | 31224 | _x_x_mozilla_page_load_details 10:07:24 INFO - PROCESS | 31224 | |i|pagename|runs| 10:07:24 INFO - PROCESS | 31224 | |0;dojo.html;2593.8184327097097;2616.4897844920247;2638.3799807045343;2654;2668.159529748129;4540.455145382559;4606.677532572721;4623.1216068946915;4645.279981602853;4663.650226233038;4581.541845815417;4622.791974361154;4636.629069674426;4660.137874493221;4706.129366067272;4248.129133527619;4283.635890949266;4296.656267498608;4305.504866940295;4306.2464068787995;4264.573542645726;4314.697971142022;4344.97827510862;4387.363832244323;4410.536893626171;4340.045190058198;4344.97827510862;4356.956430435686;4387.078713470175;4415.80128894199;4150.813213405404;4211.852585159505;4221.430106935555;4259.936100958488;4281.05816720321;4257.042165512766;4261.74429534229;4262.509811371701;4264.466941632296;4270.487541495009;4584.518625544337;4623.8150473981;4634.189016922025;4643.535646435364;4655.767211639404;4915.778789954425;4945.455999840015;4957.3059771632;5005.374328208974;5066.544011039025;5015.598752099823;5040.218766091261;5049;5051.797928082872;5104.948950510522;4515.796789144496;4561.635069194523;4659.138059458943;4660.1145782301255;4715.78778954941;5101.056304583664;5141.742912854343;5142.202958541432;5146.845594632167;5207.3230480037355;4920.40955085392;4928.802847886044;4931.3835770528685;4933.481984391659;4991.126552853236;4818.132736107465;4859.416869975555;4863.416390033148;4966.677165984272;4980.228064649985;4970.925436118461;5002.849914502571;5006.249062640633;5009.273655319958;5013.448520662724;4912.140375434285;4918.631102667243;4924.433690125681;4939.53074457926;5002.424721157041;4126.09225970286;4135.338345864648;4136.358864376027;4139.958600414017;4189.455370801777;3578.141246100917;3601.3517566838223;3603.9728677326834;3610.1696609779374;3643.85424583019;4288.871333859989;4293.592108749664;4337.587929146789;4349.804258808361;4352.673549483801;4932.630052746058;4936.456989731127;4945.530174633404;4947.158982972904;5006.6245031622775;4265.76538290397;4271.231178387858;4279.529251782302;4319.632831209319;4334.1981733379425;4432.202203603382;4449.888752781141;4453.131639330364;4484.798184081724;4491.416115904977;4782.928256076231;4807.182778927521;4810;4811.975940120277;4851.854444366604;4870.439899411613;4915.803367865388;5047.116754568009;5069.112905241494;5119.334486516729;4699.201135806853;4711.528847115261;4730.172219861442;4745.715257084586;4796.640251981185;4930.9506904930495;4931.4328852181025;4935.309056731989;4937.35814344133;4991.026749783758;4998.300237966615;5005.149124648746;5007.424146223086;5008.398992120969;5062.139436295912;4726.787294571684;4762.476127626028;4768.976155119202;4834.540718631724;4914;4807.6394270429155;4851.393575803025;4855.684380515255;4862.440819305825;4866.80532778699;4731.195696731495;4787.593054590259;4790.113828941657;4795.424549054136;4796.2805579162;4881.682690625098;4906.754662266801;4916.385451818523;4928.408590969107;4958.677685950402;4789.401324834395;4793.352897358812;4796.760161991956;4801.927971080507;4846.95153048465 10:07:24 INFO - PROCESS | 31224 | |1;ext.html;548.4131978782702;583.4253260538369;584.739790793097;593.5400064949661;595.6336852835504;34966.650333496655;38911.221775564474;39011;39070.218595628074;39174.41238381423;38948.22103557927;39388.40917386241;39415.80292098543;39420.80289598555;39468.407973880414;7443.776686699408;7633.274838890325;7642.235776422341;7658.349040331578;7659.770206893774;7593.278638529331;7674.232576742309;7674.808129796772;7678.347340476066;7683.923160768377;7708.30625243728;7739.458237923348;7740.922590774105;7742.651580678855;7744.883826742575;7645.311921927026;7676.616169191518;7681.615919204018;7688.38492920565;7690.269424404701;7517.135529414078;7575.924240757577;7583.582902940336;7587.582682952436;7590.430717696195;35134.472982905274;35439;35565.82217088898;35568.28863422743;35569.82215088934;2664.653595032653;2748.2579703480146;2823.5341168707137;2844.4737723521007;2846.5445528715304;27390.8239346188;27480.862595686893;27532.72467275342;27975.160745177473;28206;3198.1524895902603;3309.4373956427225;3385.932281354359;3481.617022127564;3513.8067406292644;248231;250622;251409;252952;253329.99999999817;53175.20237196445;54077.72961135248;54116.72941635267;54381.45618543843;54395.72802135964;31430.21424464361;32872.50691239633;32944.17639558982;34920;34929;13541.45834166642;13698;13698.863011369958;13703.657408564866;13712.93143534276;10234.48827558619;10352.378857268588;10359.22305827066;10360.792784144274;10363.481825908675;17448.69134814894;17451.30194792194;17472.737908931376;17479.737803932952;17520.29918803259;6670.466362691071;6796.218434879953;6858.211305699809;6860.0791778302155;7127.251638577978;747.872861613527;779.5400713578903;809.6032943857585;880.665347168072;958.3483231402713;26355;27805;27814.582781258297;27961.72038279632;28501;954.3891909178132;979.750163708264;1029.7888932768765;1041.8014109593228;1045.534737042009;13585.252811095485;14546.636334091732;14791.334389952262;15106.244687765568;15121.16833574164;373456;376765;377837;378134;379222;49443.75278123586;49772.50227497751;50146.749266253435;50280.497195028314;50281.49718502768;1123.3540714089431;1156.502703837358;1161.9419029048684;1164.5341863254596;1175.984426421331;25321.87339063293;26671.599926000737;26763.33091672724;27033;27507.862460687567;43122.353164703185;43992.78003609961;44025.55974440215;44042.559574403844;44189.33715994327;333997;334760;335391;335782;335841;35770.10574735652;37365.4395184067;37882.24235515219;37944;37972.430413544374;38664.6133538661;40637;40871.591284086775;40916;41105.79447102745;34922.65077349194;35071;35080.47379289364;35431.82284088563;35886.461703074994;35136.29727405387;35194.47208291929;35312.646873531965;35465.64534354623;35914;33842.32315353728;34250.14374640654;34349.48475772915;34657.826710866284;34832.82583587066;29598.704012959595;31680.841595792797;31917.8404107978;31996.6800332003;32329;24362.87818560896;24380.63429048601;24559.38601534976;24780.132695355576;24965.375865603506 10:07:24 INFO - PROCESS | 31224 | |2;jquery.html;339.24778518949626;354.29848899179626;359.3908325388466;359.7355943381615;381.87728079446424;12101.092418068647;15512.457064002761;15759.527214183578;17121.22954467049;17278.395256166037;15158.393664253445;15281.675798383603;15374.15442150684;15469.149196794171;15500.147491887941;4815.374001379816;5002.799888004475;5058.468860769622;5061.873453163682;5240.187770895498;4916.729579873106;5264.2893209416625;5302.761375738081;5312.681239125645;5314.521693047625;5175.663581867167;5235.947640523603;5244.842654720364;5250.107481728096;5254.290670759456;5074.517920797518;5240.397354304247;5245.711485868275;5246.291750613656;5299.708516031616;5171.870703232412;5172.19830926207;5173.275741396207;5177.637565370425;5179.533841954242;12002.279863208236;12249.081318901119;17502.649947001115;19922.501937451536;20045;1809.4300295406904;1900.4393703857395;2076.3251943118394;2315.96939361984;2338.8012018978407;8903.37676362655;9003.729888103368;9357.251419886461;9577.664781732607;12199.93900030503;1638.2382192280647;1717.064200010997;1734.4969958711958;1735.7743493345783;1738.6435780664933;62365.68817155885;63629.363706362805;63735;63848;65013.3498665012;9330.393524420891;9527.761805954906;9814.411135331902;9815;9968.202543796478;13310.534131305358;13328.6667833303;13343.73312533744;13408.597742067754;13440.193588384729;6681.9331806682285;6817.625030623363;6893.655737131211;7015.158181018209;7041.612711300928;6384.361563843579;6439.259485159173;6485.5460117792245;6634.170728658918;6652.06871038055;4117.91764164721;4167.187398457272;4174.3947127666315;4229.809658565372;4265.936010959838;1731;1747.4670225581065;1747.475757272813;1780.1188411736273;1802.8107048759953;778.7196609220676;826.8428998490267;833.9457935234191;860.586918279217;875.3172525430048;15868.968517046354;17855.73216401755;18111.36610218636;18820.153093110843;18908.905455472635;814.9348052155932;831.1480732249493;852.2415050604967;854.4275335525213;868.9608967596473;9240;9457.43255404678;9546.761330966643;9946.35348702332;10112.747181320527;371745.67306250555;378893;378970;380969;386676;41805;43359.783201083796;74331;74635.62682186555;74799.62600187073;848.1179573243758;877.4165180155126;903.7785742493131;906.1346414174448;907.9500627465553;10899.945500272448;14782.926085369505;14930.626734331294;15415.306311215798;15964.600884977968;33497.16257093592;33624.49563256504;33965.32069358649;34052.82973585116;34293.48559771555;42091.15817683568;43643.34534982041;45270;46216.30675539802;47456.7627161862;7155;7259.274072592699;7268.781936541912;7441.962790186014;7783.92216077832;8239.794005149919;9999.200063994718;10115.443650599287;10505.894941050492;11767.23512971654;9318.95340523293;9342.486163261086;9398.718038458857;9448.811023779348;9737.464439455898;8262;9344.486053267136;9418.811623767624;10147.34042287249;10380.792384152426;9767.951160244153;9779.559919803769;9848;10155.136813370651;10455.320404173704;7348.4935588203225;7585.241475852371;7587.748021576378;7649.235076492307;7730.420218483524;8662.740117796477;10134.949325253621;10263.332883362558;10298.17614590846;10454.529546170592 10:07:24 INFO - PROCESS | 31224 | |3;mootools.html;1327.7610030194564;1371.1361842039514;1424.679447124397;1659.659879569807;1682.2177687375367;6850.965745171267;7108.680109395077;7278.963605181973;7874.015748031503;7889.053313602369;7482.663280152393;7818.413618978585;7823.413244006694;8012.359011279098;8026.43814932955;2182.519845633966;2189.868607883532;2191.397365724423;2210.1159536185573;2212.4468882779306;1797.9910100449479;1854.137825910951;2032.2886989553685;2117.385958072165;2128.925487607934;2108.304259594338;2159.1039718516795;2162.848600597959;2165.155589320166;2169.620316444616;2070.8757474551576;2085.603735290305;2091.1739862754125;2099.149844313056;2099.674550444676;2058.259026750369;2071.357879057497;2072.58548290341;2074.1081335025933;2074.346580827035;7683;7856.960715196387;7857.0964339101165;7862.528248305063;7872.921270787276;4272.978635106836;4428.911421771547;4431.711938723973;4435.29035354345;4440.089781594766;2730.167298973812;2863.842488663123;2918.547625118089;2922.8538573071473;2939.9265018374713;859.9355048371397;860.7503823891064;868.5526953618892;875.8773771671971;897.6813231302858;10357;10416.687499375032;10456.215783816167;10460.738481537946;10481.63314284004;3883.4757307763657;4095.836166553364;4146.564610715832;4216.936745948813;4225.302825033897;9072.138146876036;9072.183503484586;9078.682246121354;9081.54592270397;9093.04523025086;4293.291606884892;4326.048269380732;4329.653627709776;4329.718568293051;4332.458442694663;3856.2287542491613;3861.4593956846065;3867.497225360685;3868.2843673920415;3868.5357757069332;3157.3527426877436;3310.3213841162506;3341.064501939461;3343.983280083584;3359.665032802228;925.2459245714856;938.2494004796135;1009.4599389326675;1015.2994433840627;1025.6358992557534;582.9390509273082;658.4765111736182;733.8018734941643;741.5476559298824;763.2558255700648;4601.631869450503;4751.928721069186;4820.25286080658;5049.697018178921;5125.2568377585785;771.7916162636169;780.0444455542029;783.2285199078902;831.1771346367053;835.4861760017545;3197.0728488738005;3215;3225.7258133058954;3230.111719277171;3414.5561077059824;9564.713058608253;9883.901160988442;9975.102240798364;9976.251781116445;9979.051990060932;9898.406095634286;9911.10800028001;9917.404955702681;9927.453990030474;9931.056549627774;6821.317868213238;7051.717931282794;7319.963400183072;7485.887711684329;7497.512661676974;5028.522290382408;5080.7205603692155;5129.7691603877165;5165.199394093921;5335.786568537215;8050.959745201237;8238.711645092393;8271.2142346477;8290.834183316421;8541.359398045295;8751.781205469913;8804.515751633722;8856.822863542822;8892;8954.149355811187;7136.143662760502;7388.815279617837;7394.593297368697;7398.630068496446;7409.184989651242;6993.685284162123;7034.718611255493;7040.260772619006;7042.084529011196;7301.707931682673;6660.666966651551;6666.533342665967;6734;6789.083473730983;6887.414569761627;6336.493080553452;6614.702338394687;6622.635755033327;6720.092787473628;6904.723811047502;6078.3921607838865;6128.601640893327;6156.199694039746;6189.442950134509;6190.690465476618;3898.863539776094;4058.0869304406274;4079.7756123413496;4168.249715051199;4176.43618111551;3949;3980.701447391399;3991.5409727881665;3998.260321840469;4116.094459218967 10:07:24 INFO - PROCESS | 31224 | |4;prototype.html;275.87171965036254;281.7999220553407;292.5071254935434;295.17057069634313;296.6929228248763;4744.742643199555;4760.809567617295;4761.0953918755495;4773.2124199507125;4780.235162374021;4689.93642797169;4690.437147542291;4690.882727931804;4700.942287985202;4703.952960470403;3721.6650501454865;3724.776513409204;3725.571559270678;3727.9627203728023;3732.4028155495125;3724.459953306769;3729.9067523311865;3741.6071312512204;3743.550773907135;3760.454734063559;3558.7864728116265;3654.5979942206336;3687.115092377837;3700.6299370063048;3722.367197576405;3662.1943172502006;3669.1377526281303;3698.2418604186078;3701.3152566775098;3703.2038111805955;3053.8015029023263;3250.707436330718;3250.9674903250902;3253.1704415374165;3259.8044117353033;4436.401085853401;4524.705894116872;4564.6348292136545;4575.176468235716;4604.2633178691585;4170.52039015514;4171.895702607429;4179.895502612429;4208.705390622657;4219.578042195786;4594.494605593382;4891.315215869746;4903.166461701519;4922.335484709554;4930.309756634038;3274.197821533716;3338.549295845078;3537.133402316423;3553.1650062235353;3560.857565697369;5087.592992560586;5093.592512598983;5100.642954993152;5105.719185444799;5121.564667003272;3637.3270944875285;3641.4901913732097;3643.7449378543247;3644.3804553226014;3654.926901461956;3574.160072382988;3645.908852278714;3684.668379845773;3712.535933008374;3712.8514859405864;4161.687873409446;4166.541680415152;4167.187398457272;4173.97913010433;4174.165166966558;4886.169351210303;4891.144049791273;4894.706317620954;4902.852914412573;4909.2881532177635;1243.185713357752;1278.9488420463263;1282.2050328796206;1282.762688902556;1284.1973766396002;811.9918800811917;830.9711103029545;833.1210572845584;833.5540485840168;836.4521238588734;3918.0792513759243;3933.724639275223;3966.781826999485;3969.702272329587;3974.4833171687496;4466.218411777926;4479.350494178326;4504.752238626841;4516.751578663205;4525.592696657317;3697.6487233712755;3900.278448487039;3966.087799806061;3976.443297938291;4001.579834117434;2355.9528809423714;2360.843186838471;2372.3238876919995;2375.6340104440014;2390.9043638254625;4207.431996680471;4236.576342365739;4240.109576988867;4244.3209086546;4585.770711464414;5052.57053150479;5083.796648134034;5150.506353157542;5159.664621799646;5167.044096842021;4751.9287210692555;4756.858353995085;4776.402949631296;4784.545468180518;4785.425748910153;4884.584810291023;5016.849494515171;5028.874278143076;5055.317532133115;5083.262926875656;4857.587105095965;4940.382452193476;4960.429550601727;4962.379702537183;4965.205567109245;4774.3315935769715;4784.354112194809;4794;4798.3042458843975;4804.543568361;3553.911152221215;3655.550780976805;3667.339878821731;3669.954063092006;3681.6134305897494;5037.118504261666;5040.218766091261;5041.059192210952;5057.7724002419245;5070.239464080418;4907.288443175791;4920.48334924842;4921.4989428224735;4923.778429970588;4938.185199442052;4688.624910007123;4862.83292009908;4874.392200172891;4899.632527560519;4908.92636610444;4827.806887724592;4857.425564450706;4858.271259311132;4863.610911127172;4872.293517439881;4939.753012349296;4964.368884491226;4968.726720030433;4969.235921247905;4974.527419895104;4612.370948559424;4835.243910970713;4840.814000569883;4842.975785121052;4845.685030473008 10:07:24 INFO - PROCESS | 31224 | |5;yui.html;601.8645804693944;618.9566730328876;688.8863337549304;693.8300116471465;695.7460526907679;12540.498380064799;13665.521706740266;13684.657883552916;13700.314984250785;13702.657433564165;11845.99309058729;11861.110416718737;12864.549740759076;13012.804807927889;13044.08691391603;771.2095102519905;787.4684587903142;792.8810678398229;793.8650429427012;794.2732399854126;806.4475834053662;810.2059981218409;810.4043528006911;810.6028046257321;810.8256724804166;831.3515457942814;831.7255305749088;832.3757182113415;832.6419639555019;832.8709050097215;823.238504383446;824.8762685597178;825.0429501777938;825.1418524734269;825.2201669422399;605.772835186805;607.313735478906;607.4532920371656;607.6627471753176;607.9300880398766;11212.66362009141;11237.26957747752;11302.773944521063;11304.830427543593;11343.773124537463;11657.883421165765;11905.821412678817;12605.180663256859;12996.28520431376;13467.461301547926;10298.352263637857;10570.471476426224;10926.289791163628;11069.280496767684;11094.167937404727;4097.672186225095;4105.794710264505;4161.542230354658;4162.7502349859105;4229.154169166179;33616.89806835893;46765;46792.76603616994;61518;62583.37416625821;9987.600495980225;10386.636467723594;10449.84325235122;10526.684199474028;10681;19270.71093933592;19290.4212873614;19328.130234139215;19336.226550938085;19373.225070997003;6675.432588229958;6786.423154031864;6938.583684978817;6947.861042779116;7051.647417629098;3584.62361452049;3617.4031284837706;3657.8253435754027;3723.7579557328686;3728.8881333560034;2976.389840082778;3121.5941927549275;3138.435081685273;3152.4798408262836;3153.0540837748586;512.7974450092192;517.6247220764915;522.169750097347;523.2308506495445;528.9418164001956;528.5032069854325;571.977120915167;574.350983388768;591.257971246092;596.9074793407029;6511.120998665215;6520.673966301666;6774.525783195228;6783.728650854009;7220.4584656151;489.2367906066548;535.2159086937655;552.2765177617334;573.845061833311;574.9966308791103;3400.4389275769718;3470.8785192518644;3514.0687717754818;3523.8590456381457;3732.104294969188;85385.57307213424;97380.51309743548;100548.49725751324;101296;103448.48275758723;48848.75575622099;59948.400515995156;80905;81095;82225;77225.61387193028;77308.61345693348;77818.22181778224;78325.60837195777;78450.21549784543;6428;6482.967585162044;6515.087887695631;6669.966650166718;6849.931500684929;44755.32867006932;45763.77118114388;45897;46075;46533.76733116313;48961.51038489569;50749;53110;55231.72384138054;55670.72164639151;10036.297459177787;10146.391216527032;10395.636152734618;10544.420056896945;10569.260151789302;11251.381174035507;11273.492692828679;11298.60454884075;12192.268463892195;12199.329036903055;9939.453330066915;10305.072543470824;10436.843447348449;10493.527791249564;10528.526216320437;10761.838572421264;10834.512446940063;11050.834237486284;11592.072634189077;11607.5937342196;9959.153471954965;9967.700968970943;10163.7459063524;10485.580576776843;10488.947555262175;9589.849218093594;9971.800563988825;10024.24818138657;10126.341787784066;10156;8162.877556836771;8926.86609700842;9001.414908030956;9007.819843603222;9128.634854606007 10:07:24 INFO - PROCESS | 31224 | __end_tp_report 10:07:24 INFO - PROCESS | 31224 | __start_cc_report 10:07:24 INFO - PROCESS | 31224 | _x_x_mozilla_cycle_collect,1948 10:07:24 INFO - PROCESS | 31224 | __end_cc_report 10:07:24 INFO - PROCESS | 31224 | __startTimestamp1476896844197__endTimestamp 10:07:24 INFO - PROCESS | 31224 | 10:07:24 INFO - PROCESS | 31224 | ------- Summary: start ------- 10:07:24 INFO - PROCESS | 31224 | Number of tests: 6 10:07:24 INFO - PROCESS | 31224 | 10:07:24 INFO - PROCESS | 31224 | [#0] dojo.html Cycles:165 Average:4607.45 Median:4768.98 stddev:488.18 (10.2%) stddev-sans-first:463.41 10:07:24 INFO - PROCESS | 31224 | Values: 2593.8 2616.5 2638.4 2654.0 2668.2 4540.5 4606.7 4623.1 4645.3 4663.7 4581.5 4622.8 4636.6 4660.1 4706.1 4248.1 4283.6 4296.7 4305.5 4306.2 4264.6 4314.7 4345.0 4387.4 4410.5 4340.0 4345.0 4357.0 4387.1 4415.8 4150.8 4211.9 4221.4 4259.9 4281.1 4257.0 4261.7 4262.5 4264.5 4270.5 4584.5 4623.8 4634.2 4643.5 4655.8 4915.8 4945.5 4957.3 5005.4 5066.5 5015.6 5040.2 5049.0 5051.8 5104.9 4515.8 4561.6 4659.1 4660.1 4715.8 5101.1 5141.7 5142.2 5146.8 5207.3 4920.4 4928.8 4931.4 4933.5 4991.1 4818.1 4859.4 4863.4 4966.7 4980.2 4970.9 5002.8 5006.2 5009.3 5013.4 4912.1 4918.6 4924.4 4939.5 5002.4 4126.1 4135.3 4136.4 4140.0 4189.5 3578.1 3601.4 3604.0 3610.2 3643.9 4288.9 4293.6 4337.6 4349.8 4352.7 4932.6 4936.5 4945.5 4947.2 5006.6 4265.8 4271.2 4279.5 4319.6 4334.2 4432.2 4449.9 4453.1 4484.8 4491.4 4782.9 4807.2 4810.0 4812.0 4851.9 4870.4 4915.8 5047.1 5069.1 5119.3 4699.2 4711.5 4730.2 4745.7 4796.6 4931.0 4931.4 4935.3 4937.4 4991.0 4998.3 5005.1 5007.4 5008.4 5062.1 4726.8 4762.5 4769.0 4834.5 4914.0 4807.6 4851.4 4855.7 4862.4 4866.8 4731.2 4787.6 4790.1 4795.4 4796.3 4881.7 4906.8 4916.4 4928.4 4958.7 4789.4 4793.4 4796.8 4801.9 4847.0 10:07:24 INFO - PROCESS | 31224 | 10:07:24 INFO - PROCESS | 31224 | [#1] ext.html Cycles:180 Average:46941.88 Median:35372.23 stddev:85682.08 (242.2%) stddev-sans-first:85851.64 10:07:24 INFO - PROCESS | 31224 | Values: 548.4 583.4 584.7 593.5 595.6 34966.7 38911.2 39011.0 39070.2 39174.4 38948.2 39388.4 39415.8 39420.8 39468.4 7443.8 7633.3 7642.2 7658.3 7659.8 7593.3 7674.2 7674.8 7678.3 7683.9 7708.3 7739.5 7740.9 7742.7 7744.9 7645.3 7676.6 7681.6 7688.4 7690.3 7517.1 7575.9 7583.6 7587.6 7590.4 35134.5 35439.0 35565.8 35568.3 35569.8 2664.7 2748.3 2823.5 2844.5 2846.5 27390.8 27480.9 27532.7 27975.2 28206.0 3198.2 3309.4 3385.9 3481.6 3513.8 248231.0 250622.0 251409.0 252952.0 253330.0 53175.2 54077.7 54116.7 54381.5 54395.7 31430.2 32872.5 32944.2 34920.0 34929.0 13541.5 13698.0 13698.9 13703.7 13712.9 10234.5 10352.4 10359.2 10360.8 10363.5 17448.7 17451.3 17472.7 17479.7 17520.3 6670.5 6796.2 6858.2 6860.1 7127.3 747.9 779.5 809.6 880.7 958.3 26355.0 27805.0 27814.6 27961.7 28501.0 954.4 979.8 1029.8 1041.8 1045.5 13585.3 14546.6 14791.3 15106.2 15121.2 373456.0 376765.0 377837.0 378134.0 379222.0 49443.8 49772.5 50146.7 50280.5 50281.5 1123.4 1156.5 1161.9 1164.5 1176.0 25321.9 26671.6 26763.3 27033.0 27507.9 43122.4 43992.8 44025.6 44042.6 44189.3 333997.0 334760.0 335391.0 335782.0 335841.0 35770.1 37365.4 37882.2 37944.0 37972.4 38664.6 40637.0 40871.6 40916.0 41105.8 34922.7 35071.0 35080.5 35431.8 35886.5 35136.3 35194.5 35312.6 35465.6 35914.0 33842.3 34250.1 34349.5 34657.8 34832.8 29598.7 31680.8 31917.8 31996.7 32329.0 24362.9 24380.6 24559.4 24780.1 24965.4 10:07:24 INFO - PROCESS | 31224 | 10:07:24 INFO - PROCESS | 31224 | [#2] jquery.html Cycles:180 Average:22829.41 Median:5123.19 stddev:62344.02 (1216.9%) stddev-sans-first:62496.04 10:07:24 INFO - PROCESS | 31224 | Values: 339.2 354.3 359.4 359.7 381.9 12101.1 15512.5 15759.5 17121.2 17278.4 15158.4 15281.7 15374.2 15469.1 15500.1 4815.4 5002.8 5058.5 5061.9 5240.2 4916.7 5264.3 5302.8 5312.7 5314.5 5175.7 5235.9 5244.8 5250.1 5254.3 5074.5 5240.4 5245.7 5246.3 5299.7 5171.9 5172.2 5173.3 5177.6 5179.5 12002.3 12249.1 17502.6 19922.5 20045.0 1809.4 1900.4 2076.3 2316.0 2338.8 8903.4 9003.7 9357.3 9577.7 12199.9 1638.2 1717.1 1734.5 1735.8 1738.6 62365.7 63629.4 63735.0 63848.0 65013.3 9330.4 9527.8 9814.4 9815.0 9968.2 13310.5 13328.7 13343.7 13408.6 13440.2 6681.9 6817.6 6893.7 7015.2 7041.6 6384.4 6439.3 6485.5 6634.2 6652.1 4117.9 4167.2 4174.4 4229.8 4265.9 1731.0 1747.5 1747.5 1780.1 1802.8 778.7 826.8 833.9 860.6 875.3 15869.0 17855.7 18111.4 18820.2 18908.9 814.9 831.1 852.2 854.4 869.0 9240.0 9457.4 9546.8 9946.4 10112.7 371745.7 378893.0 378970.0 380969.0 386676.0 41805.0 43359.8 74331.0 74635.6 74799.6 848.1 877.4 903.8 906.1 908.0 10899.9 14782.9 14930.6 15415.3 15964.6 33497.2 33624.5 33965.3 34052.8 34293.5 42091.2 43643.3 45270.0 46216.3 47456.8 7155.0 7259.3 7268.8 7442.0 7783.9 8239.8 9999.2 10115.4 10505.9 11767.2 9319.0 9342.5 9398.7 9448.8 9737.5 8262.0 9344.5 9418.8 10147.3 10380.8 9768.0 9779.6 9848.0 10155.1 10455.3 7348.5 7585.2 7587.7 7649.2 7730.4 8662.7 10134.9 10263.3 10298.2 10454.5 10:07:24 INFO - PROCESS | 31224 | 10:07:24 INFO - PROCESS | 31224 | [#3] mootools.html Cycles:180 Average:5007.61 Median:5147.48 stddev:2908.66 (56.5%) stddev-sans-first:2903.68 10:07:24 INFO - PROCESS | 31224 | Values: 1327.8 1371.1 1424.7 1659.7 1682.2 6851.0 7108.7 7279.0 7874.0 7889.1 7482.7 7818.4 7823.4 8012.4 8026.4 2182.5 2189.9 2191.4 2210.1 2212.4 1798.0 1854.1 2032.3 2117.4 2128.9 2108.3 2159.1 2162.8 2165.2 2169.6 2070.9 2085.6 2091.2 2099.1 2099.7 2058.3 2071.4 2072.6 2074.1 2074.3 7683.0 7857.0 7857.1 7862.5 7872.9 4273.0 4428.9 4431.7 4435.3 4440.1 2730.2 2863.8 2918.5 2922.9 2939.9 859.9 860.8 868.6 875.9 897.7 10357.0 10416.7 10456.2 10460.7 10481.6 3883.5 4095.8 4146.6 4216.9 4225.3 9072.1 9072.2 9078.7 9081.5 9093.0 4293.3 4326.0 4329.7 4329.7 4332.5 3856.2 3861.5 3867.5 3868.3 3868.5 3157.4 3310.3 3341.1 3344.0 3359.7 925.2 938.2 1009.5 1015.3 1025.6 582.9 658.5 733.8 741.5 763.3 4601.6 4751.9 4820.3 5049.7 5125.3 771.8 780.0 783.2 831.2 835.5 3197.1 3215.0 3225.7 3230.1 3414.6 9564.7 9883.9 9975.1 9976.3 9979.1 9898.4 9911.1 9917.4 9927.5 9931.1 6821.3 7051.7 7320.0 7485.9 7497.5 5028.5 5080.7 5129.8 5165.2 5335.8 8051.0 8238.7 8271.2 8290.8 8541.4 8751.8 8804.5 8856.8 8892.0 8954.1 7136.1 7388.8 7394.6 7398.6 7409.2 6993.7 7034.7 7040.3 7042.1 7301.7 6660.7 6666.5 6734.0 6789.1 6887.4 6336.5 6614.7 6622.6 6720.1 6904.7 6078.4 6128.6 6156.2 6189.4 6190.7 3898.9 4058.1 4079.8 4168.2 4176.4 3949.0 3980.7 3991.5 3998.3 4116.1 10:07:24 INFO - PROCESS | 31224 | 10:07:24 INFO - PROCESS | 31224 | [#4] prototype.html Cycles:180 Average:4031.69 Median:4545.11 stddev:1175.65 (25.9%) stddev-sans-first:1144.66 10:07:24 INFO - PROCESS | 31224 | Values: 275.9 281.8 292.5 295.2 296.7 4744.7 4760.8 4761.1 4773.2 4780.2 4689.9 4690.4 4690.9 4700.9 4704.0 3721.7 3724.8 3725.6 3728.0 3732.4 3724.5 3729.9 3741.6 3743.6 3760.5 3558.8 3654.6 3687.1 3700.6 3722.4 3662.2 3669.1 3698.2 3701.3 3703.2 3053.8 3250.7 3251.0 3253.2 3259.8 4436.4 4524.7 4564.6 4575.2 4604.3 4170.5 4171.9 4179.9 4208.7 4219.6 4594.5 4891.3 4903.2 4922.3 4930.3 3274.2 3338.5 3537.1 3553.2 3560.9 5087.6 5093.6 5100.6 5105.7 5121.6 3637.3 3641.5 3643.7 3644.4 3654.9 3574.2 3645.9 3684.7 3712.5 3712.9 4161.7 4166.5 4167.2 4174.0 4174.2 4886.2 4891.1 4894.7 4902.9 4909.3 1243.2 1278.9 1282.2 1282.8 1284.2 812.0 831.0 833.1 833.6 836.5 3918.1 3933.7 3966.8 3969.7 3974.5 4466.2 4479.4 4504.8 4516.8 4525.6 3697.6 3900.3 3966.1 3976.4 4001.6 2356.0 2360.8 2372.3 2375.6 2390.9 4207.4 4236.6 4240.1 4244.3 4585.8 5052.6 5083.8 5150.5 5159.7 5167.0 4751.9 4756.9 4776.4 4784.5 4785.4 4884.6 5016.8 5028.9 5055.3 5083.3 4857.6 4940.4 4960.4 4962.4 4965.2 4774.3 4784.4 4794.0 4798.3 4804.5 3553.9 3655.6 3667.3 3670.0 3681.6 5037.1 5040.2 5041.1 5057.8 5070.2 4907.3 4920.5 4921.5 4923.8 4938.2 4688.6 4862.8 4874.4 4899.6 4908.9 4827.8 4857.4 4858.3 4863.6 4872.3 4939.8 4964.4 4968.7 4969.2 4974.5 4612.4 4835.2 4840.8 4843.0 4845.7 10:07:24 INFO - PROCESS | 31224 | 10:07:24 INFO - PROCESS | 31224 | [#5] yui.html Cycles:180 Average:16625.60 Median:24669.00 stddev:23957.93 (97.1%) stddev-sans-first:23994.93 10:07:24 INFO - PROCESS | 31224 | Values: 601.9 619.0 688.9 693.8 695.7 12540.5 13665.5 13684.7 13700.3 13702.7 11846.0 11861.1 12864.5 13012.8 13044.1 771.2 787.5 792.9 793.9 794.3 806.4 810.2 810.4 810.6 810.8 831.4 831.7 832.4 832.6 832.9 823.2 824.9 825.0 825.1 825.2 605.8 607.3 607.5 607.7 607.9 11212.7 11237.3 11302.8 11304.8 11343.8 11657.9 11905.8 12605.2 12996.3 13467.5 10298.4 10570.5 10926.3 11069.3 11094.2 4097.7 4105.8 4161.5 4162.8 4229.2 33616.9 46765.0 46792.8 61518.0 62583.4 9987.6 10386.6 10449.8 10526.7 10681.0 19270.7 19290.4 19328.1 19336.2 19373.2 6675.4 6786.4 6938.6 6947.9 7051.6 3584.6 3617.4 3657.8 3723.8 3728.9 2976.4 3121.6 3138.4 3152.5 3153.1 512.8 517.6 522.2 523.2 528.9 528.5 572.0 574.4 591.3 596.9 6511.1 6520.7 6774.5 6783.7 7220.5 489.2 535.2 552.3 573.8 575.0 3400.4 3470.9 3514.1 3523.9 3732.1 85385.6 97380.5 100548.5 101296.0 103448.5 48848.8 59948.4 80905.0 81095.0 82225.0 77225.6 77308.6 77818.2 78325.6 78450.2 6428.0 6483.0 6515.1 6670.0 6849.9 44755.3 45763.8 45897.0 46075.0 46533.8 48961.5 50749.0 53110.0 55231.7 55670.7 10036.3 10146.4 10395.6 10544.4 10569.3 11251.4 11273.5 11298.6 12192.3 12199.3 9939.5 10305.1 10436.8 10493.5 10528.5 10761.8 10834.5 11050.8 11592.1 11607.6 9959.2 9967.7 10163.7 10485.6 10488.9 9589.8 9971.8 10024.2 10126.3 10156.0 8162.9 8926.9 9001.4 9007.8 9128.6 10:07:24 INFO - PROCESS | 31224 | -------- Summary: end -------- 10:07:24 INFO - PROCESS | 31224 | 10:07:25 INFO - TEST-INFO | 31224: exit 0 10:07:25 INFO - TEST-OK | dromaeo_css | took 1121969ms 10:07:25 INFO - TEST-START | kraken 10:07:25 INFO - operating with platform_type : linux_ 10:07:25 INFO - Initialising browser for kraken test... 10:07:25 INFO - TEST-INFO | started process 31532 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdjIRBa/profile http://localhost:35378/getInfo.html) 10:07:29 INFO - PROCESS | 31532 | __metrics Screen width/height:1600/1200 10:07:29 INFO - PROCESS | 31532 | colorDepth:24 10:07:29 INFO - PROCESS | 31532 | Browser inner width/height: 1024/697 10:07:29 INFO - PROCESS | 31532 | __metrics 10:07:30 INFO - PROCESS | 31532 | 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" 10:07:30 INFO - PROCESS | 31532 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:07:30 INFO - PROCESS | 31532 | console.error: PushService: 10:07:30 INFO - PROCESS | 31532 | stateChangeProcessEnqueue: Error transitioning state 10:07:30 INFO - PROCESS | 31532 | UnknownError 10:07:31 INFO - TEST-INFO | 31532: exit 0 10:07:31 INFO - Browser initialized. 10:07:31 INFO - Running cycle 1/1 for kraken test... 10:07:31 INFO - TEST-INFO | started process 31615 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdjIRBa/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:07:43 INFO - PROCESS | 31615 | RSS: Main: 172822528 10:07:43 INFO - PROCESS | 31615 | 10:07:46 INFO - PROCESS | 31615 | Cycle 1(1): loaded http://localhost:35378/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35378/tests/kraken/driver.html?testName=audio-beat-detection) 10:07:47 INFO - PROCESS | 31615 | RSS: Main: 234147840 10:07:47 INFO - PROCESS | 31615 | 10:07:50 INFO - PROCESS | 31615 | Cycle 1(1): loaded http://localhost:35378/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35378/tests/kraken/driver.html?testName=audio-dft) 10:07:50 INFO - PROCESS | 31615 | RSS: Main: 217251840 10:07:50 INFO - PROCESS | 31615 | 10:07:53 INFO - PROCESS | 31615 | Cycle 1(1): loaded http://localhost:35378/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35378/tests/kraken/driver.html?testName=audio-fft) 10:07:54 INFO - PROCESS | 31615 | RSS: Main: 299810816 10:07:54 INFO - PROCESS | 31615 | 10:07:56 INFO - PROCESS | 31615 | Cycle 1(1): loaded http://localhost:35378/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35378/tests/kraken/driver.html?testName=audio-oscillator) 10:07:57 INFO - PROCESS | 31615 | RSS: Main: 210661376 10:07:57 INFO - PROCESS | 31615 | 10:07:59 INFO - PROCESS | 31615 | Cycle 1(1): loaded http://localhost:35378/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35378/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:08:00 INFO - PROCESS | 31615 | RSS: Main: 213233664 10:08:00 INFO - PROCESS | 31615 | 10:08:03 INFO - PROCESS | 31615 | Cycle 1(1): loaded http://localhost:35378/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35378/tests/kraken/driver.html?testName=imaging-darkroom) 10:08:04 INFO - PROCESS | 31615 | RSS: Main: 249614336 10:08:04 INFO - PROCESS | 31615 | 10:08:07 INFO - PROCESS | 31615 | Cycle 1(1): loaded http://localhost:35378/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35378/tests/kraken/driver.html?testName=imaging-desaturate) 10:08:08 INFO - PROCESS | 31615 | RSS: Main: 248696832 10:08:08 INFO - PROCESS | 31615 | 10:08:10 INFO - PROCESS | 31615 | Cycle 1(1): loaded http://localhost:35378/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35378/tests/kraken/driver.html?testName=json-parse-financial) 10:08:11 INFO - PROCESS | 31615 | RSS: Main: 248422400 10:08:11 INFO - PROCESS | 31615 | 10:08:13 INFO - PROCESS | 31615 | Cycle 1(1): loaded http://localhost:35378/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35378/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:08:13 INFO - PROCESS | 31615 | RSS: Main: 210489344 10:08:13 INFO - PROCESS | 31615 | 10:08:15 INFO - PROCESS | 31615 | Cycle 1(1): loaded http://localhost:35378/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35378/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:08:16 INFO - PROCESS | 31615 | RSS: Main: 217325568 10:08:16 INFO - PROCESS | 31615 | 10:08:18 INFO - PROCESS | 31615 | Cycle 1(1): loaded http://localhost:35378/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35378/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:08:19 INFO - PROCESS | 31615 | RSS: Main: 226541568 10:08:19 INFO - PROCESS | 31615 | 10:08:21 INFO - PROCESS | 31615 | Cycle 1(1): loaded http://localhost:35378/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35378/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:08:22 INFO - PROCESS | 31615 | RSS: Main: 235032576 10:08:22 INFO - PROCESS | 31615 | 10:08:25 INFO - PROCESS | 31615 | Cycle 1(1): loaded http://localhost:35378/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35378/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:08:26 INFO - PROCESS | 31615 | RSS: Main: 232325120 10:08:26 INFO - PROCESS | 31615 | 10:08:28 INFO - PROCESS | 31615 | Cycle 1(1): loaded http://localhost:35378/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35378/tests/kraken/driver.html?testName=ai-astar) 10:08:28 INFO - PROCESS | 31615 | RSS: Main: 282976256 10:08:28 INFO - PROCESS | 31615 | 10:08:28 INFO - PROCESS | 31615 | __start_tp_report 10:08:28 INFO - PROCESS | 31615 | _x_x_mozilla_page_load 10:08:28 INFO - PROCESS | 31615 | _x_x_mozilla_page_load_details 10:08:28 INFO - PROCESS | 31615 | |i|pagename|runs| 10:08:28 INFO - PROCESS | 31615 | |0;ai-astar;106;114;113;115;113;114;114;113;115;116 10:08:28 INFO - PROCESS | 31615 | |1;audio-beat-detection;148;131;130;181;133;129;128;126;162;126 10:08:28 INFO - PROCESS | 31615 | |2;audio-dft;163;163;163;163;162;162;162;161;163;162 10:08:28 INFO - PROCESS | 31615 | |3;audio-fft;76;75;75;119;77;76;78;78;111;77 10:08:28 INFO - PROCESS | 31615 | |4;audio-oscillator;84;83;116;83;85;84;108;84;84;123 10:08:28 INFO - PROCESS | 31615 | |5;imaging-gaussian-blur;117;117;116;117;117;117;117;119;117;116 10:08:28 INFO - PROCESS | 31615 | |6;imaging-darkroom;147;146;147;146;146;146;146;146;146;146 10:08:28 INFO - PROCESS | 31615 | |7;imaging-desaturate;85;85;85;85;85;85;85;85;85;85 10:08:28 INFO - PROCESS | 31615 | |8;json-parse-financial;64;64;63;64;64;65;65;64;65;66 10:08:28 INFO - PROCESS | 31615 | |9;json-stringify-tinderbox;66;66;67;67;68;67;66;66;68;67 10:08:28 INFO - PROCESS | 31615 | |10;stanford-crypto-aes;86;90;82;93;83;86;89;85;82;88 10:08:28 INFO - PROCESS | 31615 | |11;stanford-crypto-ccm;145;141;138;147;150;144;148;153;191;147 10:08:28 INFO - PROCESS | 31615 | |12;stanford-crypto-pbkdf2;188;183;176;177;175;178;178;175;176;178 10:08:28 INFO - PROCESS | 31615 | |13;stanford-crypto-sha256-iterative;70;75;71;70;73;74;69;68;69;69 10:08:28 INFO - PROCESS | 31615 | __end_tp_report 10:08:28 INFO - PROCESS | 31615 | __start_cc_report 10:08:28 INFO - PROCESS | 31615 | _x_x_mozilla_cycle_collect,1949 10:08:28 INFO - PROCESS | 31615 | __end_cc_report 10:08:28 INFO - PROCESS | 31615 | __startTimestamp1476896908401__endTimestamp 10:08:28 INFO - PROCESS | 31615 | 10:08:28 INFO - PROCESS | 31615 | ------- Summary: start ------- 10:08:28 INFO - PROCESS | 31615 | Number of tests: 14 10:08:28 INFO - PROCESS | 31615 | 10:08:28 INFO - PROCESS | 31615 | [#0] ai-astar Cycles:10 Average:113.30 Median:114.00 stddev:2.75 (2.4%) stddev-sans-first:1.05 10:08:28 INFO - PROCESS | 31615 | Values: 106.0 114.0 113.0 115.0 113.0 114.0 114.0 113.0 115.0 116.0 10:08:28 INFO - PROCESS | 31615 | 10:08:28 INFO - PROCESS | 31615 | [#1] audio-beat-detection Cycles:10 Average:139.40 Median:132.00 stddev:18.60 (14.1%) stddev-sans-first:19.46 10:08:28 INFO - PROCESS | 31615 | Values: 148.0 131.0 130.0 181.0 133.0 129.0 128.0 126.0 162.0 126.0 10:08:28 INFO - PROCESS | 31615 | 10:08:28 INFO - PROCESS | 31615 | [#2] audio-dft Cycles:10 Average:162.40 Median:163.00 stddev:0.70 (0.4%) stddev-sans-first:0.71 10:08:28 INFO - PROCESS | 31615 | Values: 163.0 163.0 163.0 163.0 162.0 162.0 162.0 161.0 163.0 162.0 10:08:28 INFO - PROCESS | 31615 | 10:08:28 INFO - PROCESS | 31615 | [#3] audio-fft Cycles:10 Average:84.20 Median:76.50 stddev:16.38 (21.4%) stddev-sans-first:17.10 10:08:28 INFO - PROCESS | 31615 | Values: 76.0 75.0 75.0 119.0 77.0 76.0 78.0 78.0 111.0 77.0 10:08:28 INFO - PROCESS | 31615 | 10:08:28 INFO - PROCESS | 31615 | [#4] audio-oscillator Cycles:10 Average:93.40 Median:84.00 stddev:15.78 (18.8%) stddev-sans-first:16.36 10:08:28 INFO - PROCESS | 31615 | Values: 84.0 83.0 116.0 83.0 85.0 84.0 108.0 84.0 84.0 123.0 10:08:28 INFO - PROCESS | 31615 | 10:08:28 INFO - PROCESS | 31615 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.82 (0.7%) stddev-sans-first:0.87 10:08:28 INFO - PROCESS | 31615 | Values: 117.0 117.0 116.0 117.0 117.0 117.0 117.0 119.0 117.0 116.0 10:08:28 INFO - PROCESS | 31615 | 10:08:28 INFO - PROCESS | 31615 | [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.00 stddev:0.42 (0.3%) stddev-sans-first:0.33 10:08:28 INFO - PROCESS | 31615 | Values: 147.0 146.0 147.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 10:08:28 INFO - PROCESS | 31615 | 10:08:28 INFO - PROCESS | 31615 | [#7] imaging-desaturate Cycles:10 Average:85.00 Median:85.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 10:08:28 INFO - PROCESS | 31615 | Values: 85.0 85.0 85.0 85.0 85.0 85.0 85.0 85.0 85.0 85.0 10:08:28 INFO - PROCESS | 31615 | 10:08:28 INFO - PROCESS | 31615 | [#8] json-parse-financial Cycles:10 Average:64.40 Median:64.50 stddev:0.84 (1.3%) stddev-sans-first:0.88 10:08:28 INFO - PROCESS | 31615 | Values: 64.0 64.0 63.0 64.0 64.0 65.0 65.0 64.0 65.0 66.0 10:08:28 INFO - PROCESS | 31615 | 10:08:28 INFO - PROCESS | 31615 | [#9] json-stringify-tinderbox Cycles:10 Average:66.80 Median:67.00 stddev:0.79 (1.2%) stddev-sans-first:0.78 10:08:28 INFO - PROCESS | 31615 | Values: 66.0 66.0 67.0 67.0 68.0 67.0 66.0 66.0 68.0 67.0 10:08:28 INFO - PROCESS | 31615 | 10:08:28 INFO - PROCESS | 31615 | [#10] stanford-crypto-aes Cycles:10 Average:86.40 Median:87.00 stddev:3.63 (4.2%) stddev-sans-first:3.84 10:08:28 INFO - PROCESS | 31615 | Values: 86.0 90.0 82.0 93.0 83.0 86.0 89.0 85.0 82.0 88.0 10:08:28 INFO - PROCESS | 31615 | 10:08:28 INFO - PROCESS | 31615 | [#11] stanford-crypto-ccm Cycles:10 Average:150.40 Median:147.50 stddev:14.89 (10.1%) stddev-sans-first:15.67 10:08:28 INFO - PROCESS | 31615 | Values: 145.0 141.0 138.0 147.0 150.0 144.0 148.0 153.0 191.0 147.0 10:08:28 INFO - PROCESS | 31615 | 10:08:28 INFO - PROCESS | 31615 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:178.40 Median:178.00 stddev:4.09 (2.3%) stddev-sans-first:2.45 10:08:28 INFO - PROCESS | 31615 | Values: 188.0 183.0 176.0 177.0 175.0 178.0 178.0 175.0 176.0 178.0 10:08:28 INFO - PROCESS | 31615 | 10:08:28 INFO - PROCESS | 31615 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.80 Median:70.50 stddev:2.39 (3.4%) stddev-sans-first:2.52 10:08:28 INFO - PROCESS | 31615 | Values: 70.0 75.0 71.0 70.0 73.0 74.0 69.0 68.0 69.0 69.0 10:08:28 INFO - PROCESS | 31615 | -------- Summary: end -------- 10:08:28 INFO - PROCESS | 31615 | 10:08:29 INFO - TEST-INFO | 31615: exit 0 10:08:29 INFO - TEST-OK | kraken | took 64463ms 10:08:29 INFO - SUITE-END | took 1186s 10:08:30 INFO - Completed test suite (00:19:46) 10:08:30 INFO - javascript benchmark 10:08:30 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2593.8184327097097, 2616.4897844920247, 2638.3799807045343, 2654.0, 2668.159529748129, 4540.455145382559, 4606.677532572721, 4623.1216068946915, 4645.279981602853, 4663.650226233038, 4581.541845815417, 4622.791974361154, 4636.629069674426, 4660.137874493221, 4706.129366067272, 4248.129133527619, 4283.635890949266, 4296.656267498608, 4305.504866940295, 4306.2464068787995, 4264.573542645726, 4314.697971142022, 4344.97827510862, 4387.363832244323, 4410.536893626171, 4340.045190058198, 4344.97827510862, 4356.956430435686, 4387.078713470175, 4415.80128894199, 4150.813213405404, 4211.852585159505, 4221.430106935555, 4259.936100958488, 4281.05816720321, 4257.042165512766, 4261.74429534229, 4262.509811371701, 4264.466941632296, 4270.487541495009, 4584.518625544337, 4623.8150473981, 4634.189016922025, 4643.535646435364, 4655.767211639404, 4915.778789954425, 4945.455999840015, 4957.3059771632, 5005.374328208974, 5066.544011039025, 5015.598752099823, 5040.218766091261, 5049.0, 5051.797928082872, 5104.948950510522, 4515.796789144496, 4561.635069194523, 4659.138059458943, 4660.1145782301255, 4715.78778954941, 5101.056304583664, 5141.742912854343, 5142.202958541432, 5146.845594632167, 5207.3230480037355, 4920.40955085392, 4928.802847886044, 4931.3835770528685, 4933.481984391659, 4991.126552853236, 4818.132736107465, 4859.416869975555, 4863.416390033148, 4966.677165984272, 4980.228064649985, 4970.925436118461, 5002.849914502571, 5006.249062640633, 5009.273655319958, 5013.448520662724, 4912.140375434285, 4918.631102667243, 4924.433690125681, 4939.53074457926, 5002.424721157041, 4126.09225970286, 4135.338345864648, 4136.358864376027, 4139.958600414017, 4189.455370801777, 3578.141246100917, 3601.3517566838223, 3603.9728677326834, 3610.1696609779374, 3643.85424583019, 4288.871333859989, 4293.592108749664, 4337.587929146789, 4349.804258808361, 4352.673549483801, 4932.630052746058, 4936.456989731127, 4945.530174633404, 4947.158982972904, 5006.6245031622775, 4265.76538290397, 4271.231178387858, 4279.529251782302, 4319.632831209319, 4334.1981733379425, 4432.202203603382, 4449.888752781141, 4453.131639330364, 4484.798184081724, 4491.416115904977, 4782.928256076231, 4807.182778927521, 4810.0, 4811.975940120277, 4851.854444366604, 4870.439899411613, 4915.803367865388, 5047.116754568009, 5069.112905241494, 5119.334486516729, 4699.201135806853, 4711.528847115261, 4730.172219861442, 4745.715257084586, 4796.640251981185, 4930.9506904930495, 4931.4328852181025, 4935.309056731989, 4937.35814344133, 4991.026749783758, 4998.300237966615, 5005.149124648746, 5007.424146223086, 5008.398992120969, 5062.139436295912, 4726.787294571684, 4762.476127626028, 4768.976155119202, 4834.540718631724, 4914.0, 4807.6394270429155, 4851.393575803025, 4855.684380515255, 4862.440819305825, 4866.80532778699, 4731.195696731495, 4787.593054590259, 4790.113828941657, 4795.424549054136, 4796.2805579162, 4881.682690625098, 4906.754662266801, 4916.385451818523, 4928.408590969107, 4958.677685950402, 4789.401324834395, 4793.352897358812, 4796.760161991956, 4801.927971080507, 4846.95153048465], "value": 4576.165148890254, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [548.4131978782702, 583.4253260538369, 584.739790793097, 593.5400064949661, 595.6336852835504, 34966.650333496655, 38911.221775564474, 39011.0, 39070.218595628074, 39174.41238381423, 38948.22103557927, 39388.40917386241, 39415.80292098543, 39420.80289598555, 39468.407973880414, 7443.776686699408, 7633.274838890325, 7642.235776422341, 7658.349040331578, 7659.770206893774, 7593.278638529331, 7674.232576742309, 7674.808129796772, 7678.347340476066, 7683.923160768377, 7708.30625243728, 7739.458237923348, 7740.922590774105, 7742.651580678855, 7744.883826742575, 7645.311921927026, 7676.616169191518, 7681.615919204018, 7688.38492920565, 7690.269424404701, 7517.135529414078, 7575.924240757577, 7583.582902940336, 7587.582682952436, 7590.430717696195, 35134.472982905274, 35439.0, 35565.82217088898, 35568.28863422743, 35569.82215088934, 2664.653595032653, 2748.2579703480146, 2823.5341168707137, 2844.4737723521007, 2846.5445528715304, 27390.8239346188, 27480.862595686893, 27532.72467275342, 27975.160745177473, 28206.0, 3198.1524895902603, 3309.4373956427225, 3385.932281354359, 3481.617022127564, 3513.8067406292644, 248231.0, 250622.0, 251409.0, 252952.0, 253329.99999999817, 53175.20237196445, 54077.72961135248, 54116.72941635267, 54381.45618543843, 54395.72802135964, 31430.21424464361, 32872.50691239633, 32944.17639558982, 34920.0, 34929.0, 13541.45834166642, 13698.0, 13698.863011369958, 13703.657408564866, 13712.93143534276, 10234.48827558619, 10352.378857268588, 10359.22305827066, 10360.792784144274, 10363.481825908675, 17448.69134814894, 17451.30194792194, 17472.737908931376, 17479.737803932952, 17520.29918803259, 6670.466362691071, 6796.218434879953, 6858.211305699809, 6860.0791778302155, 7127.251638577978, 747.872861613527, 779.5400713578903, 809.6032943857585, 880.665347168072, 958.3483231402713, 26355.0, 27805.0, 27814.582781258297, 27961.72038279632, 28501.0, 954.3891909178132, 979.750163708264, 1029.7888932768765, 1041.8014109593228, 1045.534737042009, 13585.252811095485, 14546.636334091732, 14791.334389952262, 15106.244687765568, 15121.16833574164, 373456.0, 376765.0, 377837.0, 378134.0, 379222.0, 49443.75278123586, 49772.50227497751, 50146.749266253435, 50280.497195028314, 50281.49718502768, 1123.3540714089431, 1156.502703837358, 1161.9419029048684, 1164.5341863254596, 1175.984426421331, 25321.87339063293, 26671.599926000737, 26763.33091672724, 27033.0, 27507.862460687567, 43122.353164703185, 43992.78003609961, 44025.55974440215, 44042.559574403844, 44189.33715994327, 333997.0, 334760.0, 335391.0, 335782.0, 335841.0, 35770.10574735652, 37365.4395184067, 37882.24235515219, 37944.0, 37972.430413544374, 38664.6133538661, 40637.0, 40871.591284086775, 40916.0, 41105.79447102745, 34922.65077349194, 35071.0, 35080.47379289364, 35431.82284088563, 35886.461703074994, 35136.29727405387, 35194.47208291929, 35312.646873531965, 35465.64534354623, 35914.0, 33842.32315353728, 34250.14374640654, 34349.48475772915, 34657.826710866284, 34832.82583587066, 29598.704012959595, 31680.841595792797, 31917.8404107978, 31996.6800332003, 32329.0, 24362.87818560896, 24380.63429048601, 24559.38601534976, 24780.132695355576, 24965.375865603506], "value": 17092.482458689672, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [339.24778518949626, 354.29848899179626, 359.3908325388466, 359.7355943381615, 381.87728079446424, 12101.092418068647, 15512.457064002761, 15759.527214183578, 17121.22954467049, 17278.395256166037, 15158.393664253445, 15281.675798383603, 15374.15442150684, 15469.149196794171, 15500.147491887941, 4815.374001379816, 5002.799888004475, 5058.468860769622, 5061.873453163682, 5240.187770895498, 4916.729579873106, 5264.2893209416625, 5302.761375738081, 5312.681239125645, 5314.521693047625, 5175.663581867167, 5235.947640523603, 5244.842654720364, 5250.107481728096, 5254.290670759456, 5074.517920797518, 5240.397354304247, 5245.711485868275, 5246.291750613656, 5299.708516031616, 5171.870703232412, 5172.19830926207, 5173.275741396207, 5177.637565370425, 5179.533841954242, 12002.279863208236, 12249.081318901119, 17502.649947001115, 19922.501937451536, 20045.0, 1809.4300295406904, 1900.4393703857395, 2076.3251943118394, 2315.96939361984, 2338.8012018978407, 8903.37676362655, 9003.729888103368, 9357.251419886461, 9577.664781732607, 12199.93900030503, 1638.2382192280647, 1717.064200010997, 1734.4969958711958, 1735.7743493345783, 1738.6435780664933, 62365.68817155885, 63629.363706362805, 63735.0, 63848.0, 65013.3498665012, 9330.393524420891, 9527.761805954906, 9814.411135331902, 9815.0, 9968.202543796478, 13310.534131305358, 13328.6667833303, 13343.73312533744, 13408.597742067754, 13440.193588384729, 6681.9331806682285, 6817.625030623363, 6893.655737131211, 7015.158181018209, 7041.612711300928, 6384.361563843579, 6439.259485159173, 6485.5460117792245, 6634.170728658918, 6652.06871038055, 4117.91764164721, 4167.187398457272, 4174.3947127666315, 4229.809658565372, 4265.936010959838, 1731.0, 1747.4670225581065, 1747.475757272813, 1780.1188411736273, 1802.8107048759953, 778.7196609220676, 826.8428998490267, 833.9457935234191, 860.586918279217, 875.3172525430048, 15868.968517046354, 17855.73216401755, 18111.36610218636, 18820.153093110843, 18908.905455472635, 814.9348052155932, 831.1480732249493, 852.2415050604967, 854.4275335525213, 868.9608967596473, 9240.0, 9457.43255404678, 9546.761330966643, 9946.35348702332, 10112.747181320527, 371745.67306250555, 378893.0, 378970.0, 380969.0, 386676.0, 41805.0, 43359.783201083796, 74331.0, 74635.62682186555, 74799.62600187073, 848.1179573243758, 877.4165180155126, 903.7785742493131, 906.1346414174448, 907.9500627465553, 10899.945500272448, 14782.926085369505, 14930.626734331294, 15415.306311215798, 15964.600884977968, 33497.16257093592, 33624.49563256504, 33965.32069358649, 34052.82973585116, 34293.48559771555, 42091.15817683568, 43643.34534982041, 45270.0, 46216.30675539802, 47456.7627161862, 7155.0, 7259.274072592699, 7268.781936541912, 7441.962790186014, 7783.92216077832, 8239.794005149919, 9999.200063994718, 10115.443650599287, 10505.894941050492, 11767.23512971654, 9318.95340523293, 9342.486163261086, 9398.718038458857, 9448.811023779348, 9737.464439455898, 8262.0, 9344.486053267136, 9418.811623767624, 10147.34042287249, 10380.792384152426, 9767.951160244153, 9779.559919803769, 9848.0, 10155.136813370651, 10455.320404173704, 7348.4935588203225, 7585.241475852371, 7587.748021576378, 7649.235076492307, 7730.420218483524, 8662.740117796477, 10134.949325253621, 10263.332883362558, 10298.17614590846, 10454.529546170592], "value": 7818.995993446417, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1327.7610030194564, 1371.1361842039514, 1424.679447124397, 1659.659879569807, 1682.2177687375367, 6850.965745171267, 7108.680109395077, 7278.963605181973, 7874.015748031503, 7889.053313602369, 7482.663280152393, 7818.413618978585, 7823.413244006694, 8012.359011279098, 8026.43814932955, 2182.519845633966, 2189.868607883532, 2191.397365724423, 2210.1159536185573, 2212.4468882779306, 1797.9910100449479, 1854.137825910951, 2032.2886989553685, 2117.385958072165, 2128.925487607934, 2108.304259594338, 2159.1039718516795, 2162.848600597959, 2165.155589320166, 2169.620316444616, 2070.8757474551576, 2085.603735290305, 2091.1739862754125, 2099.149844313056, 2099.674550444676, 2058.259026750369, 2071.357879057497, 2072.58548290341, 2074.1081335025933, 2074.346580827035, 7683.0, 7856.960715196387, 7857.0964339101165, 7862.528248305063, 7872.921270787276, 4272.978635106836, 4428.911421771547, 4431.711938723973, 4435.29035354345, 4440.089781594766, 2730.167298973812, 2863.842488663123, 2918.547625118089, 2922.8538573071473, 2939.9265018374713, 859.9355048371397, 860.7503823891064, 868.5526953618892, 875.8773771671971, 897.6813231302858, 10357.0, 10416.687499375032, 10456.215783816167, 10460.738481537946, 10481.63314284004, 3883.4757307763657, 4095.836166553364, 4146.564610715832, 4216.936745948813, 4225.302825033897, 9072.138146876036, 9072.183503484586, 9078.682246121354, 9081.54592270397, 9093.04523025086, 4293.291606884892, 4326.048269380732, 4329.653627709776, 4329.718568293051, 4332.458442694663, 3856.2287542491613, 3861.4593956846065, 3867.497225360685, 3868.2843673920415, 3868.5357757069332, 3157.3527426877436, 3310.3213841162506, 3341.064501939461, 3343.983280083584, 3359.665032802228, 925.2459245714856, 938.2494004796135, 1009.4599389326675, 1015.2994433840627, 1025.6358992557534, 582.9390509273082, 658.4765111736182, 733.8018734941643, 741.5476559298824, 763.2558255700648, 4601.631869450503, 4751.928721069186, 4820.25286080658, 5049.697018178921, 5125.2568377585785, 771.7916162636169, 780.0444455542029, 783.2285199078902, 831.1771346367053, 835.4861760017545, 3197.0728488738005, 3215.0, 3225.7258133058954, 3230.111719277171, 3414.5561077059824, 9564.713058608253, 9883.901160988442, 9975.102240798364, 9976.251781116445, 9979.051990060932, 9898.406095634286, 9911.10800028001, 9917.404955702681, 9927.453990030474, 9931.056549627774, 6821.317868213238, 7051.717931282794, 7319.963400183072, 7485.887711684329, 7497.512661676974, 5028.522290382408, 5080.7205603692155, 5129.7691603877165, 5165.199394093921, 5335.786568537215, 8050.959745201237, 8238.711645092393, 8271.2142346477, 8290.834183316421, 8541.359398045295, 8751.781205469913, 8804.515751633722, 8856.822863542822, 8892.0, 8954.149355811187, 7136.143662760502, 7388.815279617837, 7394.593297368697, 7398.630068496446, 7409.184989651242, 6993.685284162123, 7034.718611255493, 7040.260772619006, 7042.084529011196, 7301.707931682673, 6660.666966651551, 6666.533342665967, 6734.0, 6789.083473730983, 6887.414569761627, 6336.493080553452, 6614.702338394687, 6622.635755033327, 6720.092787473628, 6904.723811047502, 6078.3921607838865, 6128.601640893327, 6156.199694039746, 6189.442950134509, 6190.690465476618, 3898.863539776094, 4058.0869304406274, 4079.7756123413496, 4168.249715051199, 4176.43618111551, 3949.0, 3980.701447391399, 3991.5409727881665, 3998.260321840469, 4116.094459218967], "value": 3968.8119786953444, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [275.87171965036254, 281.7999220553407, 292.5071254935434, 295.17057069634313, 296.6929228248763, 4744.742643199555, 4760.809567617295, 4761.0953918755495, 4773.2124199507125, 4780.235162374021, 4689.93642797169, 4690.437147542291, 4690.882727931804, 4700.942287985202, 4703.952960470403, 3721.6650501454865, 3724.776513409204, 3725.571559270678, 3727.9627203728023, 3732.4028155495125, 3724.459953306769, 3729.9067523311865, 3741.6071312512204, 3743.550773907135, 3760.454734063559, 3558.7864728116265, 3654.5979942206336, 3687.115092377837, 3700.6299370063048, 3722.367197576405, 3662.1943172502006, 3669.1377526281303, 3698.2418604186078, 3701.3152566775098, 3703.2038111805955, 3053.8015029023263, 3250.707436330718, 3250.9674903250902, 3253.1704415374165, 3259.8044117353033, 4436.401085853401, 4524.705894116872, 4564.6348292136545, 4575.176468235716, 4604.2633178691585, 4170.52039015514, 4171.895702607429, 4179.895502612429, 4208.705390622657, 4219.578042195786, 4594.494605593382, 4891.315215869746, 4903.166461701519, 4922.335484709554, 4930.309756634038, 3274.197821533716, 3338.549295845078, 3537.133402316423, 3553.1650062235353, 3560.857565697369, 5087.592992560586, 5093.592512598983, 5100.642954993152, 5105.719185444799, 5121.564667003272, 3637.3270944875285, 3641.4901913732097, 3643.7449378543247, 3644.3804553226014, 3654.926901461956, 3574.160072382988, 3645.908852278714, 3684.668379845773, 3712.535933008374, 3712.8514859405864, 4161.687873409446, 4166.541680415152, 4167.187398457272, 4173.97913010433, 4174.165166966558, 4886.169351210303, 4891.144049791273, 4894.706317620954, 4902.852914412573, 4909.2881532177635, 1243.185713357752, 1278.9488420463263, 1282.2050328796206, 1282.762688902556, 1284.1973766396002, 811.9918800811917, 830.9711103029545, 833.1210572845584, 833.5540485840168, 836.4521238588734, 3918.0792513759243, 3933.724639275223, 3966.781826999485, 3969.702272329587, 3974.4833171687496, 4466.218411777926, 4479.350494178326, 4504.752238626841, 4516.751578663205, 4525.592696657317, 3697.6487233712755, 3900.278448487039, 3966.087799806061, 3976.443297938291, 4001.579834117434, 2355.9528809423714, 2360.843186838471, 2372.3238876919995, 2375.6340104440014, 2390.9043638254625, 4207.431996680471, 4236.576342365739, 4240.109576988867, 4244.3209086546, 4585.770711464414, 5052.57053150479, 5083.796648134034, 5150.506353157542, 5159.664621799646, 5167.044096842021, 4751.9287210692555, 4756.858353995085, 4776.402949631296, 4784.545468180518, 4785.425748910153, 4884.584810291023, 5016.849494515171, 5028.874278143076, 5055.317532133115, 5083.262926875656, 4857.587105095965, 4940.382452193476, 4960.429550601727, 4962.379702537183, 4965.205567109245, 4774.3315935769715, 4784.354112194809, 4794.0, 4798.3042458843975, 4804.543568361, 3553.911152221215, 3655.550780976805, 3667.339878821731, 3669.954063092006, 3681.6134305897494, 5037.118504261666, 5040.218766091261, 5041.059192210952, 5057.7724002419245, 5070.239464080418, 4907.288443175791, 4920.48334924842, 4921.4989428224735, 4923.778429970588, 4938.185199442052, 4688.624910007123, 4862.83292009908, 4874.392200172891, 4899.632527560519, 4908.92636610444, 4827.806887724592, 4857.425564450706, 4858.271259311132, 4863.610911127172, 4872.293517439881, 4939.753012349296, 4964.368884491226, 4968.726720030433, 4969.235921247905, 4974.527419895104, 4612.370948559424, 4835.243910970713, 4840.814000569883, 4842.975785121052, 4845.685030473008], "value": 3659.1976999579806, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [601.8645804693944, 618.9566730328876, 688.8863337549304, 693.8300116471465, 695.7460526907679, 12540.498380064799, 13665.521706740266, 13684.657883552916, 13700.314984250785, 13702.657433564165, 11845.99309058729, 11861.110416718737, 12864.549740759076, 13012.804807927889, 13044.08691391603, 771.2095102519905, 787.4684587903142, 792.8810678398229, 793.8650429427012, 794.2732399854126, 806.4475834053662, 810.2059981218409, 810.4043528006911, 810.6028046257321, 810.8256724804166, 831.3515457942814, 831.7255305749088, 832.3757182113415, 832.6419639555019, 832.8709050097215, 823.238504383446, 824.8762685597178, 825.0429501777938, 825.1418524734269, 825.2201669422399, 605.772835186805, 607.313735478906, 607.4532920371656, 607.6627471753176, 607.9300880398766, 11212.66362009141, 11237.26957747752, 11302.773944521063, 11304.830427543593, 11343.773124537463, 11657.883421165765, 11905.821412678817, 12605.180663256859, 12996.28520431376, 13467.461301547926, 10298.352263637857, 10570.471476426224, 10926.289791163628, 11069.280496767684, 11094.167937404727, 4097.672186225095, 4105.794710264505, 4161.542230354658, 4162.7502349859105, 4229.154169166179, 33616.89806835893, 46765.0, 46792.76603616994, 61518.0, 62583.37416625821, 9987.600495980225, 10386.636467723594, 10449.84325235122, 10526.684199474028, 10681.0, 19270.71093933592, 19290.4212873614, 19328.130234139215, 19336.226550938085, 19373.225070997003, 6675.432588229958, 6786.423154031864, 6938.583684978817, 6947.861042779116, 7051.647417629098, 3584.62361452049, 3617.4031284837706, 3657.8253435754027, 3723.7579557328686, 3728.8881333560034, 2976.389840082778, 3121.5941927549275, 3138.435081685273, 3152.4798408262836, 3153.0540837748586, 512.7974450092192, 517.6247220764915, 522.169750097347, 523.2308506495445, 528.9418164001956, 528.5032069854325, 571.977120915167, 574.350983388768, 591.257971246092, 596.9074793407029, 6511.120998665215, 6520.673966301666, 6774.525783195228, 6783.728650854009, 7220.4584656151, 489.2367906066548, 535.2159086937655, 552.2765177617334, 573.845061833311, 574.9966308791103, 3400.4389275769718, 3470.8785192518644, 3514.0687717754818, 3523.8590456381457, 3732.104294969188, 85385.57307213424, 97380.51309743548, 100548.49725751324, 101296.0, 103448.48275758723, 48848.75575622099, 59948.400515995156, 80905.0, 81095.0, 82225.0, 77225.61387193028, 77308.61345693348, 77818.22181778224, 78325.60837195777, 78450.21549784543, 6428.0, 6482.967585162044, 6515.087887695631, 6669.966650166718, 6849.931500684929, 44755.32867006932, 45763.77118114388, 45897.0, 46075.0, 46533.76733116313, 48961.51038489569, 50749.0, 53110.0, 55231.72384138054, 55670.72164639151, 10036.297459177787, 10146.391216527032, 10395.636152734618, 10544.420056896945, 10569.260151789302, 11251.381174035507, 11273.492692828679, 11298.60454884075, 12192.268463892195, 12199.329036903055, 9939.453330066915, 10305.072543470824, 10436.843447348449, 10493.527791249564, 10528.526216320437, 10761.838572421264, 10834.512446940063, 11050.834237486284, 11592.072634189077, 11607.5937342196, 9959.153471954965, 9967.700968970943, 10163.7459063524, 10485.580576776843, 10488.947555262175, 9589.849218093594, 9971.800563988825, 10024.24818138657, 10126.341787784066, 10156.0, 8162.877556836771, 8926.86609700842, 9001.414908030956, 9007.819843603222, 9128.634854606007], "value": 6306.920464844317, "unit": "score"}], "name": "dromaeo_css", "value": 6185.79499731499, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 114.0, 113.0, 115.0, 113.0, 114.0, 114.0, 113.0, 115.0, 116.0], "value": 113.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 131.0, 130.0, 181.0, 133.0, 129.0, 128.0, 126.0, 162.0, 126.0], "value": 139.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 163.0, 163.0, 162.0, 162.0, 162.0, 161.0, 163.0, 162.0], "value": 162.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 75.0, 119.0, 77.0, 76.0, 78.0, 78.0, 111.0, 77.0], "value": 84.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 116.0, 83.0, 85.0, 84.0, 108.0, 84.0, 84.0, 123.0], "value": 93.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 119.0, 117.0, 116.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 147.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0], "value": 146.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 85.0, 85.0, 85.0, 85.0, 85.0, 85.0, 85.0, 85.0], "value": 85.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 63.0, 64.0, 64.0, 65.0, 65.0, 64.0, 65.0, 66.0], "value": 64.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 67.0, 67.0, 68.0, 67.0, 66.0, 66.0, 68.0, 67.0], "value": 66.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 90.0, 82.0, 93.0, 83.0, 86.0, 89.0, 85.0, 82.0, 88.0], "value": 86.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 141.0, 138.0, 147.0, 150.0, 144.0, 148.0, 153.0, 191.0, 147.0], "value": 150.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [188.0, 183.0, 176.0, 177.0, 175.0, 178.0, 178.0, 175.0, 176.0, 178.0], "value": 178.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 75.0, 71.0, 70.0, 73.0, 74.0, 69.0, 68.0, 69.0, 69.0], "value": 70.8, "unit": "score"}], "name": "kraken", "value": 1558.1000000000004, "alertThreshold": 2.0}]} 10:08:30 INFO - Return code: 0 10:08:30 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:08:30 INFO - # TBPL SUCCESS # 10:08:30 INFO - Running post-action listener: _resource_record_post_action 10:08:30 INFO - [mozharness: 2016-10-19 17:08:30.176446Z] Finished run-tests step (success) 10:08:30 INFO - Running post-run listener: _resource_record_post_run 10:08:30 INFO - Total resource usage - Wall time: 1203s; CPU: 13.0%; Read bytes: 4096; Write bytes: 394579968; Read time: 12; Write time: 294916 10:08:30 INFO - TinderboxPrint: CPU usage
13.1% 10:08:30 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 10:08:30 INFO - TinderboxPrint: I/O write bytes / time
394,579,968 / 294,916 10:08:30 INFO - TinderboxPrint: CPU idle
8,343.5 (86.9%) 10:08:30 INFO - TinderboxPrint: CPU user
1,205.6 (12.6%) 10:08:30 INFO - TinderboxPrint: Swap in / out
0 / 0 10:08:30 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 103206912; Read time: 0; Write time: 97024 10:08:30 INFO - run-tests - Wall time: 1187s; CPU: 13.0%; Read bytes: 0; Write bytes: 291373056; Read time: 0; Write time: 197892 10:08:30 INFO - Running post-run listener: _upload_blobber_files 10:08:30 INFO - Blob upload gear active. 10:08:30 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:08:30 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 10:08:30 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'] 10:08:30 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 10:08:31 INFO - (blobuploader) - INFO - Open directory for files ... 10:08:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:08:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:08:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:08:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:08:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:08:32 INFO - (blobuploader) - INFO - Done attempting. 10:08:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:08:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:08:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:08:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:08:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:08:34 INFO - (blobuploader) - INFO - Done attempting. 10:08:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:08:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:08:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:08:37 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:08:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:08:37 INFO - (blobuploader) - INFO - Done attempting. 10:08:37 INFO - (blobuploader) - INFO - Iteration through files over. 10:08:37 INFO - Return code: 0 10:08:37 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:08:37 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:08:37 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4d7a190a604bcbcf4f7253319d1f62a9a7ae0ba392acd83c41d0a81ec76d3d9a00d0d26c83d2c7b58c6d3c89aec796c5b39963aaac4fd92576ea7225df138541", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a2b9e2416cd4ef8dfd3db1c1a8c2fc8f87ad40364f8a0082690178f8837bd32f8b19e701180c90104ec9de97d6ce477e446afc169289e2a0e3f9621e94698b1a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/458dc49b77d744d51f71bc165f2f8e220a87b944dd3414b8a332204d8b3f59af3fc1269738bbe32f797a99d67ee63e3957baa02b3d3e56145ed9dffa069c7ef9"} 10:08:37 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:08:37 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:08:37 INFO - Contents: 10:08:37 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4d7a190a604bcbcf4f7253319d1f62a9a7ae0ba392acd83c41d0a81ec76d3d9a00d0d26c83d2c7b58c6d3c89aec796c5b39963aaac4fd92576ea7225df138541", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a2b9e2416cd4ef8dfd3db1c1a8c2fc8f87ad40364f8a0082690178f8837bd32f8b19e701180c90104ec9de97d6ce477e446afc169289e2a0e3f9621e94698b1a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/458dc49b77d744d51f71bc165f2f8e220a87b944dd3414b8a332204d8b3f59af3fc1269738bbe32f797a99d67ee63e3957baa02b3d3e56145ed9dffa069c7ef9"} 10:08:37 INFO - Running post-run listener: copy_logs_to_upload_dir 10:08:37 INFO - Copying logs to upload dir... 10:08:37 INFO - mkdir: /builds/slave/test/build/upload/logs 10:08:37 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.649131 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-10-19 10:08:36.531240) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-19 10:08:36.534622) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1476895667.609550-1496114129 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/4d7a190a604bcbcf4f7253319d1f62a9a7ae0ba392acd83c41d0a81ec76d3d9a00d0d26c83d2c7b58c6d3c89aec796c5b39963aaac4fd92576ea7225df138541", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a2b9e2416cd4ef8dfd3db1c1a8c2fc8f87ad40364f8a0082690178f8837bd32f8b19e701180c90104ec9de97d6ce477e446afc169289e2a0e3f9621e94698b1a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/458dc49b77d744d51f71bc165f2f8e220a87b944dd3414b8a332204d8b3f59af3fc1269738bbe32f797a99d67ee63e3957baa02b3d3e56145ed9dffa069c7ef9"} build_url:https://queue.taskcluster.net/v1/task/En5USTLdR6i7ropWeaTD3g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011347 build_url: 'https://queue.taskcluster.net/v1/task/En5USTLdR6i7ropWeaTD3g/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/4d7a190a604bcbcf4f7253319d1f62a9a7ae0ba392acd83c41d0a81ec76d3d9a00d0d26c83d2c7b58c6d3c89aec796c5b39963aaac4fd92576ea7225df138541", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a2b9e2416cd4ef8dfd3db1c1a8c2fc8f87ad40364f8a0082690178f8837bd32f8b19e701180c90104ec9de97d6ce477e446afc169289e2a0e3f9621e94698b1a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/458dc49b77d744d51f71bc165f2f8e220a87b944dd3414b8a332204d8b3f59af3fc1269738bbe32f797a99d67ee63e3957baa02b3d3e56145ed9dffa069c7ef9"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-19 10:08:36.565200) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-19 10:08:36.565551) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1476895667.609550-1496114129 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004429 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-19 10:08:36.650697) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-19 10:08:36.651437) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-19 10:08:36.652124) ========= ========= Total master_lag: 0.17 =========