builder: autoland_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-043 starttime: 1475742290.33 results: success (0) buildid: 20161005234100 builduid: 2163f75e54fd4c0fb0dde23c6c2295eb revision: cc3ee8d499c511c6fa189fe15b5fea6a57f01382 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-06 01:24:50.331834) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-06 01:24:50.332252) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-06 01:24:50.332595) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-06 01:24:50.350173) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 01:24:50.350523) ========= 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=d2a8c569965ab8367867b893000001a1-1475742197.669836-1520761353 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-06 01:24:50-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 40.6M=0s 2016-10-06 01:24:51 (40.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.083366 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 01:24:50.482805) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 01:24:50.483119) ========= 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=d2a8c569965ab8367867b893000001a1-1475742197.669836-1520761353 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018411 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 01:24:50.532711) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 01:24:50.533064) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev cc3ee8d499c511c6fa189fe15b5fea6a57f01382 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev cc3ee8d499c511c6fa189fe15b5fea6a57f01382 --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=d2a8c569965ab8367867b893000001a1-1475742197.669836-1520761353 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-06 01:24:51,177 truncating revision to first 12 chars 2016-10-06 01:24:51,177 Setting DEBUG logging. 2016-10-06 01:24:51,177 attempt 1/10 2016-10-06 01:24:51,177 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/cc3ee8d499c5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-06 01:24:51,471 unpacking tar archive at: autoland-cc3ee8d499c5/testing/mozharness/ program finished with exit code 0 elapsedTime=0.638035 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 01:24:51.184209) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-06 01:24:51.184519) ========= script_repo_revision: cc3ee8d499c511c6fa189fe15b5fea6a57f01382 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-06 01:24:51.188001) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-06 01:24:51.188304) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-06 01:24:51.197813) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-10-06 01:24:51.198101) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-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', 'Autoland-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland-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=d2a8c569965ab8367867b893000001a1-1475742197.669836-1520761353 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 01:24:51 INFO - MultiFileLogger online at 20161006 01:24:51 in /builds/slave/test 01:24:51 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO 01:24:51 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:24:51 INFO - {'append_to_log': False, 01:24:51 INFO - 'base_work_dir': '/builds/slave/test', 01:24:51 INFO - 'blob_upload_branch': 'Autoland-Non-PGO', 01:24:51 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:24:51 INFO - 'branch': 'Autoland-Non-PGO', 01:24:51 INFO - 'buildbot_json_path': 'buildprops.json', 01:24:51 INFO - 'config_files': ('talos/linux_config.py',), 01:24:51 INFO - 'default_actions': ('clobber', 01:24:51 INFO - 'read-buildbot-config', 01:24:51 INFO - 'download-and-extract', 01:24:51 INFO - 'populate-webroot', 01:24:51 INFO - 'create-virtualenv', 01:24:51 INFO - 'install', 01:24:51 INFO - 'run-tests'), 01:24:51 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:24:51 INFO - 'download_minidump_stackwalk': True, 01:24:51 INFO - 'download_symbols': 'ondemand', 01:24:51 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:24:51 INFO - 'tooltool.py': '/tools/tooltool.py', 01:24:51 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:24:51 INFO - '/tools/misc-python/virtualenv.py')}, 01:24:51 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:24:51 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:24:51 INFO - 'installer_path': 'installer.exe', 01:24:51 INFO - 'log_level': 'info', 01:24:51 INFO - 'log_name': 'talos', 01:24:51 INFO - 'log_to_console': True, 01:24:51 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 01:24:51 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 01:24:51 INFO - 'opt_config_files': (), 01:24:51 INFO - 'pip_index': False, 01:24:51 INFO - 'sps_profile': False, 01:24:51 INFO - 'sps_profile_interval': 0, 01:24:51 INFO - 'suite': 'dromaeojs', 01:24:51 INFO - 'system_bits': '32', 01:24:51 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:24:51 INFO - 'title': 'talos-linux64-ix-043', 01:24:51 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:24:51 INFO - 'use_talos_json': True, 01:24:51 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:24:51 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:24:51 INFO - 'work_dir': 'build'} 01:24:51 INFO - [mozharness: 2016-10-06 08:24:51.943117Z] Running clobber step. 01:24:51 INFO - Running pre-action listener: _resource_record_pre_action 01:24:51 INFO - Running main action method: clobber 01:24:51 INFO - rmtree: /builds/slave/test/build 01:24:51 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:24:52 INFO - Running post-action listener: _resource_record_post_action 01:24:52 INFO - [mozharness: 2016-10-06 08:24:52.921915Z] Finished clobber step (success) 01:24:52 INFO - [mozharness: 2016-10-06 08:24:52.922015Z] Running read-buildbot-config step. 01:24:52 INFO - Running pre-action listener: _resource_record_pre_action 01:24:52 INFO - Running main action method: read_buildbot_config 01:24:52 INFO - Using buildbot properties: 01:24:52 INFO - { 01:24:52 INFO - "project": "", 01:24:52 INFO - "product": "firefox", 01:24:52 INFO - "script_repo_revision": "production", 01:24:52 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs", 01:24:52 INFO - "repository": "", 01:24:52 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland talos dromaeojs", 01:24:52 INFO - "buildid": "20161005234100", 01:24:52 INFO - "pgo_build": "False", 01:24:52 INFO - "basedir": "/builds/slave/test", 01:24:52 INFO - "buildnumber": 798, 01:24:52 INFO - "slavename": "talos-linux64-ix-043", 01:24:52 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 01:24:52 INFO - "platform": "ubuntu64_hw", 01:24:52 INFO - "scheduler": "tests-autoland-linux64-talos", 01:24:52 INFO - "branch": "autoland", 01:24:52 INFO - "repo_path": "integration/autoland", 01:24:52 INFO - "revision": "cc3ee8d499c511c6fa189fe15b5fea6a57f01382", 01:24:52 INFO - "stage_platform": "linux64", 01:24:52 INFO - "builduid": "2163f75e54fd4c0fb0dde23c6c2295eb", 01:24:52 INFO - "slavebuilddir": "test" 01:24:52 INFO - } 01:24:52 INFO - Found installer url https://queue.taskcluster.net/v1/task/Xqwh8lx_QsitZ6zErCy22g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 01:24:52 INFO - Running post-action listener: _resource_record_post_action 01:24:52 INFO - [mozharness: 2016-10-06 08:24:52.924478Z] Finished read-buildbot-config step (success) 01:24:52 INFO - [mozharness: 2016-10-06 08:24:52.924567Z] Running download-and-extract step. 01:24:52 INFO - Running pre-action listener: _resource_record_pre_action 01:24:52 INFO - Running main action method: download_and_extract 01:24:52 INFO - mkdir: /builds/slave/test/build/tests 01:24:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:24:52 INFO - trying https://queue.taskcluster.net/v1/task/Xqwh8lx_QsitZ6zErCy22g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 01:24:52 INFO - Downloading https://queue.taskcluster.net/v1/task/Xqwh8lx_QsitZ6zErCy22g/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 01:24:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Xqwh8lx_QsitZ6zErCy22g/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 01:24:53 INFO - Downloaded 1361 bytes. 01:24:53 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 01:24:53 INFO - Using the following test package requirements: 01:24:53 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 01:24:53 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 01:24:53 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 01:24:53 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 01:24:53 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 01:24:53 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 01:24:53 INFO - u'jsshell-linux-x86_64.zip'], 01:24:53 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 01:24:53 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 01:24:53 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 01:24:53 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 01:24:53 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 01:24:53 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 01:24:53 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 01:24:53 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 01:24:53 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 01:24:53 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 01:24:53 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 01:24:53 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 01:24:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Xqwh8lx_QsitZ6zErCy22g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 01:24:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Xqwh8lx_QsitZ6zErCy22g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 01:24:53 INFO - Fetch https://queue.taskcluster.net/v1/task/Xqwh8lx_QsitZ6zErCy22g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 01:24:54 INFO - Http code: 200 01:24:54 INFO - via: 1.1 d8f42fc9558e3e49ebfdf8834baeb756.cloudfront.net (CloudFront) 01:24:54 INFO - x-amz-cf-id: EPsBPcqyehXZVWLiVA4ygP19OUaSb8w_rEzlVHSQmqvJ2nQmOHmhRw== 01:24:54 INFO - x-amz-version-id: F9mpvaDEFWJfzjrx5xdjuyswBtau1JRb 01:24:54 INFO - Expected file size: 20421546 01:24:54 INFO - Obtained file size: 20421546 01:24:58 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 01:24:58 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Xqwh8lx_QsitZ6zErCy22g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 01:24:58 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Xqwh8lx_QsitZ6zErCy22g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 01:24:58 INFO - Fetch https://queue.taskcluster.net/v1/task/Xqwh8lx_QsitZ6zErCy22g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 01:24:59 INFO - Http code: 200 01:24:59 INFO - via: 1.1 a1aa00de8387e7235a256b2a5b73ede8.cloudfront.net (CloudFront) 01:24:59 INFO - x-amz-cf-id: jq3W8cdskW7mGK8KsWO1kepf16wrbeC5vbKfeDC4ibqkILyhjPfzCQ== 01:24:59 INFO - x-amz-version-id: F9mpvaDEFWJfzjrx5xdjuyswBtau1JRb 01:24:59 INFO - Expected file size: 20421546 01:24:59 INFO - Obtained file size: 20421546 01:25:03 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Xqwh8lx_QsitZ6zErCy22g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 01:25:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Xqwh8lx_QsitZ6zErCy22g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 01:25:03 INFO - Fetch https://queue.taskcluster.net/v1/task/Xqwh8lx_QsitZ6zErCy22g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 01:25:04 INFO - Http code: 200 01:25:04 INFO - via: 1.1 11dd60d1f68e8258294f92935b53a91f.cloudfront.net (CloudFront) 01:25:04 INFO - x-amz-cf-id: tnvuXURaJzNYNQUZbOsLmOpP_lIVoKUINCohuqwRAbw5_DtYN9ejMw== 01:25:04 INFO - x-amz-version-id: oTv8D5xb9fp7kEP5P13V0ddU.kQ2qI6K 01:25:04 INFO - Expected file size: 14409006 01:25:04 INFO - Obtained file size: 14409006 01:25:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:25:04 INFO - trying https://queue.taskcluster.net/v1/task/Xqwh8lx_QsitZ6zErCy22g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 01:25:04 INFO - Downloading https://queue.taskcluster.net/v1/task/Xqwh8lx_QsitZ6zErCy22g/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 01:25:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Xqwh8lx_QsitZ6zErCy22g/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 01:25:05 INFO - Downloaded 55808607 bytes. 01:25:05 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Xqwh8lx_QsitZ6zErCy22g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 01:25:05 INFO - mkdir: /builds/slave/test/properties 01:25:05 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:25:05 INFO - Writing to file /builds/slave/test/properties/build_url 01:25:05 INFO - Contents: 01:25:05 INFO - build_url:https://queue.taskcluster.net/v1/task/Xqwh8lx_QsitZ6zErCy22g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 01:25:06 INFO - Running post-action listener: _resource_record_post_action 01:25:06 INFO - Running post-action listener: set_extra_try_arguments 01:25:06 INFO - [mozharness: 2016-10-06 08:25:06.487207Z] Finished download-and-extract step (success) 01:25:06 INFO - [mozharness: 2016-10-06 08:25:06.487436Z] Running populate-webroot step. 01:25:06 INFO - Running pre-action listener: _resource_record_pre_action 01:25:06 INFO - Running main action method: populate_webroot 01:25:06 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:25:06 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:25:06 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:25:06 INFO - '--tppagecycles', 01:25:06 INFO - '7'], 01:25:06 INFO - 'tests': ['tsvgm']}}, 01:25:06 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 01:25:06 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:25:06 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 01:25:06 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 01:25:06 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:25:06 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 01:25:06 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:25:06 INFO - 'talos_options': ['--disable-e10s'], 01:25:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:25:06 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:25:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:25:06 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:25:06 INFO - 'talos_options': ['--disable-e10s'], 01:25:06 INFO - 'tests': ['damp', 'tps']}, 01:25:06 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:25:06 INFO - 'tests': ['damp', 'tps']}, 01:25:06 INFO - 'g3': {'talos_options': ['--disable-e10s'], 01:25:06 INFO - 'tests': ['dromaeo_dom']}, 01:25:06 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:25:06 INFO - 'g4': {'talos_options': ['--disable-e10s'], 01:25:06 INFO - 'tests': ['basic_compositor_video']}, 01:25:06 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 01:25:06 INFO - 'other': {'talos_options': ['--disable-e10s'], 01:25:06 INFO - 'tests': ['a11yr', 01:25:06 INFO - 'ts_paint', 01:25:06 INFO - 'tpaint', 01:25:06 INFO - 'sessionrestore', 01:25:06 INFO - 'sessionrestore_no_auto_restore', 01:25:06 INFO - 'tabpaint']}, 01:25:06 INFO - 'other-e10s': {'tests': ['a11yr', 01:25:06 INFO - 'ts_paint', 01:25:06 INFO - 'tpaint', 01:25:06 INFO - 'sessionrestore', 01:25:06 INFO - 'sessionrestore_no_auto_restore', 01:25:06 INFO - 'tabpaint']}, 01:25:06 INFO - 'other-e10s_l64': {'tests': ['a11yr', 01:25:06 INFO - 'ts_paint', 01:25:06 INFO - 'tpaint', 01:25:06 INFO - 'sessionrestore', 01:25:06 INFO - 'sessionrestore_no_auto_restore', 01:25:06 INFO - 'tabpaint']}, 01:25:06 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 01:25:06 INFO - 'ts_paint', 01:25:06 INFO - 'tpaint', 01:25:06 INFO - 'sessionrestore', 01:25:06 INFO - 'sessionrestore_no_auto_restore', 01:25:06 INFO - 'tabpaint']}, 01:25:06 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 01:25:06 INFO - 'tests': ['a11yr', 01:25:06 INFO - 'ts_paint', 01:25:06 INFO - 'tpaint', 01:25:06 INFO - 'sessionrestore', 01:25:06 INFO - 'sessionrestore_no_auto_restore', 01:25:06 INFO - 'tabpaint']}, 01:25:06 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 01:25:06 INFO - 'tests': ['a11yr', 01:25:06 INFO - 'ts_paint', 01:25:06 INFO - 'tpaint', 01:25:06 INFO - 'sessionrestore', 01:25:06 INFO - 'sessionrestore_no_auto_restore', 01:25:06 INFO - 'tabpaint']}, 01:25:06 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 01:25:06 INFO - 'tests': ['tsvgx', 01:25:06 INFO - 'tsvgr_opacity', 01:25:06 INFO - 'tart', 01:25:06 INFO - 'tscrollx', 01:25:06 INFO - 'cart']}, 01:25:06 INFO - 'svgr-e10s': {'tests': ['tsvgx', 01:25:06 INFO - 'tsvgr_opacity', 01:25:06 INFO - 'tart', 01:25:06 INFO - 'tscrollx', 01:25:06 INFO - 'cart']}, 01:25:06 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:25:06 INFO - 'talos_options': ['--disable-e10s'], 01:25:06 INFO - 'tests': ['tp5o']}, 01:25:06 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:25:06 INFO - 'tests': ['tp5o']}, 01:25:06 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:25:06 INFO - 'talos_options': ['--disable-e10s', 01:25:06 INFO - '--xperf_path', 01:25:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:25:06 INFO - 'tests': ['tp5n']}, 01:25:06 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:25:06 INFO - 'talos_options': ['--xperf_path', 01:25:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:25:06 INFO - 'tests': ['tp5n']}}, 01:25:06 INFO - 'talos.zip': {'path': '', 01:25:06 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:25:06 INFO - Running post-action listener: _resource_record_post_action 01:25:06 INFO - [mozharness: 2016-10-06 08:25:06.506224Z] Finished populate-webroot step (success) 01:25:06 INFO - [mozharness: 2016-10-06 08:25:06.506312Z] Running create-virtualenv step. 01:25:06 INFO - Running pre-action listener: _resource_record_pre_action 01:25:06 INFO - Running main action method: create_virtualenv 01:25:06 INFO - Creating virtualenv /builds/slave/test/build/venv 01:25:06 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 01:25:06 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:25:06 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:25:06 INFO - Using real prefix '/usr' 01:25:06 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:25:07 INFO - Installing distribute.............................................................................................................................................................................................done. 01:25:09 INFO - Installing pip.................done. 01:25:09 INFO - Return code: 0 01:25:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 01:25:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 01:25:09 INFO - Reading from file tmpfile_stdout 01:25:09 INFO - Output received: 01:25:09 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) 01:25:09 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:25:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:25:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:25:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:25:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:25:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:25:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:25:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f53e6f56f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13ddca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13daf60>, '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 0x13dbd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13dc1d0>, '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': 'd2a8c569965ab8367867b893000001a1-1475742197.669836-1520761353', '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 01:25:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 01:25:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 01:25:09 INFO - Using env: {'DISPLAY': ':0', 01:25:09 INFO - 'HOME': '/home/cltbld', 01:25:09 INFO - 'LANG': 'en_US.UTF-8', 01:25:09 INFO - 'LANGUAGE': 'en_US:en', 01:25:09 INFO - 'LOGNAME': 'cltbld', 01:25:09 INFO - 'MAIL': '/var/mail/cltbld', 01:25:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:25:09 INFO - 'MOZ_NO_REMOTE': '1', 01:25:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:25:09 INFO - 'NO_EM_RESTART': '1', 01:25:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:25:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:25:09 INFO - 'PWD': '/builds/slave/test', 01:25:09 INFO - 'SHELL': '/bin/bash', 01:25:09 INFO - 'SHLVL': '1', 01:25:09 INFO - 'TERM': 'linux', 01:25:09 INFO - 'TMOUT': '86400', 01:25:09 INFO - 'USER': 'cltbld', 01:25:09 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1475742197.669836-1520761353', 01:25:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:25:09 INFO - '_': '/tools/buildbot/bin/python'} 01:25:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:25:09 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 01:25:09 INFO - Cleaning up... 01:25:09 INFO - Return code: 0 01:25:09 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 01:25:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:25:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:25:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:25:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:25:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:25:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:25:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f53e6f56f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13ddca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13daf60>, '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 0x13dbd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13dc1d0>, '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': 'd2a8c569965ab8367867b893000001a1-1475742197.669836-1520761353', '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 01:25:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 01:25:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 01:25:09 INFO - Using env: {'DISPLAY': ':0', 01:25:09 INFO - 'HOME': '/home/cltbld', 01:25:09 INFO - 'LANG': 'en_US.UTF-8', 01:25:09 INFO - 'LANGUAGE': 'en_US:en', 01:25:09 INFO - 'LOGNAME': 'cltbld', 01:25:09 INFO - 'MAIL': '/var/mail/cltbld', 01:25:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:25:09 INFO - 'MOZ_NO_REMOTE': '1', 01:25:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:25:09 INFO - 'NO_EM_RESTART': '1', 01:25:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:25:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:25:09 INFO - 'PWD': '/builds/slave/test', 01:25:09 INFO - 'SHELL': '/bin/bash', 01:25:09 INFO - 'SHLVL': '1', 01:25:09 INFO - 'TERM': 'linux', 01:25:09 INFO - 'TMOUT': '86400', 01:25:09 INFO - 'USER': 'cltbld', 01:25:09 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1475742197.669836-1520761353', 01:25:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:25:09 INFO - '_': '/tools/buildbot/bin/python'} 01:25:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:25:09 INFO - Downloading/unpacking psutil>=3.1.1 01:25:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:25:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:25:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:25:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:25:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:25:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:25:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:25:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:25:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:25:11 INFO - Installing collected packages: psutil 01:25:11 INFO - Running setup.py install for psutil 01:25:11 INFO - building 'psutil._psutil_linux' extension 01:25:11 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 01:25:12 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 01:25:12 INFO - building 'psutil._psutil_posix' extension 01:25:12 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 01:25:12 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 01:25:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:25:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:25:12 INFO - Successfully installed psutil 01:25:12 INFO - Cleaning up... 01:25:12 INFO - Return code: 0 01:25:12 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 01:25: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')]} 01:25:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:25:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:25: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')]} 01:25:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:25:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:25: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f53e6f56f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13ddca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13daf60>, '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 0x13dbd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13dc1d0>, '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': 'd2a8c569965ab8367867b893000001a1-1475742197.669836-1520761353', '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 01:25: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 01:25: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 mozsystemmonitor==0.3 01:25:12 INFO - Using env: {'DISPLAY': ':0', 01:25:12 INFO - 'HOME': '/home/cltbld', 01:25:12 INFO - 'LANG': 'en_US.UTF-8', 01:25:12 INFO - 'LANGUAGE': 'en_US:en', 01:25:12 INFO - 'LOGNAME': 'cltbld', 01:25:12 INFO - 'MAIL': '/var/mail/cltbld', 01:25:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:25:12 INFO - 'MOZ_NO_REMOTE': '1', 01:25:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:25:12 INFO - 'NO_EM_RESTART': '1', 01:25:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:25:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:25:12 INFO - 'PWD': '/builds/slave/test', 01:25:12 INFO - 'SHELL': '/bin/bash', 01:25:12 INFO - 'SHLVL': '1', 01:25:12 INFO - 'TERM': 'linux', 01:25:12 INFO - 'TMOUT': '86400', 01:25:12 INFO - 'USER': 'cltbld', 01:25:12 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1475742197.669836-1520761353', 01:25:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:25:12 INFO - '_': '/tools/buildbot/bin/python'} 01:25:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:25:12 INFO - Downloading/unpacking mozsystemmonitor==0.3 01:25: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 01:25: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 01:25: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 01:25: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 01:25: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 01:25: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 01:25:14 INFO - Downloading mozsystemmonitor-0.3.tar.gz 01:25:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:25:14 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 01:25:14 INFO - Installing collected packages: mozsystemmonitor 01:25:14 INFO - Running setup.py install for mozsystemmonitor 01:25:14 INFO - Successfully installed mozsystemmonitor 01:25:14 INFO - Cleaning up... 01:25:14 INFO - Return code: 0 01:25:14 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 01:25:14 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')]} 01:25:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:25:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:25:14 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')]} 01:25:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:25:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:25:14 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 0x7f53e6f56f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13ddca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13daf60>, '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 0x13dbd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13dc1d0>, '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': 'd2a8c569965ab8367867b893000001a1-1475742197.669836-1520761353', '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 01:25:14 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 01:25:14 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 01:25:14 INFO - Using env: {'DISPLAY': ':0', 01:25:14 INFO - 'HOME': '/home/cltbld', 01:25:14 INFO - 'LANG': 'en_US.UTF-8', 01:25:14 INFO - 'LANGUAGE': 'en_US:en', 01:25:14 INFO - 'LOGNAME': 'cltbld', 01:25:14 INFO - 'MAIL': '/var/mail/cltbld', 01:25:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:25:14 INFO - 'MOZ_NO_REMOTE': '1', 01:25:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:25:14 INFO - 'NO_EM_RESTART': '1', 01:25:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:25:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:25:14 INFO - 'PWD': '/builds/slave/test', 01:25:14 INFO - 'SHELL': '/bin/bash', 01:25:14 INFO - 'SHLVL': '1', 01:25:14 INFO - 'TERM': 'linux', 01:25:14 INFO - 'TMOUT': '86400', 01:25:14 INFO - 'USER': 'cltbld', 01:25:14 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1475742197.669836-1520761353', 01:25:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:25:14 INFO - '_': '/tools/buildbot/bin/python'} 01:25:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:25:14 INFO - Downloading/unpacking jsonschema==2.5.1 01:25: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 01:25: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 01:25: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 01:25: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 01:25: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 01:25: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 01:25:16 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:25:16 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 01:25:16 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 01:25:16 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 01:25:16 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 01:25:16 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 01:25:16 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 01:25:16 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 01:25:16 INFO - Downloading functools32-3.2.3-2.tar.gz 01:25:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:25:17 INFO - warning: no files found matching '*.txt' 01:25:17 INFO - no previously-included directories found matching 'build' 01:25:17 INFO - no previously-included directories found matching 'dist' 01:25:17 INFO - no previously-included directories found matching '.git*' 01:25:17 INFO - Installing collected packages: jsonschema, functools32 01:25:17 INFO - Running setup.py install for functools32 01:25:17 INFO - warning: no files found matching '*.txt' 01:25:17 INFO - no previously-included directories found matching 'build' 01:25:17 INFO - no previously-included directories found matching 'dist' 01:25:17 INFO - no previously-included directories found matching '.git*' 01:25:17 INFO - Successfully installed jsonschema functools32 01:25:17 INFO - Cleaning up... 01:25:17 INFO - Return code: 0 01:25:17 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 01:25:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:25:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:25:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:25:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:25:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:25:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:25:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f53e6f56f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13ddca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13daf60>, '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 0x13dbd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13dc1d0>, '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': 'd2a8c569965ab8367867b893000001a1-1475742197.669836-1520761353', '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 01:25:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 01:25:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 01:25:17 INFO - Using env: {'DISPLAY': ':0', 01:25:17 INFO - 'HOME': '/home/cltbld', 01:25:17 INFO - 'LANG': 'en_US.UTF-8', 01:25:17 INFO - 'LANGUAGE': 'en_US:en', 01:25:17 INFO - 'LOGNAME': 'cltbld', 01:25:17 INFO - 'MAIL': '/var/mail/cltbld', 01:25:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:25:17 INFO - 'MOZ_NO_REMOTE': '1', 01:25:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:25:17 INFO - 'NO_EM_RESTART': '1', 01:25:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:25:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:25:17 INFO - 'PWD': '/builds/slave/test', 01:25:17 INFO - 'SHELL': '/bin/bash', 01:25:17 INFO - 'SHLVL': '1', 01:25:17 INFO - 'TERM': 'linux', 01:25:17 INFO - 'TMOUT': '86400', 01:25:17 INFO - 'USER': 'cltbld', 01:25:17 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1475742197.669836-1520761353', 01:25:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:25:17 INFO - '_': '/tools/buildbot/bin/python'} 01:25:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:25:17 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 01:25:17 INFO - Cleaning up... 01:25:17 INFO - Return code: 0 01:25:17 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:25:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:25:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:25:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:25:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:25:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:25:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:25:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f53e6f56f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13ddca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13daf60>, '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 0x13dbd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13dc1d0>, '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': 'd2a8c569965ab8367867b893000001a1-1475742197.669836-1520761353', '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 01:25:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 01:25:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 01:25:17 INFO - Using env: {'DISPLAY': ':0', 01:25:17 INFO - 'HOME': '/home/cltbld', 01:25:17 INFO - 'LANG': 'en_US.UTF-8', 01:25:17 INFO - 'LANGUAGE': 'en_US:en', 01:25:17 INFO - 'LOGNAME': 'cltbld', 01:25:17 INFO - 'MAIL': '/var/mail/cltbld', 01:25:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:25:17 INFO - 'MOZ_NO_REMOTE': '1', 01:25:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:25:17 INFO - 'NO_EM_RESTART': '1', 01:25:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:25:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:25:17 INFO - 'PWD': '/builds/slave/test', 01:25:17 INFO - 'SHELL': '/bin/bash', 01:25:17 INFO - 'SHLVL': '1', 01:25:17 INFO - 'TERM': 'linux', 01:25:17 INFO - 'TMOUT': '86400', 01:25:17 INFO - 'USER': 'cltbld', 01:25:17 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1475742197.669836-1520761353', 01:25:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:25:17 INFO - '_': '/tools/buildbot/bin/python'} 01:25:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:25:17 INFO - Downloading/unpacking blobuploader==1.2.4 01:25: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 01:25: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 01:25: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 01:25: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 01:25: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 01:25: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 01:25:19 INFO - Downloading blobuploader-1.2.4.tar.gz 01:25:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:25:19 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:25:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:25:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:25:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:25:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:25:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:25:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:25:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:25:20 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:25:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:25:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:25:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:25:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:25:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:25:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:25:20 INFO - Downloading docopt-0.6.1.tar.gz 01:25:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:25:20 INFO - Installing collected packages: blobuploader, requests, docopt 01:25:20 INFO - Running setup.py install for blobuploader 01:25:20 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:25:20 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:25:20 INFO - Running setup.py install for requests 01:25:20 INFO - Running setup.py install for docopt 01:25:20 INFO - Successfully installed blobuploader requests docopt 01:25:20 INFO - Cleaning up... 01:25:20 INFO - Return code: 0 01:25:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:25:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:25:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:25:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:25:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:25:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:25:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:25:20 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 0x7f53e6f56f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13ddca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13daf60>, '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 0x13dbd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13dc1d0>, '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': 'd2a8c569965ab8367867b893000001a1-1475742197.669836-1520761353', '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 01:25:20 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 01:25:20 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 01:25:20 INFO - Using env: {'DISPLAY': ':0', 01:25:20 INFO - 'HOME': '/home/cltbld', 01:25:20 INFO - 'LANG': 'en_US.UTF-8', 01:25:20 INFO - 'LANGUAGE': 'en_US:en', 01:25:20 INFO - 'LOGNAME': 'cltbld', 01:25:20 INFO - 'MAIL': '/var/mail/cltbld', 01:25:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:25:20 INFO - 'MOZ_NO_REMOTE': '1', 01:25:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:25:20 INFO - 'NO_EM_RESTART': '1', 01:25:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:25:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:25:20 INFO - 'PWD': '/builds/slave/test', 01:25:20 INFO - 'SHELL': '/bin/bash', 01:25:20 INFO - 'SHLVL': '1', 01:25:20 INFO - 'TERM': 'linux', 01:25:20 INFO - 'TMOUT': '86400', 01:25:20 INFO - 'USER': 'cltbld', 01:25:20 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1475742197.669836-1520761353', 01:25:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:25:20 INFO - '_': '/tools/buildbot/bin/python'} 01:25:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:25:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:25:21 INFO - Running setup.py (path:/tmp/pip-yZbG2H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:25:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:25:21 INFO - Running setup.py (path:/tmp/pip-jWY_UX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:25:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:25:21 INFO - Running setup.py (path:/tmp/pip-o3AMQX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:25:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:25:21 INFO - Running setup.py (path:/tmp/pip-x996y4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:25:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:25:21 INFO - Running setup.py (path:/tmp/pip-56Rh6d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:25:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:25:21 INFO - Running setup.py (path:/tmp/pip-epZUe0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:25:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:25:21 INFO - Running setup.py (path:/tmp/pip-cPVObT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:25:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:25:21 INFO - Running setup.py (path:/tmp/pip-J40YgW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:25:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:25:21 INFO - Running setup.py (path:/tmp/pip-zuwNaF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:25:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:25:21 INFO - Running setup.py (path:/tmp/pip-UJDAa3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:25:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:25:21 INFO - Running setup.py (path:/tmp/pip-VAWlDV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:25:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:25:21 INFO - Running setup.py (path:/tmp/pip-I2wx5c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:25:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:25:22 INFO - Running setup.py (path:/tmp/pip-rfV0L8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:25:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:25:22 INFO - Running setup.py (path:/tmp/pip-SpFO3A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:25:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:25:22 INFO - Running setup.py (path:/tmp/pip-HzDeCe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:25:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:25:22 INFO - Running setup.py (path:/tmp/pip-ak7Ha4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:25:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:25:22 INFO - Running setup.py (path:/tmp/pip-OPXHYx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:25:22 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:25:22 INFO - Running setup.py install for manifestparser 01:25:22 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:25:22 INFO - Running setup.py install for mozcrash 01:25:22 INFO - Running setup.py install for mozdebug 01:25:22 INFO - Running setup.py install for mozdevice 01:25:22 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:25:22 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:25:22 INFO - Running setup.py install for mozfile 01:25:22 INFO - Running setup.py install for mozhttpd 01:25:22 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:25:22 INFO - Running setup.py install for mozinfo 01:25:23 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:25:23 INFO - Running setup.py install for mozInstall 01:25:23 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:25:23 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:25:23 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:25:23 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:25:23 INFO - Running setup.py install for mozleak 01:25:23 INFO - Running setup.py install for mozlog 01:25:23 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:25:23 INFO - Running setup.py install for moznetwork 01:25:23 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:25:23 INFO - Running setup.py install for mozprocess 01:25:23 INFO - Running setup.py install for mozprofile 01:25:23 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:25:23 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:25:23 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:25:23 INFO - Running setup.py install for mozrunner 01:25:23 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:25:23 INFO - Running setup.py install for mozscreenshot 01:25:23 INFO - Running setup.py install for moztest 01:25:24 INFO - Running setup.py install for mozversion 01:25:24 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:25:24 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:25:24 INFO - Cleaning up... 01:25:24 INFO - Return code: 0 01:25:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:25:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:25:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:25:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:25:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:25:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:25:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:25:24 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 0x7f53e6f56f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13ddca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13daf60>, '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 0x13dbd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13dc1d0>, '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': 'd2a8c569965ab8367867b893000001a1-1475742197.669836-1520761353', '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 01:25:24 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 01:25:24 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 01:25:24 INFO - Using env: {'DISPLAY': ':0', 01:25:24 INFO - 'HOME': '/home/cltbld', 01:25:24 INFO - 'LANG': 'en_US.UTF-8', 01:25:24 INFO - 'LANGUAGE': 'en_US:en', 01:25:24 INFO - 'LOGNAME': 'cltbld', 01:25:24 INFO - 'MAIL': '/var/mail/cltbld', 01:25:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:25:24 INFO - 'MOZ_NO_REMOTE': '1', 01:25:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:25:24 INFO - 'NO_EM_RESTART': '1', 01:25:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:25:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:25:24 INFO - 'PWD': '/builds/slave/test', 01:25:24 INFO - 'SHELL': '/bin/bash', 01:25:24 INFO - 'SHLVL': '1', 01:25:24 INFO - 'TERM': 'linux', 01:25:24 INFO - 'TMOUT': '86400', 01:25:24 INFO - 'USER': 'cltbld', 01:25:24 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1475742197.669836-1520761353', 01:25:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:25:24 INFO - '_': '/tools/buildbot/bin/python'} 01:25:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:25:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:25:24 INFO - Running setup.py (path:/tmp/pip-52eLNv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:25:24 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)) 01:25:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:25:24 INFO - Running setup.py (path:/tmp/pip-TKBRQg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:25:24 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)) 01:25:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:25:24 INFO - Running setup.py (path:/tmp/pip-tWo9IG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:25:24 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)) 01:25:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:25:24 INFO - Running setup.py (path:/tmp/pip-i6jHeo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:25:24 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)) 01:25:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:25:24 INFO - Running setup.py (path:/tmp/pip-y3q27Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:25:24 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)) 01:25:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:25:24 INFO - Running setup.py (path:/tmp/pip-QUARz4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:25:24 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)) 01:25:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:25:24 INFO - Running setup.py (path:/tmp/pip-3RxovI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:25:24 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)) 01:25:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:25:24 INFO - Running setup.py (path:/tmp/pip-SL4Koa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:25:24 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)) 01:25:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:25:24 INFO - Running setup.py (path:/tmp/pip-nEt0BA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:25:25 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)) 01:25:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:25:25 INFO - Running setup.py (path:/tmp/pip-Wd8CBQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:25:25 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)) 01:25:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:25:25 INFO - Running setup.py (path:/tmp/pip-J3E5WZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:25:25 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)) 01:25:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:25:25 INFO - Running setup.py (path:/tmp/pip-jhX8Ps-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:25:25 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)) 01:25:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:25:25 INFO - Running setup.py (path:/tmp/pip-7Vleja-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:25:25 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)) 01:25:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:25:25 INFO - Running setup.py (path:/tmp/pip-RUopWQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:25:25 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)) 01:25:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:25:25 INFO - Running setup.py (path:/tmp/pip-jMt8BB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:25:25 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)) 01:25:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:25:25 INFO - Running setup.py (path:/tmp/pip-RKtG4C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:25:25 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)) 01:25:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:25:25 INFO - Running setup.py (path:/tmp/pip-4IFS8b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:25:25 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)) 01:25:25 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)) 01:25:25 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)) 01:25:25 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)) 01:25:25 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)) 01:25:25 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)) 01:25:25 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:25:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:25:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:25:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:25:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:25:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:25:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:25:27 INFO - Downloading blessings-1.6.tar.gz 01:25:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:25:27 INFO - Installing collected packages: blessings 01:25:27 INFO - Running setup.py install for blessings 01:25:27 INFO - Successfully installed blessings 01:25:27 INFO - Cleaning up... 01:25:27 INFO - Return code: 0 01:25:27 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:25:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:25:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:25:28 INFO - Reading from file tmpfile_stdout 01:25:28 INFO - Current package versions: 01:25:28 INFO - argparse == 1.2.1 01:25:28 INFO - blessings == 1.6 01:25:28 INFO - blobuploader == 1.2.4 01:25:28 INFO - docopt == 0.6.1 01:25:28 INFO - functools32 == 3.2.3-2 01:25:28 INFO - jsonschema == 2.5.1 01:25:28 INFO - manifestparser == 1.1 01:25:28 INFO - mozInstall == 1.12 01:25:28 INFO - mozcrash == 0.17 01:25:28 INFO - mozdebug == 0.1 01:25:28 INFO - mozdevice == 0.48 01:25:28 INFO - mozfile == 1.2 01:25:28 INFO - mozhttpd == 0.7 01:25:28 INFO - mozinfo == 0.9 01:25:28 INFO - mozleak == 0.1 01:25:28 INFO - mozlog == 3.4 01:25:28 INFO - moznetwork == 0.27 01:25:28 INFO - mozprocess == 0.23 01:25:28 INFO - mozprofile == 0.28 01:25:28 INFO - mozrunner == 6.12 01:25:28 INFO - mozscreenshot == 0.1 01:25:28 INFO - mozsystemmonitor == 0.3 01:25:28 INFO - moztest == 0.7 01:25:28 INFO - mozversion == 1.4 01:25:28 INFO - psutil == 3.1.1 01:25:28 INFO - requests == 1.2.3 01:25:28 INFO - wsgiref == 0.1.2 01:25:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:25:28 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')]} 01:25:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:25:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:25:28 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')]} 01:25:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:25:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:25:28 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 0x7f53e6f56f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13ddca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13daf60>, '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 0x13dbd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13dc1d0>, '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': 'd2a8c569965ab8367867b893000001a1-1475742197.669836-1520761353', '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 01:25:28 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 01:25:28 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 01:25:28 INFO - Using env: {'DISPLAY': ':0', 01:25:28 INFO - 'HOME': '/home/cltbld', 01:25:28 INFO - 'LANG': 'en_US.UTF-8', 01:25:28 INFO - 'LANGUAGE': 'en_US:en', 01:25:28 INFO - 'LOGNAME': 'cltbld', 01:25:28 INFO - 'MAIL': '/var/mail/cltbld', 01:25:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:25:28 INFO - 'MOZ_NO_REMOTE': '1', 01:25:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:25:28 INFO - 'NO_EM_RESTART': '1', 01:25:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:25:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:25:28 INFO - 'PWD': '/builds/slave/test', 01:25:28 INFO - 'SHELL': '/bin/bash', 01:25:28 INFO - 'SHLVL': '1', 01:25:28 INFO - 'TERM': 'linux', 01:25:28 INFO - 'TMOUT': '86400', 01:25:28 INFO - 'USER': 'cltbld', 01:25:28 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1475742197.669836-1520761353', 01:25:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:25:28 INFO - '_': '/tools/buildbot/bin/python'} 01:25:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:25:28 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)) 01:25:28 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)) 01:25:28 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)) 01:25:28 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)) 01:25:28 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)) 01:25:28 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)) 01:25:28 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)) 01:25:28 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)) 01:25:28 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)) 01:25:28 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)) 01:25:28 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)) 01:25:28 INFO - Cleaning up... 01:25:28 INFO - Return code: 0 01:25:28 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:25:28 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')]} 01:25:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:25:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:25:28 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')]} 01:25:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:25:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:25:28 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 0x7f53e6f56f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13ddca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13daf60>, '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 0x13dbd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13dc1d0>, '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': 'd2a8c569965ab8367867b893000001a1-1475742197.669836-1520761353', '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 01:25:28 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 01:25:28 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 01:25:28 INFO - Using env: {'DISPLAY': ':0', 01:25:28 INFO - 'HOME': '/home/cltbld', 01:25:28 INFO - 'LANG': 'en_US.UTF-8', 01:25:28 INFO - 'LANGUAGE': 'en_US:en', 01:25:28 INFO - 'LOGNAME': 'cltbld', 01:25:28 INFO - 'MAIL': '/var/mail/cltbld', 01:25:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:25:28 INFO - 'MOZ_NO_REMOTE': '1', 01:25:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:25:28 INFO - 'NO_EM_RESTART': '1', 01:25:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:25:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:25:28 INFO - 'PWD': '/builds/slave/test', 01:25:28 INFO - 'SHELL': '/bin/bash', 01:25:28 INFO - 'SHLVL': '1', 01:25:28 INFO - 'TERM': 'linux', 01:25:28 INFO - 'TMOUT': '86400', 01:25:28 INFO - 'USER': 'cltbld', 01:25:28 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1475742197.669836-1520761353', 01:25:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:25:28 INFO - '_': '/tools/buildbot/bin/python'} 01:25:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:25:28 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 01:25:28 INFO - Cleaning up... 01:25:28 INFO - Return code: 0 01:25:28 INFO - Running post-action listener: _resource_record_post_action 01:25:28 INFO - Running post-action listener: _start_resource_monitoring 01:25:28 INFO - Starting resource monitoring. 01:25:28 INFO - [mozharness: 2016-10-06 08:25:28.501577Z] Finished create-virtualenv step (success) 01:25:28 INFO - [mozharness: 2016-10-06 08:25:28.502044Z] Running install step. 01:25:28 INFO - Running pre-action listener: _resource_record_pre_action 01:25:28 INFO - Running main action method: install 01:25:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:25:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:25:28 INFO - Reading from file tmpfile_stdout 01:25:28 INFO - Detecting whether we're running mozinstall >=1.0... 01:25:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:25:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:25:28 INFO - Reading from file tmpfile_stdout 01:25:28 INFO - Output received: 01:25:28 INFO - Usage: mozinstall [options] installer 01:25:28 INFO - Options: 01:25:28 INFO - -h, --help show this help message and exit 01:25:28 INFO - -d DEST, --destination=DEST 01:25:28 INFO - Directory to install application into. [default: 01:25:28 INFO - "/builds/slave/test"] 01:25:28 INFO - --app=APP Application being installed. [default: firefox] 01:25:28 INFO - mkdir: /builds/slave/test/build/application 01:25:28 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'] 01:25:28 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 01:25:44 INFO - Reading from file tmpfile_stdout 01:25:44 INFO - Output received: 01:25:44 INFO - /builds/slave/test/build/application/firefox/firefox 01:25:44 INFO - Running post-action listener: _resource_record_post_action 01:25:44 INFO - [mozharness: 2016-10-06 08:25:44.929663Z] Finished install step (success) 01:25:44 INFO - [mozharness: 2016-10-06 08:25:44.929908Z] Running run-tests step. 01:25:44 INFO - Running pre-action listener: _resource_record_pre_action 01:25:44 INFO - Running main action method: run_tests 01:25:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:25:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:25:44 INFO - Python 2.7.3 01:25:44 INFO - Return code: 0 01:25:44 INFO - grabbing minidump binary from tooltool 01:25:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:25:44 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 0x13daf60>, '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 0x13dbd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13dc1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:25:44 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 01:25:44 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 01:25:44 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 01:25:44 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:25:45 INFO - Return code: 0 01:25:45 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 01:25:45 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:25:45 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:25:45 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 01:25:45 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:25:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Xqwh8lx_QsitZ6zErCy22g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-043', '--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 01:25:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Xqwh8lx_QsitZ6zErCy22g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-043 --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 01:25:45 INFO - Using env: {'DISPLAY': ':0', 01:25:45 INFO - 'HOME': '/home/cltbld', 01:25:45 INFO - 'LANG': 'en_US.UTF-8', 01:25:45 INFO - 'LANGUAGE': 'en_US:en', 01:25:45 INFO - 'LOGNAME': 'cltbld', 01:25:45 INFO - 'MAIL': '/var/mail/cltbld', 01:25:45 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:25:45 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 01:25:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:25:45 INFO - 'MOZ_NO_REMOTE': '1', 01:25:45 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:25:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:25:45 INFO - 'NO_EM_RESTART': '1', 01:25:45 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:25:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:25:45 INFO - 'PWD': '/builds/slave/test', 01:25:45 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:25:45 INFO - 'SHELL': '/bin/bash', 01:25:45 INFO - 'SHLVL': '1', 01:25:45 INFO - 'TERM': 'linux', 01:25:45 INFO - 'TMOUT': '86400', 01:25:45 INFO - 'USER': 'cltbld', 01:25:45 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1475742197.669836-1520761353', 01:25:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:25:45 INFO - '_': '/tools/buildbot/bin/python'} 01:25:45 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Xqwh8lx_QsitZ6zErCy22g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-043', '--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 01:25:45 INFO - mozversion application_buildid: 20161005234100 01:25:45 INFO - mozversion application_changeset: cc3ee8d499c511c6fa189fe15b5fea6a57f01382 01:25:45 INFO - mozversion application_display_name: Nightly 01:25:45 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:25:45 INFO - mozversion application_name: Firefox 01:25:45 INFO - mozversion application_remotingname: firefox 01:25:45 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 01:25:45 INFO - mozversion application_vendor: Mozilla 01:25:45 INFO - mozversion application_version: 52.0a1 01:25:45 INFO - mozversion platform_buildid: 20161005234100 01:25:45 INFO - mozversion platform_changeset: cc3ee8d499c511c6fa189fe15b5fea6a57f01382 01:25:45 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 01:25:45 INFO - mozversion platform_version: 52.0a1 01:25:45 INFO - using testdate: 1475742345 01:25:45 INFO - actual date: 1475742345 01:25:45 INFO - starting webserver on 'localhost:54826' 01:25:45 INFO - SUITE-START | Running 2 tests 01:25:45 INFO - TEST-START | dromaeo_css 01:25:45 INFO - operating with platform_type : linux_ 01:25:45 INFO - Initialising browser for dromaeo_css test... 01:25:45 INFO - TEST-INFO | started process 4802 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpq0qjsc/profile http://localhost:54826/getInfo.html) 01:25:50 INFO - PROCESS | 4802 | __metrics Screen width/height:1600/1200 01:25:50 INFO - PROCESS | 4802 | colorDepth:24 01:25:50 INFO - PROCESS | 4802 | Browser inner width/height: 1024/697 01:25:50 INFO - PROCESS | 4802 | __metrics 01:25:50 INFO - PROCESS | 4802 | 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" 01:25:50 INFO - PROCESS | 4802 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:25:51 INFO - PROCESS | 4802 | console.error: PushService: 01:25:51 INFO - PROCESS | 4802 | stateChangeProcessEnqueue: Error transitioning state 01:25:51 INFO - PROCESS | 4802 | UnknownError 01:25:52 INFO - TEST-INFO | 4802: exit 0 01:25:52 INFO - Browser initialized. 01:25:52 INFO - Running cycle 1/1 for dromaeo_css test... 01:25:52 INFO - TEST-INFO | started process 4882 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpq0qjsc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:26:04 INFO - PROCESS | 4882 | RSS: Main: 174993408 01:26:04 INFO - PROCESS | 4882 | 01:26:55 INFO - PROCESS | 4882 | 1475742415534 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] 01:29:09 INFO - PROCESS | 4882 | Cycle 1(1): loaded http://localhost:54826/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54826/tests/dromaeo/cssquery-ext.html) 01:29:10 INFO - PROCESS | 4882 | RSS: Main: 293097472 01:29:10 INFO - PROCESS | 4882 | 01:32:13 INFO - PROCESS | 4882 | Cycle 1(1): loaded http://localhost:54826/tests/dromaeo/cssquery-ext.html (next: http://localhost:54826/tests/dromaeo/cssquery-jquery.html) 01:32:14 INFO - PROCESS | 4882 | RSS: Main: 272818176 01:32:14 INFO - PROCESS | 4882 | 01:35:16 INFO - PROCESS | 4882 | Cycle 1(1): loaded http://localhost:54826/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54826/tests/dromaeo/cssquery-mootools.html) 01:35:16 INFO - PROCESS | 4882 | RSS: Main: 218492928 01:35:16 INFO - PROCESS | 4882 | 01:38:19 INFO - PROCESS | 4882 | Cycle 1(1): loaded http://localhost:54826/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54826/tests/dromaeo/cssquery-prototype.html) 01:38:19 INFO - PROCESS | 4882 | RSS: Main: 223711232 01:38:19 INFO - PROCESS | 4882 | 01:41:22 INFO - PROCESS | 4882 | Cycle 1(1): loaded http://localhost:54826/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54826/tests/dromaeo/cssquery-yui.html) 01:41:23 INFO - PROCESS | 4882 | RSS: Main: 219918336 01:41:23 INFO - PROCESS | 4882 | 01:44:26 INFO - PROCESS | 4882 | Cycle 1(1): loaded http://localhost:54826/tests/dromaeo/cssquery-yui.html (next: http://localhost:54826/tests/dromaeo/cssquery-dojo.html) 01:44:26 INFO - PROCESS | 4882 | RSS: Main: 300695552 01:44:26 INFO - PROCESS | 4882 | 01:44:26 INFO - PROCESS | 4882 | __start_tp_report 01:44:26 INFO - PROCESS | 4882 | _x_x_mozilla_page_load 01:44:26 INFO - PROCESS | 4882 | _x_x_mozilla_page_load_details 01:44:26 INFO - PROCESS | 4882 | |i|pagename|runs| 01:44:26 INFO - PROCESS | 4882 | |0;dojo.html;2541.834780739253;2552.3746682062897;2591.6630837991056;2593.364625666712;2613.0592986524834;4552.24887893498;4603.079384123176;4603.700759450638;4603.930941035887;4648.976755116224;4642.141203877285;4653.69750966187;4695.3191787190835;4698.812047518095;4768.022555376148;4288.206681763868;4310;4310.267254566716;4344.174606824693;4394.978025109886;4291.356296555526;4351;4403.823847046115;4406.779661016953;4430.800613972363;4184.790760461965;4344.89137771555;4352.17308711347;4368.279233926399;4449;4173.332266837322;4228.429162063113;4263.97868010661;4288.935665965013;4320.049589090427;4212.178625168093;4213.557576454489;4214.578542145761;4215.45199124115;4264.509581398148;4629.930551041737;4651.88370290742;4653.208954477747;4663.300504924288;4717.386739723814;4910.140725373081;4945.936623625902;4960.181570040939;5003.824101336183;5025.924611130836;5056.797728090872;5073;5082;5091.1090559152;5133.743312834344;4732.410674625544;4732.976335118303;4733.83431579893;4734.431868175841;4740.976295118502;5027.522385373383;5084.313617661643;5127.3847138343635;5174.508421699932;5253.028189784825;4961.950380496221;4968.701877887338;4975.651704380659;4998.550130488274;5034.874128146826;5047.823326183566;5057.898842023139;5064.696118232918;5065.670731402521;5127.64106512548;4812.879678008007;4860.562549370574;4902.362692849907;4991.775370108354;5008.12357837377;4921.138800709861;5007.223880298487;5007.574356179693;5008.198688209869;5013.197888337849;4172;4177.624013838708;4181.351890456984;4188.518320393133;4234.851780187741;3695.020819482839;3696.6488183622514;3699.6300369962787;3725.906852328659;3729.4219395993664;4289.721168124062;4326.026644005074;4327.2643650579475;4346.695731298779;4374.21264172452;5058.620603454756;5060.620453466005;5070.898582028412;5108.744562771846;5116.718580478035;4369.694121411534;4383.978080109579;4387.627051700578;4402.603765661106;4403.581659742319;4372.562743725602;4403.471583409947;4416.381706561084;4514;4523.886902827456;4623.791929363254;4715.104130215248;4753.857384278477;4810.254410566367;4810.494898035796;4994.051130285234;4997.375328083989;5004.524570165829;5007.37407824022;5069.518395752398;4755.643326750438;4759.500252473579;4768.213244814567;4768.76156192196;4831.806727730851;4808.975955120202;4860.659753817199;4883.804647814048;4927.975360123177;4943.036107958914;5011.84964451067;5014.623903207201;5022.171341728574;5061.620378471555;5089.465606111453;4870.488598697086;4873.293372461044;4876.463589005136;4877.731724755173;4903.975480122576;4756.9048619026735;4764.8332308369045;4857.635677324144;4879;4926.704397736147;4845.563899249085;4846.224604063333;4853.223484242504;4910.7544622768;4922.803087876445;4917.1149193145575;4931.087748766489;4931.235658472942;4954.752262386938;4984.4517103117905;4636.768161591975;4661.906761864676;4855.854324370274;4871.858424627005;4915.066137433876 01:44:26 INFO - PROCESS | 4882 | |1;ext.html;557.3367692445989;557.9888402231956;560.3276068717535;569.1945896556373;574.3940143148977;27365.31586710331;37272;39095.60904390955;39138.21723565527;42351.78824105883;37808;38083;38109.61890381095;38163.80918095406;38212.617873821255;7523.360514356273;7699.230076992312;7700.268474494914;7702.4993375430695;7704.614769261514;7619;7703.768886933373;7708.38332933364;7709.344705700022;7713.845723085535;7723.111842138142;7768.805779855492;7773.416993725465;7777.650005749755;7778.222177782233;7668.961655191716;7706.961465192694;7708.460407771458;7713.96143019287;7721.65252563636;7630.38956883448;7699.615019249015;7701;7704.075510938723;7707.730229441942;36378.45432318517;36699.348529316245;36723;36731.81634091812;36753.26493470142;2615.463829914882;2659.494696007772;2681.825681330707;2816.957745633817;3030.9393812123635;27246.45507089847;27387.45225095507;27485.587716184273;27656;28323.85838070817;3480.147363895862;3527.188746588299;3533.94699079514;3547.467879818022;3596.1908570571672;246606;247162;247825;248014;248078;48599;49202.50797491979;49205.75397122991;49251.50748492469;49267.753661231465;32168.356632867213;33589.49615755765;52989.470105299224;53003.734981324844;53110.73444632829;13802.309884505734;14219.289035548181;14220.644483887985;14221.715565688835;14221.715565688835;10524.894751052545;10612.734681633021;10625.415602141802;10627.202959778047;10630.734231644115;17443.21505532254;17451.82548174502;17461.38885139014;17472.301107955795;17539.386121485943;6414.550981431255;6486.902696459557;6510.414062734377;6723.495737819683;6736.360045795642;775.8681024225895;914.5107367558458;938.957746901391;939.2673714502699;950.6957773512548;26989.865050675013;27610.585841212396;27835.16494505168;28082.85958570194;28126.71873281241;941.2140862379989;942.835003874333;942.9104235097655;959.9520023998772;995.6266400099962;13676.247806370546;14501;14704.558863233906;14923.477678281208;15101.281769281635;127111;127965;128155;128666.35666821606;128789.35605321913;48810.755946220044;49209;49304.50695493071;49342.50657493379;49450;1055.7941201465794;1084.1706094837455;1111.9221654484109;1126.206024752564;1147.4951021550492;27464.313392165357;28938.27654308659;29100.563491547222;29275.121746347642;29983.850080749457;39260;39863.60136398599;39872.60127398689;39912.40131397973;39994;275158;275185;275660;276918;277230;21582.136714531243;22415.103395863982;23067;24165.395865103514;24184.63723044191;39900.2019959605;39936;40101.79949100353;40534;41539.58460415357;34368;34622.82688586541;35072.64927350694;35168.64831351654;35377.64622353847;34280;34503.4824477638;34571.30857382788;34601.82699086489;35056.47415288722;34200;34406.65593344034;34540.48189277213;34622.82688586541;35289.64710352966;29121.271968200963;31366;31381.52927706132;31411.37177256488;31630.525542117346;24217.515649686557;24278.757212428358;24331.39171520726;24674.629880552166;24970 01:44:26 INFO - PROCESS | 4882 | |2;jquery.html;342.1685304709555;354.59753180140547;365.3442071481691;367.84734335250874;378.1548239684305;12174.573889913854;15295.617609559753;15708.607284817885;17223.397181098662;17464;14738.484153054618;16493.752593711102;16580.585485362873;16878.324867005304;17002.659946801086;4097.569755175708;4910.508949105088;5063.316452278932;5070.163423035195;5094.847154585368;5065.164247899111;5092.236164575324;5122.590192784587;5161.561267292284;5162.277281180638;4500.077484115748;4527.569880861313;4707.340972263886;5089.440161582223;5094.057599344114;5001.424836143854;5060.671056381323;5073.213651883945;5075.517825806561;5079.263506791532;4359.934600980988;4451.953790859146;4484.663650226246;4517.480489743656;4527.547245275479;19662;20211.292604758764;20248.89875550613;20359.49101272465;20441.080151393224;1882.6517094337592;1923.2307077169105;1942.2522328903474;2127.361791462555;2333.334999525144;13098.279594622292;13114;13127.277999710011;13237.13958592698;13796;1655.553000689807;1743.5379624399545;1751.816059313779;1763.6560870630233;1769.0977601423238;65754.67122664404;66559.66720166417;67252.32747672558;67657;68085;8045.919540804517;8577.356698247657;8592.269657079218;8749.693760718344;8843.513606751561;11570.42147892602;11574.189806713617;11578;11587.88412115885;11692.70768230801;6548.8362790930605;6802.829929251809;6889.655517224119;6979.651017449107;7022.438204943593;6781.186257649114;6851.965740171367;6908.5509441887125;6990.965045174741;7140.642967851587;3638.2541578976247;3667.44988251759;3689.870854520079;3746.7002639788752;3753.2118255166174;1682.621410182699;1685.570179604193;1722.3024675006643;1753.438899552131;1812.3656720148106;377.2379792818491;383.7697381571035;658.3186402073926;778.7430148051129;788.1448628238311;10110.545025473724;15717.577435784637;17367.56581085483;17476.30094796194;18195.81804181968;825.2449009156554;854.9444286121383;861.5476874640864;861.6294993153004;873.4933738431695;8993.505357205286;9554.092361225672;9587.712368628952;9623.422594644204;9807.852882206773;373572;377745;379743;382159;382931;75077;75916;76730;76749;80461.59769201117;910.981780364389;912.1471424218377;929.9070092990647;932.1238036245907;933.1415098109755;14632.634184145481;14665.193414361886;15066;15282.548157925425;15525.702275938122;35474.467882982295;35995.46006809952;36192.638073618924;36512;36896.26207475889;49410;49467;49567;49893.501064988886;50318;7306.890396643948;7539.396848252017;7602.429817763579;7614.733484328022;7886.250806173404;11114.888851111386;11351.37567433799;11579.652610421701;11787.233829801036;11866.169368144147;10176.287659863738;10223.386596804216;10230.693079207636;10234.283600148216;10525.842112368167;10237.590496380359;10477.637907072032;10485.895141048491;10546.472676366304;10713.839292410776;9651.517424128626;9872.802543948937;10236.488175591041;10280.897191027994;10343;7353.70585176587;7540;7654.579962041709;7792.168840322406;8058.798530036562;9601.279904007368;9838.606455741976;10235.1300139486;10439.791204176026;10545.841812372668 01:44:26 INFO - PROCESS | 4882 | |3;mootools.html;1321.9537316193935;1340.8994325425592;1402.200745575022;1631.2659303313505;1636.2963925512024;6816.147981502312;7089.432845372371;7367.963160184198;7927.167647397019;7937.801554961129;7376.557406555597;7687.2697093776005;7689.538627682343;7891.723789667363;7901.604919754003;2103.08515795629;2118.7245658064508;2132.360291912428;2132.4242454537266;2133.9893300533477;1791.9014454205014;1860.0606693619702;2101.6217080925426;2140.4862832920066;2142.1431427429075;1788.8390044895957;1804.7924488683773;1814.2652225848553;2027.0979414160631;2108.7785782492847;2050.0672194151775;2051.8768873867616;2053.5790163016623;2055.640262953977;2065.7211276477633;2014.5366565689826;2050.456628993303;2054.342610364684;2056.074766355146;2061.7319748432606;7552.4713270071115;7685.462017658766;7693.961530192313;7702.306792388712;7734.458587898849;4419.071994881079;4534.614557762594;4536.410266665345;4542.545745425431;4550.317452382136;2719.925629376405;2809.887604495818;2831.3346363604537;2853.7431631153295;2854.1722900358873;837.3050368194384;878.3675753457501;878.5563290538302;886.4769785826329;895.4314010603249;10574.788504229873;10613.734656633645;10627.468626568718;10684.252102352915;10711.571537138505;3852.653261206449;3926.1755031443145;4054.3310353791885;4064.1871625674394;4151.8339266429;9065.274778017743;9068.410553314014;9074.954625226832;9076.273898088137;9082.591283392263;4666.906661866811;4671.602913752301;4680.485146633868;4680.53194680536;4681.274402467623;4140.772257525805;4265.317549192177;4269.167512335127;4280.571942805695;4280.651594747645;3554.87557935471;3632.328019316435;3689.723270754704;3702.333579955634;3708.2212735325343;1140.4411838199223;1177.4877928101132;1179.168686076314;1187.26389638423;1188.7622475504934;611.9663418511935;706.6855249414065;736.4071922102759;736.8489459660757;777.2887807655932;5008.860835108828;5139.383274007143;5143.382794064736;5161.638685292069;5183.844484665466;793.2662287384146;808.6886548678801;818.4802650316973;861.2378045429715;875.3303722652176;3710.5361829771277;3787.337215987191;3801.4107813288983;3834.9424758628643;3975.1453437511072;9445;9483.14651681352;9621.326507144573;9645.469499177612;9669.129778319984;9588.185004274716;9590.136887680143;9591.760205994906;9614;9621.422714637005;7024.964875175591;7423.814404639819;7476.551406915493;7482.6632801524065;7536;5270.393904700855;5290.312259406252;5338;5453.918191227214;5595.776168953359;8808.51553164582;8894.688685895962;8911.777205569653;8931.598078086372;8993.100689931216;8396.832063358577;8807.119288071142;8809.735707928772;8972.327075469497;9103.863442048241;6694.129763130762;6768.796936091925;6870.828229294308;6872.931270687229;6886.69009894566;7373.594452305175;7436.92563074384;7440.627968601657;7446.515976461729;7454.695428300134;6693.799186024427;6699.263081060982;6712.966435167793;6714.83212919681;6972;6580.407763301326;6660.367265109807;6734.797956061326;6747.561408508432;6786.93213067863;5998.970005149947;6140.140380346666;6208.596441231305;6255.624662520263;6259.3427690091885;4386.12277544486;4563.315502674493;4614.700044497097;4624.514425985223;4663.160631086302;4442.155990361821;4466.062126953247;4505.684602077954;4572;4734.289856521412 01:44:26 INFO - PROCESS | 4882 | |4;prototype.html;281.53406112883187;295.3281285076451;295.70724982267535;297.66810006842377;299.6134985868229;4617.399738034059;4729.929051064237;4785.784639691214;4801.711897286161;4823.276508523723;4496.6402687784985;4636.4436267647925;4637.791299391527;4693.859184224479;4709.670323077386;3731.4029755239167;3746.2882052409955;3751.8686845960397;3761.8526349463405;3762.172322089136;3557.484164796103;3756.455313979471;3759.9624003759886;3775.9622403776025;3787.829547670348;3429.7770644908;3686.6313368663186;3687.9815600921957;3724.14344700719;3738.4392341148773;3695.260947810422;3698.389765688658;3708.3325001499584;3715.7956312402807;3720.1071742781673;3280.3767284215924;3292.37444885471;3293.917652058694;3298.2084299767885;3318.4192766265805;4540.545945405466;4599.678022538424;4614.907701845944;4617.2612382018715;4663;4185.476815398075;4187.958120418787;4201.831926722927;4207.326827707552;4213.2837417639075;4871.171900776876;4895.143349913751;4898.804047838083;4906.264060390934;4908.631852611033;3495.3271028037384;3556.6798988090936;3563.6436356364416;3564.9821750891338;3578.6958108560802;4988.251762235657;5106.64253502255;5123.2315152727015;5124.871878203037;5129.846104616868;3629.346717590859;3638.472421498868;3639.1266096137265;3641.1807343348064;3643.690286325639;3701.1857391373856;3708.2583483303447;3713.628637136265;3714.888553343404;3729.4219395993664;4086.2644723949975;4195.412642230091;4202.285611446062;4212.220739163265;4214.3889136075095;4843.1524483216;4850.8787280317565;4863.221884498464;4878.780454879539;4882.584980276645;1214.7509760499076;1255.6233130060946;1278.6739381457855;1296.2870421268265;1296.3388671777273;877.7410663854179;901.4816480523594;907.2061945797427;908.9000209976897;914.9725508234764;4404.436425069119;4408.184485870061;4428.601425871687;4441.844535441244;4451.399061126771;5065.746712664426;5096.898062038813;5098.490150984871;5132.153194722829;5141.71720555373;4326.329418940069;4371.956280437155;4392.494863090786;4405.867823965286;4417.734935903856;2666.58670904421;2688.8790004449847;2702.5135475614184;2702.8783704733332;2719.5376785946437;4746.976265118721;4769.403824521934;4789.760511974388;4818.518148185153;4832.661713680009;4985.227289770091;5089;5105.8723531911255;5150.690958542425;5153.510416510426;4769.856904292877;4776.23580227162;4789.185838407479;4799.66402351832;4807.903841923212;5082.136036873666;5082.263071854634;5088.618353623567;5089.312942752681;5093.439721630692;4734.73958932262;4905.950940490549;4913.975430122827;4919.926201106915;4925.1873440881855;4727.149113159664;4769.689970151929;4783.282507623884;4795.664303498722;4839.7096174229655;3710.091027698123;3714;3715.758475699179;3718.200586873835;3721.7766933982966;4835.879103022453;4983.900321993612;5010.599152067753;5018.322526458881;5066.82266120684;4854.83008094715;4854.985181149783;4863.4650188479945;4879.268109783561;4886.706797592155;4871.19625261842;4875.561199492063;4884.242942343943;4908.680935739166;4918.43438004634;4539.931901021553;4570.6800523963;4700.2268661488515;4769.76151192432;4789.712617242976;4805.471398146271;4942.1104201244125;4942.308076869169;5004.099262132851;5034.823781167642;4899.289603007615;4911.9754401227765;4932.334134891744;4937.530934561211;4942.640773787093 01:44:26 INFO - PROCESS | 4882 | |5;yui.html;620.4168082002919;632.4782054804786;654.8657525207333;714.1572943926168;728.3372131360463;12212.145149839514;13286.667833304173;13334.799978000337;13339.399727012284;13369;13386.866131338684;13483.460661573525;13537.729245415087;13555;13564.253966031863;589.0722112672537;604.9667268300242;718.2888939949438;727.9599622020813;755.5504474837463;749.7675720526627;758.9981224783288;759.0094926121409;759.1535437986632;759.9430042746789;794.8171920458298;796.2913007423398;796.6415113199055;796.7131832540281;796.760971708488;627.9309275979639;646.066434002866;648.8604949935786;650.5348675696852;792.1840504280572;477.4080140625634;559.3902646115713;573.6701396696916;575.7869588252331;577.0824389221159;13191.736165276641;13220.801687974592;13224.14043087206;13228.669283267898;13234;11341.206115571913;12028.45871935765;12211.816822747576;12228.388580571025;12534.81197782034;11460.484278207501;11692.883071169264;11701.239419437708;11760.17678762487;12111.091668124838;3937.3503371943593;3985.6811455083525;4025.9194816103513;4031.677465802729;4072.6741860651077;60115.69942150305;60462;61103.69448152731;61972.38027619711;62044;9926.553305101288;9973.451460169761;10040.447775372424;10048.497575121215;10132.34139780912;18446.81553184478;18545.165467553994;18587.535311617317;18660.533486662942;18760.343387981356;6353.618782873043;6381.074744162071;6436;6461.483081353481;6660.9000864987065;3399.5070714746716;3436.9656303437146;3478.4260597001717;3492.8253587320532;3511.0695665648623;2560.641510188575;2650.933726656849;2656.1102030819893;2666.1734862192784;2670.105514652574;466.5847395817725;466.7666166916542;468.59232467752594;475.9524047595213;480.1070009781803;453.6416231177333;470.6139870854802;562.9521490673256;577.1026054485316;586.5920396771278;7675.270849269311;7903.407244456689;8026.317762990095;8095.554744488992;8192.18078192176;505.9797608095635;534.2600498309869;561.8146011816173;574.6379780738108;580.4427749360576;3295.489199174132;3686.391745362039;3766.851110411296;3850.6919446444217;3997.7801220932547;55152.448475515535;55451.72274138604;55488.44511554913;56430.43569564334;98351;85322.57338713267;86257.5687121573;86672;88768.5561572188;89074;61563.692181538805;71338.28661713524;71522;74125.62937185388;74515;7260;7499.550026998398;7541.509801862861;7596.316331530189;7632.923670763444;31819.522707158947;31837.36325273528;45073.323900140866;45453.77273113613;45476.8630784233;60889.69555152196;67439;68060.31939680738;68276.317236827;70553;9521.904780952102;9639.325247232626;9800.607975681178;9914.801703965735;9944.204463643036;10622.309549879234;10639.414832184304;10770.73073173177;10862.456877156268;11736.119791015537;10352;10406.73983150397;10423.530941107516;11684.18210725241;12342.629721108382;11631.594907511162;12262.816057759319;12289.754204916031;12316.199447035913;12731.2997785119;10985.780284394108;11239.943800280946;11317.362890570843;11531.308121512737;12272.386380680751;9865.950670246602;10127.139193168663;10207.183425325808;10354.430506322225;10566.735831604272;10154.796904062025;10431.68704938853;10612.946935265274;10716.410597417216;10742.3017503862 01:44:26 INFO - PROCESS | 4882 | __end_tp_report 01:44:26 INFO - PROCESS | 4882 | __start_cc_report 01:44:26 INFO - PROCESS | 4882 | _x_x_mozilla_cycle_collect,1182 01:44:26 INFO - PROCESS | 4882 | __end_cc_report 01:44:26 INFO - PROCESS | 4882 | __startTimestamp1475743466598__endTimestamp 01:44:26 INFO - PROCESS | 4882 | 01:44:26 INFO - PROCESS | 4882 | ------- Summary: start ------- 01:44:26 INFO - PROCESS | 4882 | Number of tests: 6 01:44:26 INFO - PROCESS | 4882 | 01:44:26 INFO - PROCESS | 4882 | [#0] dojo.html Cycles:165 Average:4632.98 Median:4764.83 stddev:496.45 (10.4%) stddev-sans-first:470.09 01:44:26 INFO - PROCESS | 4882 | Values: 2541.8 2552.4 2591.7 2593.4 2613.1 4552.2 4603.1 4603.7 4603.9 4649.0 4642.1 4653.7 4695.3 4698.8 4768.0 4288.2 4310.0 4310.3 4344.2 4395.0 4291.4 4351.0 4403.8 4406.8 4430.8 4184.8 4344.9 4352.2 4368.3 4449.0 4173.3 4228.4 4264.0 4288.9 4320.0 4212.2 4213.6 4214.6 4215.5 4264.5 4629.9 4651.9 4653.2 4663.3 4717.4 4910.1 4945.9 4960.2 5003.8 5025.9 5056.8 5073.0 5082.0 5091.1 5133.7 4732.4 4733.0 4733.8 4734.4 4741.0 5027.5 5084.3 5127.4 5174.5 5253.0 4962.0 4968.7 4975.7 4998.6 5034.9 5047.8 5057.9 5064.7 5065.7 5127.6 4812.9 4860.6 4902.4 4991.8 5008.1 4921.1 5007.2 5007.6 5008.2 5013.2 4172.0 4177.6 4181.4 4188.5 4234.9 3695.0 3696.6 3699.6 3725.9 3729.4 4289.7 4326.0 4327.3 4346.7 4374.2 5058.6 5060.6 5070.9 5108.7 5116.7 4369.7 4384.0 4387.6 4402.6 4403.6 4372.6 4403.5 4416.4 4514.0 4523.9 4623.8 4715.1 4753.9 4810.3 4810.5 4994.1 4997.4 5004.5 5007.4 5069.5 4755.6 4759.5 4768.2 4768.8 4831.8 4809.0 4860.7 4883.8 4928.0 4943.0 5011.8 5014.6 5022.2 5061.6 5089.5 4870.5 4873.3 4876.5 4877.7 4904.0 4756.9 4764.8 4857.6 4879.0 4926.7 4845.6 4846.2 4853.2 4910.8 4922.8 4917.1 4931.1 4931.2 4954.8 4984.5 4636.8 4661.9 4855.9 4871.9 4915.1 01:44:26 INFO - PROCESS | 4882 | 01:44:26 INFO - PROCESS | 4882 | [#1] ext.html Cycles:180 Average:37935.40 Median:35120.65 stddev:59259.16 (168.7%) stddev-sans-first:59358.94 01:44:26 INFO - PROCESS | 4882 | Values: 557.3 558.0 560.3 569.2 574.4 27365.3 37272.0 39095.6 39138.2 42351.8 37808.0 38083.0 38109.6 38163.8 38212.6 7523.4 7699.2 7700.3 7702.5 7704.6 7619.0 7703.8 7708.4 7709.3 7713.8 7723.1 7768.8 7773.4 7777.7 7778.2 7669.0 7707.0 7708.5 7714.0 7721.7 7630.4 7699.6 7701.0 7704.1 7707.7 36378.5 36699.3 36723.0 36731.8 36753.3 2615.5 2659.5 2681.8 2817.0 3030.9 27246.5 27387.5 27485.6 27656.0 28323.9 3480.1 3527.2 3533.9 3547.5 3596.2 246606.0 247162.0 247825.0 248014.0 248078.0 48599.0 49202.5 49205.8 49251.5 49267.8 32168.4 33589.5 52989.5 53003.7 53110.7 13802.3 14219.3 14220.6 14221.7 14221.7 10524.9 10612.7 10625.4 10627.2 10630.7 17443.2 17451.8 17461.4 17472.3 17539.4 6414.6 6486.9 6510.4 6723.5 6736.4 775.9 914.5 939.0 939.3 950.7 26989.9 27610.6 27835.2 28082.9 28126.7 941.2 942.8 942.9 960.0 995.6 13676.2 14501.0 14704.6 14923.5 15101.3 127111.0 127965.0 128155.0 128666.4 128789.4 48810.8 49209.0 49304.5 49342.5 49450.0 1055.8 1084.2 1111.9 1126.2 1147.5 27464.3 28938.3 29100.6 29275.1 29983.9 39260.0 39863.6 39872.6 39912.4 39994.0 275158.0 275185.0 275660.0 276918.0 277230.0 21582.1 22415.1 23067.0 24165.4 24184.6 39900.2 39936.0 40101.8 40534.0 41539.6 34368.0 34622.8 35072.6 35168.6 35377.6 34280.0 34503.5 34571.3 34601.8 35056.5 34200.0 34406.7 34540.5 34622.8 35289.6 29121.3 31366.0 31381.5 31411.4 31630.5 24217.5 24278.8 24331.4 24674.6 24970.0 01:44:26 INFO - PROCESS | 4882 | 01:44:26 INFO - PROCESS | 4882 | [#2] jquery.html Cycles:180 Average:23690.99 Median:382545.00 stddev:62674.06 (16.4%) stddev-sans-first:62825.36 01:44:26 INFO - PROCESS | 4882 | Values: 342.2 354.6 365.3 367.8 378.2 12174.6 15295.6 15708.6 17223.4 17464.0 14738.5 16493.8 16580.6 16878.3 17002.7 4097.6 4910.5 5063.3 5070.2 5094.8 5065.2 5092.2 5122.6 5161.6 5162.3 4500.1 4527.6 4707.3 5089.4 5094.1 5001.4 5060.7 5073.2 5075.5 5079.3 4359.9 4452.0 4484.7 4517.5 4527.5 19662.0 20211.3 20248.9 20359.5 20441.1 1882.7 1923.2 1942.3 2127.4 2333.3 13098.3 13114.0 13127.3 13237.1 13796.0 1655.6 1743.5 1751.8 1763.7 1769.1 65754.7 66559.7 67252.3 67657.0 68085.0 8045.9 8577.4 8592.3 8749.7 8843.5 11570.4 11574.2 11578.0 11587.9 11692.7 6548.8 6802.8 6889.7 6979.7 7022.4 6781.2 6852.0 6908.6 6991.0 7140.6 3638.3 3667.4 3689.9 3746.7 3753.2 1682.6 1685.6 1722.3 1753.4 1812.4 377.2 383.8 658.3 778.7 788.1 10110.5 15717.6 17367.6 17476.3 18195.8 825.2 854.9 861.5 861.6 873.5 8993.5 9554.1 9587.7 9623.4 9807.9 373572.0 377745.0 379743.0 382159.0 382931.0 75077.0 75916.0 76730.0 76749.0 80461.6 911.0 912.1 929.9 932.1 933.1 14632.6 14665.2 15066.0 15282.5 15525.7 35474.5 35995.5 36192.6 36512.0 36896.3 49410.0 49467.0 49567.0 49893.5 50318.0 7306.9 7539.4 7602.4 7614.7 7886.3 11114.9 11351.4 11579.7 11787.2 11866.2 10176.3 10223.4 10230.7 10234.3 10525.8 10237.6 10477.6 10485.9 10546.5 10713.8 9651.5 9872.8 10236.5 10280.9 10343.0 7353.7 7540.0 7654.6 7792.2 8058.8 9601.3 9838.6 10235.1 10439.8 10545.8 01:44:26 INFO - PROCESS | 4882 | 01:44:26 INFO - PROCESS | 4882 | [#3] mootools.html Cycles:180 Average:5091.02 Median:5280.35 stddev:2883.74 (54.6%) stddev-sans-first:2877.92 01:44:26 INFO - PROCESS | 4882 | Values: 1322.0 1340.9 1402.2 1631.3 1636.3 6816.1 7089.4 7368.0 7927.2 7937.8 7376.6 7687.3 7689.5 7891.7 7901.6 2103.1 2118.7 2132.4 2132.4 2134.0 1791.9 1860.1 2101.6 2140.5 2142.1 1788.8 1804.8 1814.3 2027.1 2108.8 2050.1 2051.9 2053.6 2055.6 2065.7 2014.5 2050.5 2054.3 2056.1 2061.7 7552.5 7685.5 7694.0 7702.3 7734.5 4419.1 4534.6 4536.4 4542.5 4550.3 2719.9 2809.9 2831.3 2853.7 2854.2 837.3 878.4 878.6 886.5 895.4 10574.8 10613.7 10627.5 10684.3 10711.6 3852.7 3926.2 4054.3 4064.2 4151.8 9065.3 9068.4 9075.0 9076.3 9082.6 4666.9 4671.6 4680.5 4680.5 4681.3 4140.8 4265.3 4269.2 4280.6 4280.7 3554.9 3632.3 3689.7 3702.3 3708.2 1140.4 1177.5 1179.2 1187.3 1188.8 612.0 706.7 736.4 736.8 777.3 5008.9 5139.4 5143.4 5161.6 5183.8 793.3 808.7 818.5 861.2 875.3 3710.5 3787.3 3801.4 3834.9 3975.1 9445.0 9483.1 9621.3 9645.5 9669.1 9588.2 9590.1 9591.8 9614.0 9621.4 7025.0 7423.8 7476.6 7482.7 7536.0 5270.4 5290.3 5338.0 5453.9 5595.8 8808.5 8894.7 8911.8 8931.6 8993.1 8396.8 8807.1 8809.7 8972.3 9103.9 6694.1 6768.8 6870.8 6872.9 6886.7 7373.6 7436.9 7440.6 7446.5 7454.7 6693.8 6699.3 6713.0 6714.8 6972.0 6580.4 6660.4 6734.8 6747.6 6786.9 5999.0 6140.1 6208.6 6255.6 6259.3 4386.1 4563.3 4614.7 4624.5 4663.2 4442.2 4466.1 4505.7 4572.0 4734.3 01:44:26 INFO - PROCESS | 4882 | 01:44:26 INFO - PROCESS | 4882 | [#4] prototype.html Cycles:180 Average:4104.89 Median:4678.43 stddev:1169.42 (25.0%) stddev-sans-first:1136.94 01:44:26 INFO - PROCESS | 4882 | Values: 281.5 295.3 295.7 297.7 299.6 4617.4 4729.9 4785.8 4801.7 4823.3 4496.6 4636.4 4637.8 4693.9 4709.7 3731.4 3746.3 3751.9 3761.9 3762.2 3557.5 3756.5 3760.0 3776.0 3787.8 3429.8 3686.6 3688.0 3724.1 3738.4 3695.3 3698.4 3708.3 3715.8 3720.1 3280.4 3292.4 3293.9 3298.2 3318.4 4540.5 4599.7 4614.9 4617.3 4663.0 4185.5 4188.0 4201.8 4207.3 4213.3 4871.2 4895.1 4898.8 4906.3 4908.6 3495.3 3556.7 3563.6 3565.0 3578.7 4988.3 5106.6 5123.2 5124.9 5129.8 3629.3 3638.5 3639.1 3641.2 3643.7 3701.2 3708.3 3713.6 3714.9 3729.4 4086.3 4195.4 4202.3 4212.2 4214.4 4843.2 4850.9 4863.2 4878.8 4882.6 1214.8 1255.6 1278.7 1296.3 1296.3 877.7 901.5 907.2 908.9 915.0 4404.4 4408.2 4428.6 4441.8 4451.4 5065.7 5096.9 5098.5 5132.2 5141.7 4326.3 4372.0 4392.5 4405.9 4417.7 2666.6 2688.9 2702.5 2702.9 2719.5 4747.0 4769.4 4789.8 4818.5 4832.7 4985.2 5089.0 5105.9 5150.7 5153.5 4769.9 4776.2 4789.2 4799.7 4807.9 5082.1 5082.3 5088.6 5089.3 5093.4 4734.7 4906.0 4914.0 4919.9 4925.2 4727.1 4769.7 4783.3 4795.7 4839.7 3710.1 3714.0 3715.8 3718.2 3721.8 4835.9 4983.9 5010.6 5018.3 5066.8 4854.8 4855.0 4863.5 4879.3 4886.7 4871.2 4875.6 4884.2 4908.7 4918.4 4539.9 4570.7 4700.2 4769.8 4789.7 4805.5 4942.1 4942.3 5004.1 5034.8 4899.3 4912.0 4932.3 4937.5 4942.6 01:44:26 INFO - PROCESS | 4882 | 01:44:26 INFO - PROCESS | 4882 | [#5] yui.html Cycles:180 Average:16668.27 Median:469.60 stddev:23169.01 (4933.7%) stddev-sans-first:23202.67 01:44:26 INFO - PROCESS | 4882 | Values: 620.4 632.5 654.9 714.2 728.3 12212.1 13286.7 13334.8 13339.4 13369.0 13386.9 13483.5 13537.7 13555.0 13564.3 589.1 605.0 718.3 728.0 755.6 749.8 759.0 759.0 759.2 759.9 794.8 796.3 796.6 796.7 796.8 627.9 646.1 648.9 650.5 792.2 477.4 559.4 573.7 575.8 577.1 13191.7 13220.8 13224.1 13228.7 13234.0 11341.2 12028.5 12211.8 12228.4 12534.8 11460.5 11692.9 11701.2 11760.2 12111.1 3937.4 3985.7 4025.9 4031.7 4072.7 60115.7 60462.0 61103.7 61972.4 62044.0 9926.6 9973.5 10040.4 10048.5 10132.3 18446.8 18545.2 18587.5 18660.5 18760.3 6353.6 6381.1 6436.0 6461.5 6660.9 3399.5 3437.0 3478.4 3492.8 3511.1 2560.6 2650.9 2656.1 2666.2 2670.1 466.6 466.8 468.6 476.0 480.1 453.6 470.6 563.0 577.1 586.6 7675.3 7903.4 8026.3 8095.6 8192.2 506.0 534.3 561.8 574.6 580.4 3295.5 3686.4 3766.9 3850.7 3997.8 55152.4 55451.7 55488.4 56430.4 98351.0 85322.6 86257.6 86672.0 88768.6 89074.0 61563.7 71338.3 71522.0 74125.6 74515.0 7260.0 7499.6 7541.5 7596.3 7632.9 31819.5 31837.4 45073.3 45453.8 45476.9 60889.7 67439.0 68060.3 68276.3 70553.0 9521.9 9639.3 9800.6 9914.8 9944.2 10622.3 10639.4 10770.7 10862.5 11736.1 10352.0 10406.7 10423.5 11684.2 12342.6 11631.6 12262.8 12289.8 12316.2 12731.3 10985.8 11239.9 11317.4 11531.3 12272.4 9866.0 10127.1 10207.2 10354.4 10566.7 10154.8 10431.7 10612.9 10716.4 10742.3 01:44:26 INFO - PROCESS | 4882 | -------- Summary: end -------- 01:44:26 INFO - PROCESS | 4882 | 01:44:27 INFO - TEST-INFO | 4882: exit 0 01:44:27 INFO - TEST-OK | dromaeo_css | took 1122439ms 01:44:27 INFO - TEST-START | kraken 01:44:27 INFO - operating with platform_type : linux_ 01:44:27 INFO - Initialising browser for kraken test... 01:44:27 INFO - TEST-INFO | started process 5186 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsJsDBL/profile http://localhost:54826/getInfo.html) 01:44:32 INFO - PROCESS | 5186 | __metrics Screen width/height:1600/1200 01:44:32 INFO - PROCESS | 5186 | colorDepth:24 01:44:32 INFO - PROCESS | 5186 | Browser inner width/height: 1024/697 01:44:32 INFO - PROCESS | 5186 | __metrics 01:44:33 INFO - PROCESS | 5186 | 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" 01:44:33 INFO - PROCESS | 5186 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:44:33 INFO - PROCESS | 5186 | console.error: PushService: 01:44:33 INFO - PROCESS | 5186 | stateChangeProcessEnqueue: Error transitioning state 01:44:33 INFO - PROCESS | 5186 | UnknownError 01:44:34 INFO - TEST-INFO | 5186: exit 0 01:44:34 INFO - Browser initialized. 01:44:34 INFO - Running cycle 1/1 for kraken test... 01:44:34 INFO - TEST-INFO | started process 5273 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsJsDBL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:44:46 INFO - PROCESS | 5273 | RSS: Main: 175771648 01:44:46 INFO - PROCESS | 5273 | 01:44:49 INFO - PROCESS | 5273 | Cycle 1(1): loaded http://localhost:54826/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54826/tests/kraken/driver.html?testName=audio-beat-detection) 01:44:50 INFO - PROCESS | 5273 | RSS: Main: 234606592 01:44:50 INFO - PROCESS | 5273 | 01:44:53 INFO - PROCESS | 5273 | Cycle 1(1): loaded http://localhost:54826/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54826/tests/kraken/driver.html?testName=audio-dft) 01:44:53 INFO - PROCESS | 5273 | RSS: Main: 219348992 01:44:53 INFO - PROCESS | 5273 | 01:44:57 INFO - PROCESS | 5273 | Cycle 1(1): loaded http://localhost:54826/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54826/tests/kraken/driver.html?testName=audio-fft) 01:44:57 INFO - PROCESS | 5273 | RSS: Main: 301522944 01:44:57 INFO - PROCESS | 5273 | 01:45:00 INFO - PROCESS | 5273 | Cycle 1(1): loaded http://localhost:54826/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54826/tests/kraken/driver.html?testName=audio-oscillator) 01:45:00 INFO - PROCESS | 5273 | RSS: Main: 211681280 01:45:00 INFO - PROCESS | 5273 | 01:45:02 INFO - PROCESS | 5273 | Cycle 1(1): loaded http://localhost:54826/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54826/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:45:03 INFO - PROCESS | 5273 | RSS: Main: 214429696 01:45:03 INFO - PROCESS | 5273 | 01:45:06 INFO - PROCESS | 5273 | Cycle 1(1): loaded http://localhost:54826/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54826/tests/kraken/driver.html?testName=imaging-darkroom) 01:45:07 INFO - PROCESS | 5273 | RSS: Main: 250613760 01:45:07 INFO - PROCESS | 5273 | 01:45:10 INFO - PROCESS | 5273 | Cycle 1(1): loaded http://localhost:54826/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54826/tests/kraken/driver.html?testName=imaging-desaturate) 01:45:11 INFO - PROCESS | 5273 | RSS: Main: 249802752 01:45:11 INFO - PROCESS | 5273 | 01:45:14 INFO - PROCESS | 5273 | Cycle 1(1): loaded http://localhost:54826/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54826/tests/kraken/driver.html?testName=json-parse-financial) 01:45:14 INFO - PROCESS | 5273 | RSS: Main: 249597952 01:45:14 INFO - PROCESS | 5273 | 01:45:16 INFO - PROCESS | 5273 | Cycle 1(1): loaded http://localhost:54826/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54826/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:45:17 INFO - PROCESS | 5273 | RSS: Main: 211681280 01:45:17 INFO - PROCESS | 5273 | 01:45:19 INFO - PROCESS | 5273 | Cycle 1(1): loaded http://localhost:54826/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54826/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:45:19 INFO - PROCESS | 5273 | RSS: Main: 218279936 01:45:19 INFO - PROCESS | 5273 | 01:45:21 INFO - PROCESS | 5273 | Cycle 1(1): loaded http://localhost:54826/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54826/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:45:22 INFO - PROCESS | 5273 | RSS: Main: 227659776 01:45:22 INFO - PROCESS | 5273 | 01:45:25 INFO - PROCESS | 5273 | Cycle 1(1): loaded http://localhost:54826/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54826/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:45:26 INFO - PROCESS | 5273 | RSS: Main: 236175360 01:45:26 INFO - PROCESS | 5273 | 01:45:29 INFO - PROCESS | 5273 | Cycle 1(1): loaded http://localhost:54826/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54826/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:45:29 INFO - PROCESS | 5273 | RSS: Main: 233644032 01:45:29 INFO - PROCESS | 5273 | 01:45:31 INFO - PROCESS | 5273 | Cycle 1(1): loaded http://localhost:54826/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54826/tests/kraken/driver.html?testName=ai-astar) 01:45:31 INFO - PROCESS | 5273 | RSS: Main: 284336128 01:45:31 INFO - PROCESS | 5273 | 01:45:31 INFO - PROCESS | 5273 | __start_tp_report 01:45:31 INFO - PROCESS | 5273 | _x_x_mozilla_page_load 01:45:31 INFO - PROCESS | 5273 | _x_x_mozilla_page_load_details 01:45:31 INFO - PROCESS | 5273 | |i|pagename|runs| 01:45:31 INFO - PROCESS | 5273 | |0;ai-astar;114;116;118;119;116;117;116;116;117;116 01:45:31 INFO - PROCESS | 5273 | |1;audio-beat-detection;152;135;129;170;128;134;127;133;162;125 01:45:31 INFO - PROCESS | 5273 | |2;audio-dft;161;160;162;163;161;162;162;161;160;161 01:45:31 INFO - PROCESS | 5273 | |3;audio-fft;76;76;77;117;77;77;78;77;111;75 01:45:31 INFO - PROCESS | 5273 | |4;audio-oscillator;84;83;114;84;84;84;107;84;84;120 01:45:31 INFO - PROCESS | 5273 | |5;imaging-gaussian-blur;117;116;117;117;117;117;116;116;117;117 01:45:31 INFO - PROCESS | 5273 | |6;imaging-darkroom;147;146;147;146;146;147;146;146;147;146 01:45:31 INFO - PROCESS | 5273 | |7;imaging-desaturate;95;95;95;95;95;95;94;95;95;95 01:45:31 INFO - PROCESS | 5273 | |8;json-parse-financial;67;65;65;66;65;66;65;66;66;66 01:45:31 INFO - PROCESS | 5273 | |9;json-stringify-tinderbox;66;66;66;66;67;66;67;68;66;66 01:45:31 INFO - PROCESS | 5273 | |10;stanford-crypto-aes;94;86;84;84;83;85;84;83;84;83 01:45:31 INFO - PROCESS | 5273 | |11;stanford-crypto-ccm;141;143;148;142;140;140;138;138;180;143 01:45:31 INFO - PROCESS | 5273 | |12;stanford-crypto-pbkdf2;177;175;178;177;174;182;175;175;175;175 01:45:31 INFO - PROCESS | 5273 | |13;stanford-crypto-sha256-iterative;70;70;73;69;70;73;69;69;70;68 01:45:31 INFO - PROCESS | 5273 | __end_tp_report 01:45:31 INFO - PROCESS | 5273 | __start_cc_report 01:45:31 INFO - PROCESS | 5273 | _x_x_mozilla_cycle_collect,1929 01:45:31 INFO - PROCESS | 5273 | __end_cc_report 01:45:31 INFO - PROCESS | 5273 | __startTimestamp1475743531768__endTimestamp 01:45:31 INFO - PROCESS | 5273 | 01:45:31 INFO - PROCESS | 5273 | ------- Summary: start ------- 01:45:31 INFO - PROCESS | 5273 | Number of tests: 14 01:45:31 INFO - PROCESS | 5273 | 01:45:31 INFO - PROCESS | 5273 | [#0] ai-astar Cycles:10 Average:116.50 Median:116.50 stddev:1.35 (1.2%) stddev-sans-first:1.09 01:45:31 INFO - PROCESS | 5273 | Values: 114.0 116.0 118.0 119.0 116.0 117.0 116.0 116.0 117.0 116.0 01:45:31 INFO - PROCESS | 5273 | 01:45:31 INFO - PROCESS | 5273 | [#1] audio-beat-detection Cycles:10 Average:139.50 Median:134.50 stddev:15.97 (11.9%) stddev-sans-first:16.28 01:45:31 INFO - PROCESS | 5273 | Values: 152.0 135.0 129.0 170.0 128.0 134.0 127.0 133.0 162.0 125.0 01:45:31 INFO - PROCESS | 5273 | 01:45:31 INFO - PROCESS | 5273 | [#2] audio-dft Cycles:10 Average:161.30 Median:161.50 stddev:0.95 (0.6%) stddev-sans-first:1.00 01:45:31 INFO - PROCESS | 5273 | Values: 161.0 160.0 162.0 163.0 161.0 162.0 162.0 161.0 160.0 161.0 01:45:31 INFO - PROCESS | 5273 | 01:45:31 INFO - PROCESS | 5273 | [#3] audio-fft Cycles:10 Average:84.10 Median:77.00 stddev:15.84 (20.6%) stddev-sans-first:16.53 01:45:31 INFO - PROCESS | 5273 | Values: 76.0 76.0 77.0 117.0 77.0 77.0 78.0 77.0 111.0 75.0 01:45:31 INFO - PROCESS | 5273 | 01:45:31 INFO - PROCESS | 5273 | [#4] audio-oscillator Cycles:10 Average:92.80 Median:84.00 stddev:14.73 (17.5%) stddev-sans-first:15.27 01:45:31 INFO - PROCESS | 5273 | Values: 84.0 83.0 114.0 84.0 84.0 84.0 107.0 84.0 84.0 120.0 01:45:31 INFO - PROCESS | 5273 | 01:45:31 INFO - PROCESS | 5273 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 01:45:31 INFO - PROCESS | 5273 | Values: 117.0 116.0 117.0 117.0 117.0 117.0 116.0 116.0 117.0 117.0 01:45:31 INFO - PROCESS | 5273 | 01:45:31 INFO - PROCESS | 5273 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 01:45:31 INFO - PROCESS | 5273 | Values: 147.0 146.0 147.0 146.0 146.0 147.0 146.0 146.0 147.0 146.0 01:45:31 INFO - PROCESS | 5273 | 01:45:31 INFO - PROCESS | 5273 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 01:45:31 INFO - PROCESS | 5273 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 94.0 95.0 95.0 95.0 01:45:31 INFO - PROCESS | 5273 | 01:45:31 INFO - PROCESS | 5273 | [#8] json-parse-financial Cycles:10 Average:65.70 Median:66.00 stddev:0.67 (1.0%) stddev-sans-first:0.53 01:45:31 INFO - PROCESS | 5273 | Values: 67.0 65.0 65.0 66.0 65.0 66.0 65.0 66.0 66.0 66.0 01:45:31 INFO - PROCESS | 5273 | 01:45:31 INFO - PROCESS | 5273 | [#9] json-stringify-tinderbox Cycles:10 Average:66.40 Median:66.00 stddev:0.70 (1.1%) stddev-sans-first:0.73 01:45:31 INFO - PROCESS | 5273 | Values: 66.0 66.0 66.0 66.0 67.0 66.0 67.0 68.0 66.0 66.0 01:45:31 INFO - PROCESS | 5273 | 01:45:31 INFO - PROCESS | 5273 | [#10] stanford-crypto-aes Cycles:10 Average:85.00 Median:84.00 stddev:3.30 (3.9%) stddev-sans-first:1.00 01:45:31 INFO - PROCESS | 5273 | Values: 94.0 86.0 84.0 84.0 83.0 85.0 84.0 83.0 84.0 83.0 01:45:31 INFO - PROCESS | 5273 | 01:45:31 INFO - PROCESS | 5273 | [#11] stanford-crypto-ccm Cycles:10 Average:145.30 Median:142.50 stddev:12.53 (8.8%) stddev-sans-first:13.20 01:45:31 INFO - PROCESS | 5273 | Values: 141.0 143.0 148.0 142.0 140.0 140.0 138.0 138.0 180.0 143.0 01:45:31 INFO - PROCESS | 5273 | 01:45:31 INFO - PROCESS | 5273 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.30 Median:176.00 stddev:2.36 (1.3%) stddev-sans-first:2.49 01:45:31 INFO - PROCESS | 5273 | Values: 177.0 175.0 178.0 177.0 174.0 182.0 175.0 175.0 175.0 175.0 01:45:31 INFO - PROCESS | 5273 | 01:45:31 INFO - PROCESS | 5273 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.10 Median:70.00 stddev:1.66 (2.4%) stddev-sans-first:1.76 01:45:31 INFO - PROCESS | 5273 | Values: 70.0 70.0 73.0 69.0 70.0 73.0 69.0 69.0 70.0 68.0 01:45:31 INFO - PROCESS | 5273 | -------- Summary: end -------- 01:45:31 INFO - PROCESS | 5273 | 01:45:33 INFO - TEST-INFO | 5273: exit 0 01:45:33 INFO - TEST-OK | kraken | took 65579ms 01:45:33 INFO - SUITE-END | took 1188s 01:45:33 INFO - Completed test suite (00:19:48) 01:45:33 INFO - javascript benchmark 01:45:33 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2541.834780739253, 2552.3746682062897, 2591.6630837991056, 2593.364625666712, 2613.0592986524834, 4552.24887893498, 4603.079384123176, 4603.700759450638, 4603.930941035887, 4648.976755116224, 4642.141203877285, 4653.69750966187, 4695.3191787190835, 4698.812047518095, 4768.022555376148, 4288.206681763868, 4310.0, 4310.267254566716, 4344.174606824693, 4394.978025109886, 4291.356296555526, 4351.0, 4403.823847046115, 4406.779661016953, 4430.800613972363, 4184.790760461965, 4344.89137771555, 4352.17308711347, 4368.279233926399, 4449.0, 4173.332266837322, 4228.429162063113, 4263.97868010661, 4288.935665965013, 4320.049589090427, 4212.178625168093, 4213.557576454489, 4214.578542145761, 4215.45199124115, 4264.509581398148, 4629.930551041737, 4651.88370290742, 4653.208954477747, 4663.300504924288, 4717.386739723814, 4910.140725373081, 4945.936623625902, 4960.181570040939, 5003.824101336183, 5025.924611130836, 5056.797728090872, 5073.0, 5082.0, 5091.1090559152, 5133.743312834344, 4732.410674625544, 4732.976335118303, 4733.83431579893, 4734.431868175841, 4740.976295118502, 5027.522385373383, 5084.313617661643, 5127.3847138343635, 5174.508421699932, 5253.028189784825, 4961.950380496221, 4968.701877887338, 4975.651704380659, 4998.550130488274, 5034.874128146826, 5047.823326183566, 5057.898842023139, 5064.696118232918, 5065.670731402521, 5127.64106512548, 4812.879678008007, 4860.562549370574, 4902.362692849907, 4991.775370108354, 5008.12357837377, 4921.138800709861, 5007.223880298487, 5007.574356179693, 5008.198688209869, 5013.197888337849, 4172.0, 4177.624013838708, 4181.351890456984, 4188.518320393133, 4234.851780187741, 3695.020819482839, 3696.6488183622514, 3699.6300369962787, 3725.906852328659, 3729.4219395993664, 4289.721168124062, 4326.026644005074, 4327.2643650579475, 4346.695731298779, 4374.21264172452, 5058.620603454756, 5060.620453466005, 5070.898582028412, 5108.744562771846, 5116.718580478035, 4369.694121411534, 4383.978080109579, 4387.627051700578, 4402.603765661106, 4403.581659742319, 4372.562743725602, 4403.471583409947, 4416.381706561084, 4514.0, 4523.886902827456, 4623.791929363254, 4715.104130215248, 4753.857384278477, 4810.254410566367, 4810.494898035796, 4994.051130285234, 4997.375328083989, 5004.524570165829, 5007.37407824022, 5069.518395752398, 4755.643326750438, 4759.500252473579, 4768.213244814567, 4768.76156192196, 4831.806727730851, 4808.975955120202, 4860.659753817199, 4883.804647814048, 4927.975360123177, 4943.036107958914, 5011.84964451067, 5014.623903207201, 5022.171341728574, 5061.620378471555, 5089.465606111453, 4870.488598697086, 4873.293372461044, 4876.463589005136, 4877.731724755173, 4903.975480122576, 4756.9048619026735, 4764.8332308369045, 4857.635677324144, 4879.0, 4926.704397736147, 4845.563899249085, 4846.224604063333, 4853.223484242504, 4910.7544622768, 4922.803087876445, 4917.1149193145575, 4931.087748766489, 4931.235658472942, 4954.752262386938, 4984.4517103117905, 4636.768161591975, 4661.906761864676, 4855.854324370274, 4871.858424627005, 4915.066137433876], "value": 4600.429636195282, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [557.3367692445989, 557.9888402231956, 560.3276068717535, 569.1945896556373, 574.3940143148977, 27365.31586710331, 37272.0, 39095.60904390955, 39138.21723565527, 42351.78824105883, 37808.0, 38083.0, 38109.61890381095, 38163.80918095406, 38212.617873821255, 7523.360514356273, 7699.230076992312, 7700.268474494914, 7702.4993375430695, 7704.614769261514, 7619.0, 7703.768886933373, 7708.38332933364, 7709.344705700022, 7713.845723085535, 7723.111842138142, 7768.805779855492, 7773.416993725465, 7777.650005749755, 7778.222177782233, 7668.961655191716, 7706.961465192694, 7708.460407771458, 7713.96143019287, 7721.65252563636, 7630.38956883448, 7699.615019249015, 7701.0, 7704.075510938723, 7707.730229441942, 36378.45432318517, 36699.348529316245, 36723.0, 36731.81634091812, 36753.26493470142, 2615.463829914882, 2659.494696007772, 2681.825681330707, 2816.957745633817, 3030.9393812123635, 27246.45507089847, 27387.45225095507, 27485.587716184273, 27656.0, 28323.85838070817, 3480.147363895862, 3527.188746588299, 3533.94699079514, 3547.467879818022, 3596.1908570571672, 246606.0, 247162.0, 247825.0, 248014.0, 248078.0, 48599.0, 49202.50797491979, 49205.75397122991, 49251.50748492469, 49267.753661231465, 32168.356632867213, 33589.49615755765, 52989.470105299224, 53003.734981324844, 53110.73444632829, 13802.309884505734, 14219.289035548181, 14220.644483887985, 14221.715565688835, 14221.715565688835, 10524.894751052545, 10612.734681633021, 10625.415602141802, 10627.202959778047, 10630.734231644115, 17443.21505532254, 17451.82548174502, 17461.38885139014, 17472.301107955795, 17539.386121485943, 6414.550981431255, 6486.902696459557, 6510.414062734377, 6723.495737819683, 6736.360045795642, 775.8681024225895, 914.5107367558458, 938.957746901391, 939.2673714502699, 950.6957773512548, 26989.865050675013, 27610.585841212396, 27835.16494505168, 28082.85958570194, 28126.71873281241, 941.2140862379989, 942.835003874333, 942.9104235097655, 959.9520023998772, 995.6266400099962, 13676.247806370546, 14501.0, 14704.558863233906, 14923.477678281208, 15101.281769281635, 127111.0, 127965.0, 128155.0, 128666.35666821606, 128789.35605321913, 48810.755946220044, 49209.0, 49304.50695493071, 49342.50657493379, 49450.0, 1055.7941201465794, 1084.1706094837455, 1111.9221654484109, 1126.206024752564, 1147.4951021550492, 27464.313392165357, 28938.27654308659, 29100.563491547222, 29275.121746347642, 29983.850080749457, 39260.0, 39863.60136398599, 39872.60127398689, 39912.40131397973, 39994.0, 275158.0, 275185.0, 275660.0, 276918.0, 277230.0, 21582.136714531243, 22415.103395863982, 23067.0, 24165.395865103514, 24184.63723044191, 39900.2019959605, 39936.0, 40101.79949100353, 40534.0, 41539.58460415357, 34368.0, 34622.82688586541, 35072.64927350694, 35168.64831351654, 35377.64622353847, 34280.0, 34503.4824477638, 34571.30857382788, 34601.82699086489, 35056.47415288722, 34200.0, 34406.65593344034, 34540.48189277213, 34622.82688586541, 35289.64710352966, 29121.271968200963, 31366.0, 31381.52927706132, 31411.37177256488, 31630.525542117346, 24217.515649686557, 24278.757212428358, 24331.39171520726, 24674.629880552166, 24970.0], "value": 16327.501605884712, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [342.1685304709555, 354.59753180140547, 365.3442071481691, 367.84734335250874, 378.1548239684305, 12174.573889913854, 15295.617609559753, 15708.607284817885, 17223.397181098662, 17464.0, 14738.484153054618, 16493.752593711102, 16580.585485362873, 16878.324867005304, 17002.659946801086, 4097.569755175708, 4910.508949105088, 5063.316452278932, 5070.163423035195, 5094.847154585368, 5065.164247899111, 5092.236164575324, 5122.590192784587, 5161.561267292284, 5162.277281180638, 4500.077484115748, 4527.569880861313, 4707.340972263886, 5089.440161582223, 5094.057599344114, 5001.424836143854, 5060.671056381323, 5073.213651883945, 5075.517825806561, 5079.263506791532, 4359.934600980988, 4451.953790859146, 4484.663650226246, 4517.480489743656, 4527.547245275479, 19662.0, 20211.292604758764, 20248.89875550613, 20359.49101272465, 20441.080151393224, 1882.6517094337592, 1923.2307077169105, 1942.2522328903474, 2127.361791462555, 2333.334999525144, 13098.279594622292, 13114.0, 13127.277999710011, 13237.13958592698, 13796.0, 1655.553000689807, 1743.5379624399545, 1751.816059313779, 1763.6560870630233, 1769.0977601423238, 65754.67122664404, 66559.66720166417, 67252.32747672558, 67657.0, 68085.0, 8045.919540804517, 8577.356698247657, 8592.269657079218, 8749.693760718344, 8843.513606751561, 11570.42147892602, 11574.189806713617, 11578.0, 11587.88412115885, 11692.70768230801, 6548.8362790930605, 6802.829929251809, 6889.655517224119, 6979.651017449107, 7022.438204943593, 6781.186257649114, 6851.965740171367, 6908.5509441887125, 6990.965045174741, 7140.642967851587, 3638.2541578976247, 3667.44988251759, 3689.870854520079, 3746.7002639788752, 3753.2118255166174, 1682.621410182699, 1685.570179604193, 1722.3024675006643, 1753.438899552131, 1812.3656720148106, 377.2379792818491, 383.7697381571035, 658.3186402073926, 778.7430148051129, 788.1448628238311, 10110.545025473724, 15717.577435784637, 17367.56581085483, 17476.30094796194, 18195.81804181968, 825.2449009156554, 854.9444286121383, 861.5476874640864, 861.6294993153004, 873.4933738431695, 8993.505357205286, 9554.092361225672, 9587.712368628952, 9623.422594644204, 9807.852882206773, 373572.0, 377745.0, 379743.0, 382159.0, 382931.0, 75077.0, 75916.0, 76730.0, 76749.0, 80461.59769201117, 910.981780364389, 912.1471424218377, 929.9070092990647, 932.1238036245907, 933.1415098109755, 14632.634184145481, 14665.193414361886, 15066.0, 15282.548157925425, 15525.702275938122, 35474.467882982295, 35995.46006809952, 36192.638073618924, 36512.0, 36896.26207475889, 49410.0, 49467.0, 49567.0, 49893.501064988886, 50318.0, 7306.890396643948, 7539.396848252017, 7602.429817763579, 7614.733484328022, 7886.250806173404, 11114.888851111386, 11351.37567433799, 11579.652610421701, 11787.233829801036, 11866.169368144147, 10176.287659863738, 10223.386596804216, 10230.693079207636, 10234.283600148216, 10525.842112368167, 10237.590496380359, 10477.637907072032, 10485.895141048491, 10546.472676366304, 10713.839292410776, 9651.517424128626, 9872.802543948937, 10236.488175591041, 10280.897191027994, 10343.0, 7353.70585176587, 7540.0, 7654.579962041709, 7792.168840322406, 8058.798530036562, 9601.279904007368, 9838.606455741976, 10235.1300139486, 10439.791204176026, 10545.841812372668], "value": 7891.39621690712, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1321.9537316193935, 1340.8994325425592, 1402.200745575022, 1631.2659303313505, 1636.2963925512024, 6816.147981502312, 7089.432845372371, 7367.963160184198, 7927.167647397019, 7937.801554961129, 7376.557406555597, 7687.2697093776005, 7689.538627682343, 7891.723789667363, 7901.604919754003, 2103.08515795629, 2118.7245658064508, 2132.360291912428, 2132.4242454537266, 2133.9893300533477, 1791.9014454205014, 1860.0606693619702, 2101.6217080925426, 2140.4862832920066, 2142.1431427429075, 1788.8390044895957, 1804.7924488683773, 1814.2652225848553, 2027.0979414160631, 2108.7785782492847, 2050.0672194151775, 2051.8768873867616, 2053.5790163016623, 2055.640262953977, 2065.7211276477633, 2014.5366565689826, 2050.456628993303, 2054.342610364684, 2056.074766355146, 2061.7319748432606, 7552.4713270071115, 7685.462017658766, 7693.961530192313, 7702.306792388712, 7734.458587898849, 4419.071994881079, 4534.614557762594, 4536.410266665345, 4542.545745425431, 4550.317452382136, 2719.925629376405, 2809.887604495818, 2831.3346363604537, 2853.7431631153295, 2854.1722900358873, 837.3050368194384, 878.3675753457501, 878.5563290538302, 886.4769785826329, 895.4314010603249, 10574.788504229873, 10613.734656633645, 10627.468626568718, 10684.252102352915, 10711.571537138505, 3852.653261206449, 3926.1755031443145, 4054.3310353791885, 4064.1871625674394, 4151.8339266429, 9065.274778017743, 9068.410553314014, 9074.954625226832, 9076.273898088137, 9082.591283392263, 4666.906661866811, 4671.602913752301, 4680.485146633868, 4680.53194680536, 4681.274402467623, 4140.772257525805, 4265.317549192177, 4269.167512335127, 4280.571942805695, 4280.651594747645, 3554.87557935471, 3632.328019316435, 3689.723270754704, 3702.333579955634, 3708.2212735325343, 1140.4411838199223, 1177.4877928101132, 1179.168686076314, 1187.26389638423, 1188.7622475504934, 611.9663418511935, 706.6855249414065, 736.4071922102759, 736.8489459660757, 777.2887807655932, 5008.860835108828, 5139.383274007143, 5143.382794064736, 5161.638685292069, 5183.844484665466, 793.2662287384146, 808.6886548678801, 818.4802650316973, 861.2378045429715, 875.3303722652176, 3710.5361829771277, 3787.337215987191, 3801.4107813288983, 3834.9424758628643, 3975.1453437511072, 9445.0, 9483.14651681352, 9621.326507144573, 9645.469499177612, 9669.129778319984, 9588.185004274716, 9590.136887680143, 9591.760205994906, 9614.0, 9621.422714637005, 7024.964875175591, 7423.814404639819, 7476.551406915493, 7482.6632801524065, 7536.0, 5270.393904700855, 5290.312259406252, 5338.0, 5453.918191227214, 5595.776168953359, 8808.51553164582, 8894.688685895962, 8911.777205569653, 8931.598078086372, 8993.100689931216, 8396.832063358577, 8807.119288071142, 8809.735707928772, 8972.327075469497, 9103.863442048241, 6694.129763130762, 6768.796936091925, 6870.828229294308, 6872.931270687229, 6886.69009894566, 7373.594452305175, 7436.92563074384, 7440.627968601657, 7446.515976461729, 7454.695428300134, 6693.799186024427, 6699.263081060982, 6712.966435167793, 6714.83212919681, 6972.0, 6580.407763301326, 6660.367265109807, 6734.797956061326, 6747.561408508432, 6786.93213067863, 5998.970005149947, 6140.140380346666, 6208.596441231305, 6255.624662520263, 6259.3427690091885, 4386.12277544486, 4563.315502674493, 4614.700044497097, 4624.514425985223, 4663.160631086302, 4442.155990361821, 4466.062126953247, 4505.684602077954, 4572.0, 4734.289856521412], "value": 4059.0796935328135, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [281.53406112883187, 295.3281285076451, 295.70724982267535, 297.66810006842377, 299.6134985868229, 4617.399738034059, 4729.929051064237, 4785.784639691214, 4801.711897286161, 4823.276508523723, 4496.6402687784985, 4636.4436267647925, 4637.791299391527, 4693.859184224479, 4709.670323077386, 3731.4029755239167, 3746.2882052409955, 3751.8686845960397, 3761.8526349463405, 3762.172322089136, 3557.484164796103, 3756.455313979471, 3759.9624003759886, 3775.9622403776025, 3787.829547670348, 3429.7770644908, 3686.6313368663186, 3687.9815600921957, 3724.14344700719, 3738.4392341148773, 3695.260947810422, 3698.389765688658, 3708.3325001499584, 3715.7956312402807, 3720.1071742781673, 3280.3767284215924, 3292.37444885471, 3293.917652058694, 3298.2084299767885, 3318.4192766265805, 4540.545945405466, 4599.678022538424, 4614.907701845944, 4617.2612382018715, 4663.0, 4185.476815398075, 4187.958120418787, 4201.831926722927, 4207.326827707552, 4213.2837417639075, 4871.171900776876, 4895.143349913751, 4898.804047838083, 4906.264060390934, 4908.631852611033, 3495.3271028037384, 3556.6798988090936, 3563.6436356364416, 3564.9821750891338, 3578.6958108560802, 4988.251762235657, 5106.64253502255, 5123.2315152727015, 5124.871878203037, 5129.846104616868, 3629.346717590859, 3638.472421498868, 3639.1266096137265, 3641.1807343348064, 3643.690286325639, 3701.1857391373856, 3708.2583483303447, 3713.628637136265, 3714.888553343404, 3729.4219395993664, 4086.2644723949975, 4195.412642230091, 4202.285611446062, 4212.220739163265, 4214.3889136075095, 4843.1524483216, 4850.8787280317565, 4863.221884498464, 4878.780454879539, 4882.584980276645, 1214.7509760499076, 1255.6233130060946, 1278.6739381457855, 1296.2870421268265, 1296.3388671777273, 877.7410663854179, 901.4816480523594, 907.2061945797427, 908.9000209976897, 914.9725508234764, 4404.436425069119, 4408.184485870061, 4428.601425871687, 4441.844535441244, 4451.399061126771, 5065.746712664426, 5096.898062038813, 5098.490150984871, 5132.153194722829, 5141.71720555373, 4326.329418940069, 4371.956280437155, 4392.494863090786, 4405.867823965286, 4417.734935903856, 2666.58670904421, 2688.8790004449847, 2702.5135475614184, 2702.8783704733332, 2719.5376785946437, 4746.976265118721, 4769.403824521934, 4789.760511974388, 4818.518148185153, 4832.661713680009, 4985.227289770091, 5089.0, 5105.8723531911255, 5150.690958542425, 5153.510416510426, 4769.856904292877, 4776.23580227162, 4789.185838407479, 4799.66402351832, 4807.903841923212, 5082.136036873666, 5082.263071854634, 5088.618353623567, 5089.312942752681, 5093.439721630692, 4734.73958932262, 4905.950940490549, 4913.975430122827, 4919.926201106915, 4925.1873440881855, 4727.149113159664, 4769.689970151929, 4783.282507623884, 4795.664303498722, 4839.7096174229655, 3710.091027698123, 3714.0, 3715.758475699179, 3718.200586873835, 3721.7766933982966, 4835.879103022453, 4983.900321993612, 5010.599152067753, 5018.322526458881, 5066.82266120684, 4854.83008094715, 4854.985181149783, 4863.4650188479945, 4879.268109783561, 4886.706797592155, 4871.19625261842, 4875.561199492063, 4884.242942343943, 4908.680935739166, 4918.43438004634, 4539.931901021553, 4570.6800523963, 4700.2268661488515, 4769.76151192432, 4789.712617242976, 4805.471398146271, 4942.1104201244125, 4942.308076869169, 5004.099262132851, 5034.823781167642, 4899.289603007615, 4911.9754401227765, 4932.334134891744, 4937.530934561211, 4942.640773787093], "value": 3736.694706802845, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [620.4168082002919, 632.4782054804786, 654.8657525207333, 714.1572943926168, 728.3372131360463, 12212.145149839514, 13286.667833304173, 13334.799978000337, 13339.399727012284, 13369.0, 13386.866131338684, 13483.460661573525, 13537.729245415087, 13555.0, 13564.253966031863, 589.0722112672537, 604.9667268300242, 718.2888939949438, 727.9599622020813, 755.5504474837463, 749.7675720526627, 758.9981224783288, 759.0094926121409, 759.1535437986632, 759.9430042746789, 794.8171920458298, 796.2913007423398, 796.6415113199055, 796.7131832540281, 796.760971708488, 627.9309275979639, 646.066434002866, 648.8604949935786, 650.5348675696852, 792.1840504280572, 477.4080140625634, 559.3902646115713, 573.6701396696916, 575.7869588252331, 577.0824389221159, 13191.736165276641, 13220.801687974592, 13224.14043087206, 13228.669283267898, 13234.0, 11341.206115571913, 12028.45871935765, 12211.816822747576, 12228.388580571025, 12534.81197782034, 11460.484278207501, 11692.883071169264, 11701.239419437708, 11760.17678762487, 12111.091668124838, 3937.3503371943593, 3985.6811455083525, 4025.9194816103513, 4031.677465802729, 4072.6741860651077, 60115.69942150305, 60462.0, 61103.69448152731, 61972.38027619711, 62044.0, 9926.553305101288, 9973.451460169761, 10040.447775372424, 10048.497575121215, 10132.34139780912, 18446.81553184478, 18545.165467553994, 18587.535311617317, 18660.533486662942, 18760.343387981356, 6353.618782873043, 6381.074744162071, 6436.0, 6461.483081353481, 6660.9000864987065, 3399.5070714746716, 3436.9656303437146, 3478.4260597001717, 3492.8253587320532, 3511.0695665648623, 2560.641510188575, 2650.933726656849, 2656.1102030819893, 2666.1734862192784, 2670.105514652574, 466.5847395817725, 466.7666166916542, 468.59232467752594, 475.9524047595213, 480.1070009781803, 453.6416231177333, 470.6139870854802, 562.9521490673256, 577.1026054485316, 586.5920396771278, 7675.270849269311, 7903.407244456689, 8026.317762990095, 8095.554744488992, 8192.18078192176, 505.9797608095635, 534.2600498309869, 561.8146011816173, 574.6379780738108, 580.4427749360576, 3295.489199174132, 3686.391745362039, 3766.851110411296, 3850.6919446444217, 3997.7801220932547, 55152.448475515535, 55451.72274138604, 55488.44511554913, 56430.43569564334, 98351.0, 85322.57338713267, 86257.5687121573, 86672.0, 88768.5561572188, 89074.0, 61563.692181538805, 71338.28661713524, 71522.0, 74125.62937185388, 74515.0, 7260.0, 7499.550026998398, 7541.509801862861, 7596.316331530189, 7632.923670763444, 31819.522707158947, 31837.36325273528, 45073.323900140866, 45453.77273113613, 45476.8630784233, 60889.69555152196, 67439.0, 68060.31939680738, 68276.317236827, 70553.0, 9521.904780952102, 9639.325247232626, 9800.607975681178, 9914.801703965735, 9944.204463643036, 10622.309549879234, 10639.414832184304, 10770.73073173177, 10862.456877156268, 11736.119791015537, 10352.0, 10406.73983150397, 10423.530941107516, 11684.18210725241, 12342.629721108382, 11631.594907511162, 12262.816057759319, 12289.754204916031, 12316.199447035913, 12731.2997785119, 10985.780284394108, 11239.943800280946, 11317.362890570843, 11531.308121512737, 12272.386380680751, 9865.950670246602, 10127.139193168663, 10207.183425325808, 10354.430506322225, 10566.735831604272, 10154.796904062025, 10431.68704938853, 10612.946935265274, 10716.410597417216, 10742.3017503862], "value": 6281.034178259604, "unit": "score"}], "name": "dromaeo_css", "value": 6194.092274771786, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 116.0, 118.0, 119.0, 116.0, 117.0, 116.0, 116.0, 117.0, 116.0], "value": 116.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 135.0, 129.0, 170.0, 128.0, 134.0, 127.0, 133.0, 162.0, 125.0], "value": 139.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 162.0, 163.0, 161.0, 162.0, 162.0, 161.0, 160.0, 161.0], "value": 161.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 77.0, 117.0, 77.0, 77.0, 78.0, 77.0, 111.0, 75.0], "value": 84.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 114.0, 84.0, 84.0, 84.0, 107.0, 84.0, 84.0, 120.0], "value": 92.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 116.0, 116.0, 117.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 147.0, 146.0, 146.0, 147.0, 146.0, 146.0, 147.0, 146.0], "value": 146.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 65.0, 65.0, 66.0, 65.0, 66.0, 65.0, 66.0, 66.0, 66.0], "value": 65.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 66.0, 66.0, 67.0, 66.0, 67.0, 68.0, 66.0, 66.0], "value": 66.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 86.0, 84.0, 84.0, 83.0, 85.0, 84.0, 83.0, 84.0, 83.0], "value": 85.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 143.0, 148.0, 142.0, 140.0, 140.0, 138.0, 138.0, 180.0, 143.0], "value": 145.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 175.0, 178.0, 177.0, 174.0, 182.0, 175.0, 175.0, 175.0, 175.0], "value": 176.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 70.0, 73.0, 69.0, 70.0, 73.0, 69.0, 69.0, 70.0, 68.0], "value": 70.1, "unit": "score"}], "name": "kraken", "value": 1560.9999999999998, "alertThreshold": 2.0}]} 01:45:33 INFO - Return code: 0 01:45:33 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 01:45:33 INFO - # TBPL SUCCESS # 01:45:33 INFO - Running post-action listener: _resource_record_post_action 01:45:33 INFO - [mozharness: 2016-10-06 08:45:33.573699Z] Finished run-tests step (success) 01:45:33 INFO - Running post-run listener: _resource_record_post_run 01:45:33 INFO - Total resource usage - Wall time: 1204s; CPU: 13.0%; Read bytes: 4096; Write bytes: 405499904; Read time: 8; Write time: 227476 01:45:33 INFO - TinderboxPrint: CPU usage
13.0% 01:45:33 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 01:45:33 INFO - TinderboxPrint: I/O write bytes / time
405,499,904 / 227,476 01:45:33 INFO - TinderboxPrint: CPU idle
8,355.7 (87.0%) 01:45:33 INFO - TinderboxPrint: CPU user
1,201.2 (12.5%) 01:45:33 INFO - TinderboxPrint: Swap in / out
0 / 0 01:45:33 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 115974144; Read time: 0; Write time: 56664 01:45:33 INFO - run-tests - Wall time: 1189s; CPU: 13.0%; Read bytes: 0; Write bytes: 289525760; Read time: 0; Write time: 170812 01:45:34 INFO - Running post-run listener: _upload_blobber_files 01:45:34 INFO - Blob upload gear active. 01:45:34 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 01:45:34 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 01:45:34 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', 'Autoland-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 01:45:34 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 Autoland-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 01:45:34 INFO - (blobuploader) - INFO - Open directory for files ... 01:45:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 01:45:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:45:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:45:37 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 01:45:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:45:37 INFO - (blobuploader) - INFO - Done attempting. 01:45:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 01:45:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:45:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:45:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 01:45:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:45:39 INFO - (blobuploader) - INFO - Done attempting. 01:45:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 01:45:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:45:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:45:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 01:45:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:45:39 INFO - (blobuploader) - INFO - Done attempting. 01:45:39 INFO - (blobuploader) - INFO - Iteration through files over. 01:45:39 INFO - Return code: 0 01:45:39 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 01:45:39 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 01:45:39 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/003958b22358e3bdc7412985b5bbb587b8fbb5a03b5842fc083177f63e57cd0dc54d5c7e5bfe5f782c5056e73daa60e03b7396a3eef3ef8ca9ff204c9c9b381e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/62eb14b48a2f8e0b15aba6c87b0194c37cfb23124843dfddfd0b8f330d528b139e19c1107de5e6f31919f984b26dc82dac71b52576860e4f39d08a9023021efc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/4506b6125434b18e69aa06d601145d77e3fbc2f02dada3a2e2cdd61d91eafd78e689f0c2e3bd0528bd591d0fa608b098d6b7c2d005612240b68a1683e085c754"} 01:45:39 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 01:45:39 INFO - Writing to file /builds/slave/test/properties/blobber_files 01:45:39 INFO - Contents: 01:45:39 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/003958b22358e3bdc7412985b5bbb587b8fbb5a03b5842fc083177f63e57cd0dc54d5c7e5bfe5f782c5056e73daa60e03b7396a3eef3ef8ca9ff204c9c9b381e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/62eb14b48a2f8e0b15aba6c87b0194c37cfb23124843dfddfd0b8f330d528b139e19c1107de5e6f31919f984b26dc82dac71b52576860e4f39d08a9023021efc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/4506b6125434b18e69aa06d601145d77e3fbc2f02dada3a2e2cdd61d91eafd78e689f0c2e3bd0528bd591d0fa608b098d6b7c2d005612240b68a1683e085c754"} 01:45:39 INFO - Running post-run listener: copy_logs_to_upload_dir 01:45:39 INFO - Copying logs to upload dir... 01:45:39 INFO - mkdir: /builds/slave/test/build/upload/logs 01:45:39 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.966380 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-10-06 01:45:39.176223) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-06 01:45:39.180134) ========= 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=d2a8c569965ab8367867b893000001a1-1475742197.669836-1520761353 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/003958b22358e3bdc7412985b5bbb587b8fbb5a03b5842fc083177f63e57cd0dc54d5c7e5bfe5f782c5056e73daa60e03b7396a3eef3ef8ca9ff204c9c9b381e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/62eb14b48a2f8e0b15aba6c87b0194c37cfb23124843dfddfd0b8f330d528b139e19c1107de5e6f31919f984b26dc82dac71b52576860e4f39d08a9023021efc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/4506b6125434b18e69aa06d601145d77e3fbc2f02dada3a2e2cdd61d91eafd78e689f0c2e3bd0528bd591d0fa608b098d6b7c2d005612240b68a1683e085c754"} build_url:https://queue.taskcluster.net/v1/task/Xqwh8lx_QsitZ6zErCy22g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011372 build_url: 'https://queue.taskcluster.net/v1/task/Xqwh8lx_QsitZ6zErCy22g/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/Autoland-Non-PGO/sha512/003958b22358e3bdc7412985b5bbb587b8fbb5a03b5842fc083177f63e57cd0dc54d5c7e5bfe5f782c5056e73daa60e03b7396a3eef3ef8ca9ff204c9c9b381e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/62eb14b48a2f8e0b15aba6c87b0194c37cfb23124843dfddfd0b8f330d528b139e19c1107de5e6f31919f984b26dc82dac71b52576860e4f39d08a9023021efc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/4506b6125434b18e69aa06d601145d77e3fbc2f02dada3a2e2cdd61d91eafd78e689f0c2e3bd0528bd591d0fa608b098d6b7c2d005612240b68a1683e085c754"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-06 01:45:39.209930) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 01:45:39.210266) ========= 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=d2a8c569965ab8367867b893000001a1-1475742197.669836-1520761353 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004513 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 01:45:39.293433) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-06 01:45:39.293759) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-06 01:45:39.294027) ========= ========= Total master_lag: 0.20 =========