builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-042 starttime: 1475900278.69 results: success (0) buildid: 20161007195722 builduid: 0b0c430461154a90bfed7b3b36f43c5f revision: efa3b654aa77bcb9b3dd7fc5a52efb6b5afc34d6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-07 21:17:58.688438) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-07 21:17:58.691022) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-07 21:17:58.691472) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-07 21:17:58.721105) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-07 21:17:58.721499) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=74d6aec007b0fa31a864ebd7000001f8-1475899969.994681-1799934594 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-07 21:17:58-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.5M=0s 2016-10-07 21:17:58 (46.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.122061 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-07 21:17:58.865513) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-07 21:17:58.865836) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=74d6aec007b0fa31a864ebd7000001f8-1475899969.994681-1799934594 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020948 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-07 21:17:58.917015) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-07 21:17:58.917559) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev efa3b654aa77bcb9b3dd7fc5a52efb6b5afc34d6 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev efa3b654aa77bcb9b3dd7fc5a52efb6b5afc34d6 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=74d6aec007b0fa31a864ebd7000001f8-1475899969.994681-1799934594 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-07 21:17:59,087 truncating revision to first 12 chars 2016-10-07 21:17:59,088 Setting DEBUG logging. 2016-10-07 21:17:59,088 attempt 1/10 2016-10-07 21:17:59,088 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/efa3b654aa77?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-07 21:17:59,690 unpacking tar archive at: mozilla-central-efa3b654aa77/testing/mozharness/ program finished with exit code 0 elapsedTime=0.950525 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-07 21:17:59.888130) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-07 21:17:59.888611) ========= script_repo_revision: efa3b654aa77bcb9b3dd7fc5a52efb6b5afc34d6 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-07 21:17:59.889169) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-07 21:17:59.889493) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-07 21:17:59.901051) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-10-07 21:17:59.901602) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=74d6aec007b0fa31a864ebd7000001f8-1475899969.994681-1799934594 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 21:18:00 INFO - MultiFileLogger online at 20161007 21:18:00 in /builds/slave/test 21:18:00 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 21:18:00 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:18:00 INFO - {'append_to_log': False, 21:18:00 INFO - 'base_work_dir': '/builds/slave/test', 21:18:00 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 21:18:00 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:18:00 INFO - 'branch': 'Firefox-Non-PGO', 21:18:00 INFO - 'buildbot_json_path': 'buildprops.json', 21:18:00 INFO - 'config_files': ('talos/linux_config.py',), 21:18:00 INFO - 'default_actions': ('clobber', 21:18:00 INFO - 'read-buildbot-config', 21:18:00 INFO - 'download-and-extract', 21:18:00 INFO - 'populate-webroot', 21:18:00 INFO - 'create-virtualenv', 21:18:00 INFO - 'install', 21:18:00 INFO - 'run-tests'), 21:18:00 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:18:00 INFO - 'download_minidump_stackwalk': True, 21:18:00 INFO - 'download_symbols': 'ondemand', 21:18:00 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:18:00 INFO - 'tooltool.py': '/tools/tooltool.py', 21:18:00 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:18:00 INFO - '/tools/misc-python/virtualenv.py')}, 21:18:00 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:18:00 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:18:00 INFO - 'installer_path': 'installer.exe', 21:18:00 INFO - 'log_level': 'info', 21:18:00 INFO - 'log_name': 'talos', 21:18:00 INFO - 'log_to_console': True, 21:18:00 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 21:18:00 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 21:18:00 INFO - 'opt_config_files': (), 21:18:00 INFO - 'pip_index': False, 21:18:00 INFO - 'sps_profile': False, 21:18:00 INFO - 'sps_profile_interval': 0, 21:18:00 INFO - 'suite': 'dromaeojs', 21:18:00 INFO - 'system_bits': '32', 21:18:00 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:18:00 INFO - 'title': 'talos-linux64-ix-042', 21:18:00 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:18:00 INFO - 'use_talos_json': True, 21:18:00 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:18:00 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:18:00 INFO - 'work_dir': 'build'} 21:18:00 INFO - [mozharness: 2016-10-08 04:18:00.165319Z] Running clobber step. 21:18:00 INFO - Running pre-action listener: _resource_record_pre_action 21:18:00 INFO - Running main action method: clobber 21:18:00 INFO - rmtree: /builds/slave/test/build 21:18:00 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:18:01 INFO - Running post-action listener: _resource_record_post_action 21:18:01 INFO - [mozharness: 2016-10-08 04:18:01.135173Z] Finished clobber step (success) 21:18:01 INFO - [mozharness: 2016-10-08 04:18:01.135275Z] Running read-buildbot-config step. 21:18:01 INFO - Running pre-action listener: _resource_record_pre_action 21:18:01 INFO - Running main action method: read_buildbot_config 21:18:01 INFO - Using buildbot properties: 21:18:01 INFO - { 21:18:01 INFO - "project": "", 21:18:01 INFO - "product": "firefox", 21:18:01 INFO - "script_repo_revision": "production", 21:18:01 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 21:18:01 INFO - "repository": "", 21:18:01 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 21:18:01 INFO - "buildid": "20161007195722", 21:18:01 INFO - "pgo_build": "False", 21:18:01 INFO - "basedir": "/builds/slave/test", 21:18:01 INFO - "buildnumber": 235, 21:18:01 INFO - "slavename": "talos-linux64-ix-042", 21:18:01 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 21:18:01 INFO - "platform": "ubuntu64_hw", 21:18:01 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 21:18:01 INFO - "branch": "mozilla-central", 21:18:01 INFO - "repo_path": "mozilla-central", 21:18:01 INFO - "revision": "efa3b654aa77bcb9b3dd7fc5a52efb6b5afc34d6", 21:18:01 INFO - "stage_platform": "linux64", 21:18:01 INFO - "builduid": "0b0c430461154a90bfed7b3b36f43c5f", 21:18:01 INFO - "slavebuilddir": "test" 21:18:01 INFO - } 21:18:01 INFO - Found installer url https://queue.taskcluster.net/v1/task/VFgeObhNTxS8XK-dc_Wtjw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 21:18:01 INFO - Running post-action listener: _resource_record_post_action 21:18:01 INFO - [mozharness: 2016-10-08 04:18:01.137699Z] Finished read-buildbot-config step (success) 21:18:01 INFO - [mozharness: 2016-10-08 04:18:01.137787Z] Running download-and-extract step. 21:18:01 INFO - Running pre-action listener: _resource_record_pre_action 21:18:01 INFO - Running main action method: download_and_extract 21:18:01 INFO - mkdir: /builds/slave/test/build/tests 21:18:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:18:01 INFO - trying https://queue.taskcluster.net/v1/task/VFgeObhNTxS8XK-dc_Wtjw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 21:18:01 INFO - Downloading https://queue.taskcluster.net/v1/task/VFgeObhNTxS8XK-dc_Wtjw/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 21:18:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VFgeObhNTxS8XK-dc_Wtjw/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 21:18:01 INFO - Downloaded 1361 bytes. 21:18:01 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 21:18:01 INFO - Using the following test package requirements: 21:18:01 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 21:18:01 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:18:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 21:18:01 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:18:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 21:18:01 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:18:01 INFO - u'jsshell-linux-x86_64.zip'], 21:18:01 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:18:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 21:18:01 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 21:18:01 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:18:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 21:18:01 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:18:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 21:18:01 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:18:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 21:18:01 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:18:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 21:18:01 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 21:18:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VFgeObhNTxS8XK-dc_Wtjw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 21:18:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VFgeObhNTxS8XK-dc_Wtjw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:18:01 INFO - Fetch https://queue.taskcluster.net/v1/task/VFgeObhNTxS8XK-dc_Wtjw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 21:18:02 INFO - Http code: 200 21:18:02 INFO - via: 1.1 41b2ee7cbe95749816a7586d9ab4629d.cloudfront.net (CloudFront) 21:18:02 INFO - x-amz-cf-id: MvJ95kXNfizWkPYuxPPLRmfNZgwDHu-CXH0bJdhOqkgcLr_fsrJ_hw== 21:18:02 INFO - x-amz-version-id: xPgIwzD4Lt3LxRzjeqhrEZvWyesuyM11 21:18:02 INFO - Expected file size: 20461484 21:18:02 INFO - Obtained file size: 20461484 21:18:06 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 21:18:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VFgeObhNTxS8XK-dc_Wtjw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 21:18:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VFgeObhNTxS8XK-dc_Wtjw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:18:06 INFO - Fetch https://queue.taskcluster.net/v1/task/VFgeObhNTxS8XK-dc_Wtjw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 21:18:07 INFO - Http code: 200 21:18:07 INFO - via: 1.1 6cd88b9fd84ad5daa3b3867fb8c5c91a.cloudfront.net (CloudFront) 21:18:07 INFO - x-amz-cf-id: aGW_chbPGzXMCLNebiFn3XqxDo4BtR_oWzLUml7wOt3VeKmzBwnrMg== 21:18:07 INFO - x-amz-version-id: xPgIwzD4Lt3LxRzjeqhrEZvWyesuyM11 21:18:07 INFO - Expected file size: 20461484 21:18:07 INFO - Obtained file size: 20461484 21:18:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VFgeObhNTxS8XK-dc_Wtjw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 21:18:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VFgeObhNTxS8XK-dc_Wtjw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 21:18:11 INFO - Fetch https://queue.taskcluster.net/v1/task/VFgeObhNTxS8XK-dc_Wtjw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 21:18:12 INFO - Http code: 200 21:18:12 INFO - via: 1.1 bb8a7ff26b131d51953dc2d3e19a2751.cloudfront.net (CloudFront) 21:18:12 INFO - x-amz-cf-id: IUh6bnCDT0I0wCGNBRWXLVvHp4EJ9h5c27w3pJdOH7MFZxCHaHZggQ== 21:18:12 INFO - x-amz-version-id: 4ZAE6V8S6m7oWv97bXdSPbzlJmtVaXjf 21:18:12 INFO - Expected file size: 14409006 21:18:12 INFO - Obtained file size: 14409006 21:18:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:18:13 INFO - trying https://queue.taskcluster.net/v1/task/VFgeObhNTxS8XK-dc_Wtjw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 21:18:13 INFO - Downloading https://queue.taskcluster.net/v1/task/VFgeObhNTxS8XK-dc_Wtjw/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 21:18:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VFgeObhNTxS8XK-dc_Wtjw/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 21:18:15 INFO - Downloaded 55869875 bytes. 21:18:15 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/VFgeObhNTxS8XK-dc_Wtjw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 21:18:15 INFO - mkdir: /builds/slave/test/properties 21:18:15 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:18:15 INFO - Writing to file /builds/slave/test/properties/build_url 21:18:15 INFO - Contents: 21:18:15 INFO - build_url:https://queue.taskcluster.net/v1/task/VFgeObhNTxS8XK-dc_Wtjw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 21:18:15 INFO - Running post-action listener: _resource_record_post_action 21:18:15 INFO - Running post-action listener: set_extra_try_arguments 21:18:15 INFO - [mozharness: 2016-10-08 04:18:15.933249Z] Finished download-and-extract step (success) 21:18:15 INFO - [mozharness: 2016-10-08 04:18:15.933476Z] Running populate-webroot step. 21:18:15 INFO - Running pre-action listener: _resource_record_pre_action 21:18:15 INFO - Running main action method: populate_webroot 21:18:15 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:18:15 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:18:15 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:18:15 INFO - '--tppagecycles', 21:18:15 INFO - '7'], 21:18:15 INFO - 'tests': ['tsvgm']}}, 21:18:15 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 21:18:15 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:18:15 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:18:15 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 21:18:15 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:18:15 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:18:15 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:18:15 INFO - 'talos_options': ['--disable-e10s'], 21:18:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:18:15 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:18:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:18:15 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:18:15 INFO - 'talos_options': ['--disable-e10s'], 21:18:15 INFO - 'tests': ['damp', 'tps']}, 21:18:15 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:18:15 INFO - 'tests': ['damp', 'tps']}, 21:18:15 INFO - 'g3': {'talos_options': ['--disable-e10s'], 21:18:15 INFO - 'tests': ['dromaeo_dom']}, 21:18:15 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:18:15 INFO - 'g4': {'talos_options': ['--disable-e10s'], 21:18:15 INFO - 'tests': ['basic_compositor_video']}, 21:18:15 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 21:18:15 INFO - 'other': {'talos_options': ['--disable-e10s'], 21:18:15 INFO - 'tests': ['a11yr', 21:18:15 INFO - 'ts_paint', 21:18:15 INFO - 'tpaint', 21:18:15 INFO - 'sessionrestore', 21:18:15 INFO - 'sessionrestore_no_auto_restore', 21:18:15 INFO - 'tabpaint']}, 21:18:15 INFO - 'other-e10s': {'tests': ['a11yr', 21:18:15 INFO - 'ts_paint', 21:18:15 INFO - 'tpaint', 21:18:15 INFO - 'sessionrestore', 21:18:15 INFO - 'sessionrestore_no_auto_restore', 21:18:15 INFO - 'tabpaint']}, 21:18:15 INFO - 'other-e10s_l64': {'tests': ['a11yr', 21:18:15 INFO - 'ts_paint', 21:18:15 INFO - 'tpaint', 21:18:15 INFO - 'sessionrestore', 21:18:15 INFO - 'sessionrestore_no_auto_restore', 21:18:15 INFO - 'tabpaint']}, 21:18:15 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 21:18:15 INFO - 'ts_paint', 21:18:15 INFO - 'tpaint', 21:18:15 INFO - 'sessionrestore', 21:18:15 INFO - 'sessionrestore_no_auto_restore', 21:18:15 INFO - 'tabpaint']}, 21:18:15 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 21:18:15 INFO - 'tests': ['a11yr', 21:18:15 INFO - 'ts_paint', 21:18:15 INFO - 'tpaint', 21:18:15 INFO - 'sessionrestore', 21:18:15 INFO - 'sessionrestore_no_auto_restore', 21:18:15 INFO - 'tabpaint']}, 21:18:15 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 21:18:15 INFO - 'tests': ['a11yr', 21:18:15 INFO - 'ts_paint', 21:18:15 INFO - 'tpaint', 21:18:15 INFO - 'sessionrestore', 21:18:15 INFO - 'sessionrestore_no_auto_restore', 21:18:15 INFO - 'tabpaint']}, 21:18:15 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 21:18:15 INFO - 'tests': ['tsvgx', 21:18:15 INFO - 'tsvgr_opacity', 21:18:15 INFO - 'tart', 21:18:15 INFO - 'tscrollx', 21:18:15 INFO - 'cart']}, 21:18:15 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:18:15 INFO - 'tsvgr_opacity', 21:18:15 INFO - 'tart', 21:18:15 INFO - 'tscrollx', 21:18:15 INFO - 'cart']}, 21:18:15 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:18:15 INFO - 'talos_options': ['--disable-e10s'], 21:18:15 INFO - 'tests': ['tp5o']}, 21:18:15 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:18:15 INFO - 'tests': ['tp5o']}, 21:18:15 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:18:15 INFO - 'talos_options': ['--disable-e10s', 21:18:15 INFO - '--xperf_path', 21:18:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:18:15 INFO - 'tests': ['tp5n']}, 21:18:15 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:18:15 INFO - 'talos_options': ['--xperf_path', 21:18:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:18:15 INFO - 'tests': ['tp5n']}}, 21:18:15 INFO - 'talos.zip': {'path': '', 21:18:15 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:18:15 INFO - Running post-action listener: _resource_record_post_action 21:18:15 INFO - [mozharness: 2016-10-08 04:18:15.949682Z] Finished populate-webroot step (success) 21:18:15 INFO - [mozharness: 2016-10-08 04:18:15.949769Z] Running create-virtualenv step. 21:18:15 INFO - Running pre-action listener: _resource_record_pre_action 21:18:15 INFO - Running main action method: create_virtualenv 21:18:15 INFO - Creating virtualenv /builds/slave/test/build/venv 21:18:15 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 21:18:15 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:18:16 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:18:16 INFO - Using real prefix '/usr' 21:18:16 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:18:16 INFO - Installing distribute.............................................................................................................................................................................................done. 21:18:18 INFO - Installing pip.................done. 21:18:18 INFO - Return code: 0 21:18:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 21:18:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 21:18:18 INFO - Reading from file tmpfile_stdout 21:18:18 INFO - Output received: 21:18:18 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) 21:18:18 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:18:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:18:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:18:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:18:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:18:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:18:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:18:18 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 0x7fb34a260f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d138a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1de0ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dddf60>, '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 0x1dded40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ddf1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1475899969.994681-1799934594', '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 21:18:18 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 21:18:18 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 21:18:18 INFO - Using env: {'DISPLAY': ':0', 21:18:18 INFO - 'HOME': '/home/cltbld', 21:18:18 INFO - 'LANG': 'en_US.UTF-8', 21:18:18 INFO - 'LANGUAGE': 'en_US:en', 21:18:18 INFO - 'LOGNAME': 'cltbld', 21:18:18 INFO - 'MAIL': '/var/mail/cltbld', 21:18:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:18:18 INFO - 'MOZ_NO_REMOTE': '1', 21:18:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:18:18 INFO - 'NO_EM_RESTART': '1', 21:18:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:18:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:18:18 INFO - 'PWD': '/builds/slave/test', 21:18:18 INFO - 'SHELL': '/bin/bash', 21:18:18 INFO - 'SHLVL': '1', 21:18:18 INFO - 'TERM': 'linux', 21:18:18 INFO - 'TMOUT': '86400', 21:18:18 INFO - 'USER': 'cltbld', 21:18:18 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1475899969.994681-1799934594', 21:18:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:18:18 INFO - '_': '/tools/buildbot/bin/python'} 21:18:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:18:18 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 21:18:18 INFO - Cleaning up... 21:18:18 INFO - Return code: 0 21:18:18 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 21:18:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:18:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:18:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:18:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:18:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:18:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:18:18 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 0x7fb34a260f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d138a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1de0ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dddf60>, '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 0x1dded40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ddf1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1475899969.994681-1799934594', '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 21:18:18 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 21:18:18 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 21:18:18 INFO - Using env: {'DISPLAY': ':0', 21:18:18 INFO - 'HOME': '/home/cltbld', 21:18:18 INFO - 'LANG': 'en_US.UTF-8', 21:18:18 INFO - 'LANGUAGE': 'en_US:en', 21:18:18 INFO - 'LOGNAME': 'cltbld', 21:18:18 INFO - 'MAIL': '/var/mail/cltbld', 21:18:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:18:18 INFO - 'MOZ_NO_REMOTE': '1', 21:18:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:18:18 INFO - 'NO_EM_RESTART': '1', 21:18:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:18:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:18:18 INFO - 'PWD': '/builds/slave/test', 21:18:18 INFO - 'SHELL': '/bin/bash', 21:18:18 INFO - 'SHLVL': '1', 21:18:18 INFO - 'TERM': 'linux', 21:18:18 INFO - 'TMOUT': '86400', 21:18:18 INFO - 'USER': 'cltbld', 21:18:18 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1475899969.994681-1799934594', 21:18:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:18:18 INFO - '_': '/tools/buildbot/bin/python'} 21:18:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:18:19 INFO - Downloading/unpacking psutil>=3.1.1 21:18: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 21:18: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 21:18: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 21:18: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 21:18: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 21:18: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 21:18:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:18:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:18:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:18:21 INFO - Installing collected packages: psutil 21:18:21 INFO - Running setup.py install for psutil 21:18:21 INFO - building 'psutil._psutil_linux' extension 21:18:21 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 21:18:21 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 21:18:21 INFO - building 'psutil._psutil_posix' extension 21:18:21 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 21:18:21 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 21:18:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:18:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:18:21 INFO - Successfully installed psutil 21:18:21 INFO - Cleaning up... 21:18:21 INFO - Return code: 0 21:18:21 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 21:18:21 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')]} 21:18:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:18:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:18:21 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')]} 21:18:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:18:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:18:21 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 0x7fb34a260f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d138a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1de0ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dddf60>, '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 0x1dded40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ddf1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1475899969.994681-1799934594', '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 21:18:21 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 21:18:21 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 21:18:21 INFO - Using env: {'DISPLAY': ':0', 21:18:21 INFO - 'HOME': '/home/cltbld', 21:18:21 INFO - 'LANG': 'en_US.UTF-8', 21:18:21 INFO - 'LANGUAGE': 'en_US:en', 21:18:21 INFO - 'LOGNAME': 'cltbld', 21:18:21 INFO - 'MAIL': '/var/mail/cltbld', 21:18:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:18:21 INFO - 'MOZ_NO_REMOTE': '1', 21:18:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:18:21 INFO - 'NO_EM_RESTART': '1', 21:18:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:18:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:18:21 INFO - 'PWD': '/builds/slave/test', 21:18:21 INFO - 'SHELL': '/bin/bash', 21:18:21 INFO - 'SHLVL': '1', 21:18:21 INFO - 'TERM': 'linux', 21:18:21 INFO - 'TMOUT': '86400', 21:18:21 INFO - 'USER': 'cltbld', 21:18:21 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1475899969.994681-1799934594', 21:18:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:18:21 INFO - '_': '/tools/buildbot/bin/python'} 21:18:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:18:21 INFO - Downloading/unpacking mozsystemmonitor==0.3 21:18:21 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 21:18:21 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 21:18:21 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 21:18:21 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 21:18:21 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 21:18:21 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 21:18:23 INFO - Downloading mozsystemmonitor-0.3.tar.gz 21:18:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:18:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 21:18:23 INFO - Installing collected packages: mozsystemmonitor 21:18:23 INFO - Running setup.py install for mozsystemmonitor 21:18:23 INFO - Successfully installed mozsystemmonitor 21:18:23 INFO - Cleaning up... 21:18:24 INFO - Return code: 0 21:18:24 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 21:18: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')]} 21:18:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:18:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:18: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')]} 21:18:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:18:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:18:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb34a260f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d138a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1de0ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dddf60>, '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 0x1dded40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ddf1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1475899969.994681-1799934594', '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 21:18:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 21:18:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 21:18:24 INFO - Using env: {'DISPLAY': ':0', 21:18:24 INFO - 'HOME': '/home/cltbld', 21:18:24 INFO - 'LANG': 'en_US.UTF-8', 21:18:24 INFO - 'LANGUAGE': 'en_US:en', 21:18:24 INFO - 'LOGNAME': 'cltbld', 21:18:24 INFO - 'MAIL': '/var/mail/cltbld', 21:18:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:18:24 INFO - 'MOZ_NO_REMOTE': '1', 21:18:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:18:24 INFO - 'NO_EM_RESTART': '1', 21:18:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:18:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:18:24 INFO - 'PWD': '/builds/slave/test', 21:18:24 INFO - 'SHELL': '/bin/bash', 21:18:24 INFO - 'SHLVL': '1', 21:18:24 INFO - 'TERM': 'linux', 21:18:24 INFO - 'TMOUT': '86400', 21:18:24 INFO - 'USER': 'cltbld', 21:18:24 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1475899969.994681-1799934594', 21:18:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:18:24 INFO - '_': '/tools/buildbot/bin/python'} 21:18:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:18:24 INFO - Downloading/unpacking jsonschema==2.5.1 21:18:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:18:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:18:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:18:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:18:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:18:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:18:26 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:18:26 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 21:18:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:18:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:18:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:18:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:18:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:18:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:18:26 INFO - Downloading functools32-3.2.3-2.tar.gz 21:18:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:18:26 INFO - warning: no files found matching '*.txt' 21:18:26 INFO - no previously-included directories found matching 'build' 21:18:26 INFO - no previously-included directories found matching 'dist' 21:18:26 INFO - no previously-included directories found matching '.git*' 21:18:26 INFO - Installing collected packages: jsonschema, functools32 21:18:26 INFO - Running setup.py install for functools32 21:18:26 INFO - warning: no files found matching '*.txt' 21:18:26 INFO - no previously-included directories found matching 'build' 21:18:26 INFO - no previously-included directories found matching 'dist' 21:18:26 INFO - no previously-included directories found matching '.git*' 21:18:26 INFO - Successfully installed jsonschema functools32 21:18:26 INFO - Cleaning up... 21:18:26 INFO - Return code: 0 21:18:26 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 21:18:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:18:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:18:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:18:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:18:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:18:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:18:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fb34a260f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d138a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1de0ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dddf60>, '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 0x1dded40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ddf1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1475899969.994681-1799934594', '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 21:18:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 21:18:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 21:18:26 INFO - Using env: {'DISPLAY': ':0', 21:18:26 INFO - 'HOME': '/home/cltbld', 21:18:26 INFO - 'LANG': 'en_US.UTF-8', 21:18:26 INFO - 'LANGUAGE': 'en_US:en', 21:18:26 INFO - 'LOGNAME': 'cltbld', 21:18:26 INFO - 'MAIL': '/var/mail/cltbld', 21:18:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:18:26 INFO - 'MOZ_NO_REMOTE': '1', 21:18:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:18:26 INFO - 'NO_EM_RESTART': '1', 21:18:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:18:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:18:26 INFO - 'PWD': '/builds/slave/test', 21:18:26 INFO - 'SHELL': '/bin/bash', 21:18:26 INFO - 'SHLVL': '1', 21:18:26 INFO - 'TERM': 'linux', 21:18:26 INFO - 'TMOUT': '86400', 21:18:26 INFO - 'USER': 'cltbld', 21:18:26 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1475899969.994681-1799934594', 21:18:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:18:26 INFO - '_': '/tools/buildbot/bin/python'} 21:18:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:18:26 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 21:18:26 INFO - Cleaning up... 21:18:26 INFO - Return code: 0 21:18:26 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:18:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:18:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:18:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:18:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:18:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:18:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:18:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fb34a260f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d138a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1de0ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dddf60>, '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 0x1dded40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ddf1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1475899969.994681-1799934594', '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 21:18:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 21:18:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 21:18:26 INFO - Using env: {'DISPLAY': ':0', 21:18:26 INFO - 'HOME': '/home/cltbld', 21:18:26 INFO - 'LANG': 'en_US.UTF-8', 21:18:26 INFO - 'LANGUAGE': 'en_US:en', 21:18:26 INFO - 'LOGNAME': 'cltbld', 21:18:26 INFO - 'MAIL': '/var/mail/cltbld', 21:18:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:18:26 INFO - 'MOZ_NO_REMOTE': '1', 21:18:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:18:26 INFO - 'NO_EM_RESTART': '1', 21:18:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:18:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:18:26 INFO - 'PWD': '/builds/slave/test', 21:18:26 INFO - 'SHELL': '/bin/bash', 21:18:26 INFO - 'SHLVL': '1', 21:18:26 INFO - 'TERM': 'linux', 21:18:26 INFO - 'TMOUT': '86400', 21:18:26 INFO - 'USER': 'cltbld', 21:18:26 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1475899969.994681-1799934594', 21:18:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:18:26 INFO - '_': '/tools/buildbot/bin/python'} 21:18:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:18:27 INFO - Downloading/unpacking blobuploader==1.2.4 21:18:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:18:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:18:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:18:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:18:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:18:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:18:28 INFO - Downloading blobuploader-1.2.4.tar.gz 21:18:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:18:29 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:18:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:18:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:18:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:18:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:18:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:18:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:18:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:18:29 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:18:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:18:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:18:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:18:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:18:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:18:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:18:29 INFO - Downloading docopt-0.6.1.tar.gz 21:18:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:18:29 INFO - Installing collected packages: blobuploader, requests, docopt 21:18:29 INFO - Running setup.py install for blobuploader 21:18:29 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:18:29 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:18:29 INFO - Running setup.py install for requests 21:18:30 INFO - Running setup.py install for docopt 21:18:30 INFO - Successfully installed blobuploader requests docopt 21:18:30 INFO - Cleaning up... 21:18:30 INFO - Return code: 0 21:18:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:18:30 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')]} 21:18:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:18:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:18:30 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')]} 21:18:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:18:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:18:30 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 0x7fb34a260f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d138a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1de0ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dddf60>, '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 0x1dded40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ddf1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1475899969.994681-1799934594', '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 21:18:30 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 21:18:30 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 21:18:30 INFO - Using env: {'DISPLAY': ':0', 21:18:30 INFO - 'HOME': '/home/cltbld', 21:18:30 INFO - 'LANG': 'en_US.UTF-8', 21:18:30 INFO - 'LANGUAGE': 'en_US:en', 21:18:30 INFO - 'LOGNAME': 'cltbld', 21:18:30 INFO - 'MAIL': '/var/mail/cltbld', 21:18:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:18:30 INFO - 'MOZ_NO_REMOTE': '1', 21:18:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:18:30 INFO - 'NO_EM_RESTART': '1', 21:18:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:18:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:18:30 INFO - 'PWD': '/builds/slave/test', 21:18:30 INFO - 'SHELL': '/bin/bash', 21:18:30 INFO - 'SHLVL': '1', 21:18:30 INFO - 'TERM': 'linux', 21:18:30 INFO - 'TMOUT': '86400', 21:18:30 INFO - 'USER': 'cltbld', 21:18:30 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1475899969.994681-1799934594', 21:18:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:18:30 INFO - '_': '/tools/buildbot/bin/python'} 21:18:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:18:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:18:30 INFO - Running setup.py (path:/tmp/pip-1kyM4Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:18:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:18:30 INFO - Running setup.py (path:/tmp/pip-HLH7td-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:18:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:18:30 INFO - Running setup.py (path:/tmp/pip-OY4qn1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:18:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:18:30 INFO - Running setup.py (path:/tmp/pip-fS4Ph6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:18:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:18:30 INFO - Running setup.py (path:/tmp/pip-gwVl9u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:18:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:18:30 INFO - Running setup.py (path:/tmp/pip-u9zqd1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:18:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:18:30 INFO - Running setup.py (path:/tmp/pip-K87EtZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:18:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:18:31 INFO - Running setup.py (path:/tmp/pip-RHyHs9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:18:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:18:31 INFO - Running setup.py (path:/tmp/pip-9Z087A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:18:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:18:31 INFO - Running setup.py (path:/tmp/pip-2NXihC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:18:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:18:31 INFO - Running setup.py (path:/tmp/pip-m5FLhQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:18:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:18:31 INFO - Running setup.py (path:/tmp/pip-ejYcvM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:18:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:18:31 INFO - Running setup.py (path:/tmp/pip-kN0fww-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:18:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:18:31 INFO - Running setup.py (path:/tmp/pip-est7Tv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:18:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:18:31 INFO - Running setup.py (path:/tmp/pip-2rTl4i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:18:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:18:31 INFO - Running setup.py (path:/tmp/pip-Yo0Bk8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:18:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:18:31 INFO - Running setup.py (path:/tmp/pip-I2urpk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:18:31 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:18:31 INFO - Running setup.py install for manifestparser 21:18:31 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:18:31 INFO - Running setup.py install for mozcrash 21:18:31 INFO - Running setup.py install for mozdebug 21:18:32 INFO - Running setup.py install for mozdevice 21:18:32 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 21:18:32 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:18:32 INFO - Running setup.py install for mozfile 21:18:32 INFO - Running setup.py install for mozhttpd 21:18:32 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:18:32 INFO - Running setup.py install for mozinfo 21:18:32 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:18:32 INFO - Running setup.py install for mozInstall 21:18:32 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:18:32 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:18:32 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:18:32 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:18:32 INFO - Running setup.py install for mozleak 21:18:32 INFO - Running setup.py install for mozlog 21:18:32 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:18:32 INFO - Running setup.py install for moznetwork 21:18:32 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:18:32 INFO - Running setup.py install for mozprocess 21:18:33 INFO - Running setup.py install for mozprofile 21:18:33 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:18:33 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:18:33 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:18:33 INFO - Running setup.py install for mozrunner 21:18:33 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:18:33 INFO - Running setup.py install for mozscreenshot 21:18:33 INFO - Running setup.py install for moztest 21:18:33 INFO - Running setup.py install for mozversion 21:18:33 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:18:33 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:18:33 INFO - Cleaning up... 21:18:33 INFO - Return code: 0 21:18:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:18:33 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')]} 21:18:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:18:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:18:33 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')]} 21:18:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:18:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:18:33 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 0x7fb34a260f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d138a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1de0ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dddf60>, '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 0x1dded40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ddf1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1475899969.994681-1799934594', '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 21:18:33 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 21:18:33 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 21:18:33 INFO - Using env: {'DISPLAY': ':0', 21:18:33 INFO - 'HOME': '/home/cltbld', 21:18:33 INFO - 'LANG': 'en_US.UTF-8', 21:18:33 INFO - 'LANGUAGE': 'en_US:en', 21:18:33 INFO - 'LOGNAME': 'cltbld', 21:18:33 INFO - 'MAIL': '/var/mail/cltbld', 21:18:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:18:33 INFO - 'MOZ_NO_REMOTE': '1', 21:18:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:18:33 INFO - 'NO_EM_RESTART': '1', 21:18:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:18:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:18:33 INFO - 'PWD': '/builds/slave/test', 21:18:33 INFO - 'SHELL': '/bin/bash', 21:18:33 INFO - 'SHLVL': '1', 21:18:33 INFO - 'TERM': 'linux', 21:18:33 INFO - 'TMOUT': '86400', 21:18:33 INFO - 'USER': 'cltbld', 21:18:33 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1475899969.994681-1799934594', 21:18:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:18:33 INFO - '_': '/tools/buildbot/bin/python'} 21:18:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:18:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:18:33 INFO - Running setup.py (path:/tmp/pip-WZnPCt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:18:33 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)) 21:18:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:18:33 INFO - Running setup.py (path:/tmp/pip-EeKNbM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:18:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 21:18:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:18:33 INFO - Running setup.py (path:/tmp/pip-H9obMO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:18:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 21:18:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:18:34 INFO - Running setup.py (path:/tmp/pip-Bq7ryZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:18:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 21:18:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:18:34 INFO - Running setup.py (path:/tmp/pip-XQukVr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:18:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 21:18:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:18:34 INFO - Running setup.py (path:/tmp/pip-9EJK6X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:18:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 21:18:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:18:34 INFO - Running setup.py (path:/tmp/pip-wGcHmM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:18:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 21:18:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:18:34 INFO - Running setup.py (path:/tmp/pip-0pweJr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:18:34 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)) 21:18:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:18:34 INFO - Running setup.py (path:/tmp/pip-xU6AmX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:18:34 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)) 21:18:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:18:34 INFO - Running setup.py (path:/tmp/pip-aqJW3B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:18:34 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)) 21:18:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:18:34 INFO - Running setup.py (path:/tmp/pip-LxyBhS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:18:34 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)) 21:18:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:18:34 INFO - Running setup.py (path:/tmp/pip-IuRvV4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:18:34 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)) 21:18:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:18:34 INFO - Running setup.py (path:/tmp/pip-HACU8b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:18:34 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)) 21:18:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:18:34 INFO - Running setup.py (path:/tmp/pip-EtHXHn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:18:34 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)) 21:18:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:18:34 INFO - Running setup.py (path:/tmp/pip-mW8ril-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:18:34 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)) 21:18:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:18:34 INFO - Running setup.py (path:/tmp/pip-a6QmOa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:18:34 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 21:18:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:18:34 INFO - Running setup.py (path:/tmp/pip-D7PXxM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:18:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 21:18:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 21:18:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 21:18:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 21:18:35 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 21:18:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 21:18:35 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:18:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:18:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:18:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:18:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:18:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:18:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:18:36 INFO - Downloading blessings-1.6.tar.gz 21:18:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:18:36 INFO - Installing collected packages: blessings 21:18:36 INFO - Running setup.py install for blessings 21:18:37 INFO - Successfully installed blessings 21:18:37 INFO - Cleaning up... 21:18:37 INFO - Return code: 0 21:18:37 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:18:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:18:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:18:37 INFO - Reading from file tmpfile_stdout 21:18:37 INFO - Current package versions: 21:18:37 INFO - argparse == 1.2.1 21:18:37 INFO - blessings == 1.6 21:18:37 INFO - blobuploader == 1.2.4 21:18:37 INFO - docopt == 0.6.1 21:18:37 INFO - functools32 == 3.2.3-2 21:18:37 INFO - jsonschema == 2.5.1 21:18:37 INFO - manifestparser == 1.1 21:18:37 INFO - mozInstall == 1.12 21:18:37 INFO - mozcrash == 0.17 21:18:37 INFO - mozdebug == 0.1 21:18:37 INFO - mozdevice == 0.48 21:18:37 INFO - mozfile == 1.2 21:18:37 INFO - mozhttpd == 0.7 21:18:37 INFO - mozinfo == 0.9 21:18:37 INFO - mozleak == 0.1 21:18:37 INFO - mozlog == 3.4 21:18:37 INFO - moznetwork == 0.27 21:18:37 INFO - mozprocess == 0.23 21:18:37 INFO - mozprofile == 0.28 21:18:37 INFO - mozrunner == 6.12 21:18:37 INFO - mozscreenshot == 0.1 21:18:37 INFO - mozsystemmonitor == 0.3 21:18:37 INFO - moztest == 0.7 21:18:37 INFO - mozversion == 1.4 21:18:37 INFO - psutil == 3.1.1 21:18:37 INFO - requests == 1.2.3 21:18:37 INFO - wsgiref == 0.1.2 21:18:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:18:37 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')]} 21:18:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:18:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:18:37 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')]} 21:18:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:18:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:18:37 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 0x7fb34a260f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d138a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1de0ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dddf60>, '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 0x1dded40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ddf1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1475899969.994681-1799934594', '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 21:18:37 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 21:18:37 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 21:18:37 INFO - Using env: {'DISPLAY': ':0', 21:18:37 INFO - 'HOME': '/home/cltbld', 21:18:37 INFO - 'LANG': 'en_US.UTF-8', 21:18:37 INFO - 'LANGUAGE': 'en_US:en', 21:18:37 INFO - 'LOGNAME': 'cltbld', 21:18:37 INFO - 'MAIL': '/var/mail/cltbld', 21:18:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:18:37 INFO - 'MOZ_NO_REMOTE': '1', 21:18:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:18:37 INFO - 'NO_EM_RESTART': '1', 21:18:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:18:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:18:37 INFO - 'PWD': '/builds/slave/test', 21:18:37 INFO - 'SHELL': '/bin/bash', 21:18:37 INFO - 'SHLVL': '1', 21:18:37 INFO - 'TERM': 'linux', 21:18:37 INFO - 'TMOUT': '86400', 21:18:37 INFO - 'USER': 'cltbld', 21:18:37 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1475899969.994681-1799934594', 21:18:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:18:37 INFO - '_': '/tools/buildbot/bin/python'} 21:18:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:18:37 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)) 21:18:37 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)) 21:18:37 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)) 21:18:37 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)) 21:18:37 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)) 21:18:37 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)) 21:18:37 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)) 21:18:37 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)) 21:18:37 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)) 21:18:37 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)) 21:18:37 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)) 21:18:37 INFO - Cleaning up... 21:18:37 INFO - Return code: 0 21:18:37 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:18:37 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')]} 21:18:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:18:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:18:37 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')]} 21:18:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:18:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:18:37 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 0x7fb34a260f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d138a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1de0ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dddf60>, '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 0x1dded40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ddf1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1475899969.994681-1799934594', '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 21:18:37 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 21:18:37 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 21:18:37 INFO - Using env: {'DISPLAY': ':0', 21:18:37 INFO - 'HOME': '/home/cltbld', 21:18:37 INFO - 'LANG': 'en_US.UTF-8', 21:18:37 INFO - 'LANGUAGE': 'en_US:en', 21:18:37 INFO - 'LOGNAME': 'cltbld', 21:18:37 INFO - 'MAIL': '/var/mail/cltbld', 21:18:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:18:37 INFO - 'MOZ_NO_REMOTE': '1', 21:18:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:18:37 INFO - 'NO_EM_RESTART': '1', 21:18:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:18:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:18:37 INFO - 'PWD': '/builds/slave/test', 21:18:37 INFO - 'SHELL': '/bin/bash', 21:18:37 INFO - 'SHLVL': '1', 21:18:37 INFO - 'TERM': 'linux', 21:18:37 INFO - 'TMOUT': '86400', 21:18:37 INFO - 'USER': 'cltbld', 21:18:37 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1475899969.994681-1799934594', 21:18:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:18:37 INFO - '_': '/tools/buildbot/bin/python'} 21:18:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:18:37 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 21:18:37 INFO - Cleaning up... 21:18:37 INFO - Return code: 0 21:18:37 INFO - Running post-action listener: _resource_record_post_action 21:18:37 INFO - Running post-action listener: _start_resource_monitoring 21:18:37 INFO - Starting resource monitoring. 21:18:37 INFO - [mozharness: 2016-10-08 04:18:37.867865Z] Finished create-virtualenv step (success) 21:18:37 INFO - [mozharness: 2016-10-08 04:18:37.868367Z] Running install step. 21:18:37 INFO - Running pre-action listener: _resource_record_pre_action 21:18:37 INFO - Running main action method: install 21:18:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:18:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:18:38 INFO - Reading from file tmpfile_stdout 21:18:38 INFO - Detecting whether we're running mozinstall >=1.0... 21:18:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:18:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:18:38 INFO - Reading from file tmpfile_stdout 21:18:38 INFO - Output received: 21:18:38 INFO - Usage: mozinstall [options] installer 21:18:38 INFO - Options: 21:18:38 INFO - -h, --help show this help message and exit 21:18:38 INFO - -d DEST, --destination=DEST 21:18:38 INFO - Directory to install application into. [default: 21:18:38 INFO - "/builds/slave/test"] 21:18:38 INFO - --app=APP Application being installed. [default: firefox] 21:18:38 INFO - mkdir: /builds/slave/test/build/application 21:18:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 21:18:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 21:18:54 INFO - Reading from file tmpfile_stdout 21:18:54 INFO - Output received: 21:18:54 INFO - /builds/slave/test/build/application/firefox/firefox 21:18:54 INFO - Running post-action listener: _resource_record_post_action 21:18:54 INFO - [mozharness: 2016-10-08 04:18:54.335108Z] Finished install step (success) 21:18:54 INFO - [mozharness: 2016-10-08 04:18:54.335351Z] Running run-tests step. 21:18:54 INFO - Running pre-action listener: _resource_record_pre_action 21:18:54 INFO - Running main action method: run_tests 21:18:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:18:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:18:54 INFO - Python 2.7.3 21:18:54 INFO - Return code: 0 21:18:54 INFO - grabbing minidump binary from tooltool 21:18:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:18:54 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dddf60>, '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 0x1dded40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ddf1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:18:54 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 21:18:54 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 21:18:54 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 21:18:54 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:18:54 INFO - Return code: 0 21:18:54 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 21:18:54 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:18:54 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:18:54 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 21:18:54 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:18:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VFgeObhNTxS8XK-dc_Wtjw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 21:18:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/VFgeObhNTxS8XK-dc_Wtjw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-042 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 21:18:54 INFO - Using env: {'DISPLAY': ':0', 21:18:54 INFO - 'HOME': '/home/cltbld', 21:18:54 INFO - 'LANG': 'en_US.UTF-8', 21:18:54 INFO - 'LANGUAGE': 'en_US:en', 21:18:54 INFO - 'LOGNAME': 'cltbld', 21:18:54 INFO - 'MAIL': '/var/mail/cltbld', 21:18:54 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:18:54 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 21:18:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:18:54 INFO - 'MOZ_NO_REMOTE': '1', 21:18:54 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:18:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:18:54 INFO - 'NO_EM_RESTART': '1', 21:18:54 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:18:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:18:54 INFO - 'PWD': '/builds/slave/test', 21:18:54 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:18:54 INFO - 'SHELL': '/bin/bash', 21:18:54 INFO - 'SHLVL': '1', 21:18:54 INFO - 'TERM': 'linux', 21:18:54 INFO - 'TMOUT': '86400', 21:18:54 INFO - 'USER': 'cltbld', 21:18:54 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1475899969.994681-1799934594', 21:18:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:18:54 INFO - '_': '/tools/buildbot/bin/python'} 21:18:54 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VFgeObhNTxS8XK-dc_Wtjw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 21:18:54 INFO - mozversion application_buildid: 20161007195722 21:18:54 INFO - mozversion application_changeset: efa3b654aa77bcb9b3dd7fc5a52efb6b5afc34d6 21:18:54 INFO - mozversion application_display_name: Nightly 21:18:54 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:18:54 INFO - mozversion application_name: Firefox 21:18:54 INFO - mozversion application_remotingname: firefox 21:18:54 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 21:18:54 INFO - mozversion application_vendor: Mozilla 21:18:54 INFO - mozversion application_version: 52.0a1 21:18:54 INFO - mozversion platform_buildid: 20161007195722 21:18:54 INFO - mozversion platform_changeset: efa3b654aa77bcb9b3dd7fc5a52efb6b5afc34d6 21:18:54 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 21:18:54 INFO - mozversion platform_version: 52.0a1 21:18:54 INFO - using testdate: 1475900334 21:18:54 INFO - actual date: 1475900334 21:18:54 INFO - starting webserver on 'localhost:51434' 21:18:54 INFO - SUITE-START | Running 2 tests 21:18:54 INFO - TEST-START | dromaeo_css 21:18:54 INFO - operating with platform_type : linux_ 21:18:54 INFO - Initialising browser for dromaeo_css test... 21:18:54 INFO - TEST-INFO | started process 25075 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZFDj2p/profile http://localhost:51434/getInfo.html) 21:18:59 INFO - PROCESS | 25075 | __metrics Screen width/height:1600/1200 21:18:59 INFO - PROCESS | 25075 | colorDepth:24 21:18:59 INFO - PROCESS | 25075 | Browser inner width/height: 1024/697 21:18:59 INFO - PROCESS | 25075 | __metrics 21:18:59 INFO - PROCESS | 25075 | 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" 21:18:59 INFO - PROCESS | 25075 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:19:00 INFO - PROCESS | 25075 | console.error: PushService: 21:19:00 INFO - PROCESS | 25075 | stateChangeProcessEnqueue: Error transitioning state 21:19:00 INFO - PROCESS | 25075 | UnknownError 21:19:01 INFO - TEST-INFO | 25075: exit 0 21:19:01 INFO - Browser initialized. 21:19:01 INFO - Running cycle 1/1 for dromaeo_css test... 21:19:01 INFO - TEST-INFO | started process 25157 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZFDj2p/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:19:13 INFO - PROCESS | 25157 | RSS: Main: 173797376 21:19:13 INFO - PROCESS | 25157 | 21:20:05 INFO - PROCESS | 25157 | 1475900405322 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] 21:22:18 INFO - PROCESS | 25157 | Cycle 1(1): loaded http://localhost:51434/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51434/tests/dromaeo/cssquery-ext.html) 21:22:19 INFO - PROCESS | 25157 | RSS: Main: 297865216 21:22:19 INFO - PROCESS | 25157 | 21:25:21 INFO - PROCESS | 25157 | Cycle 1(1): loaded http://localhost:51434/tests/dromaeo/cssquery-ext.html (next: http://localhost:51434/tests/dromaeo/cssquery-jquery.html) 21:25:22 INFO - PROCESS | 25157 | RSS: Main: 284360704 21:25:22 INFO - PROCESS | 25157 | 21:28:24 INFO - PROCESS | 25157 | Cycle 1(1): loaded http://localhost:51434/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51434/tests/dromaeo/cssquery-mootools.html) 21:28:25 INFO - PROCESS | 25157 | RSS: Main: 218243072 21:28:25 INFO - PROCESS | 25157 | 21:31:27 INFO - PROCESS | 25157 | Cycle 1(1): loaded http://localhost:51434/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51434/tests/dromaeo/cssquery-prototype.html) 21:31:28 INFO - PROCESS | 25157 | RSS: Main: 219267072 21:31:28 INFO - PROCESS | 25157 | 21:34:31 INFO - PROCESS | 25157 | Cycle 1(1): loaded http://localhost:51434/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51434/tests/dromaeo/cssquery-yui.html) 21:34:31 INFO - PROCESS | 25157 | RSS: Main: 221163520 21:34:31 INFO - PROCESS | 25157 | 21:37:34 INFO - PROCESS | 25157 | Cycle 1(1): loaded http://localhost:51434/tests/dromaeo/cssquery-yui.html (next: http://localhost:51434/tests/dromaeo/cssquery-dojo.html) 21:37:35 INFO - PROCESS | 25157 | RSS: Main: 314028032 21:37:35 INFO - PROCESS | 25157 | 21:37:35 INFO - PROCESS | 25157 | __start_tp_report 21:37:35 INFO - PROCESS | 25157 | _x_x_mozilla_page_load 21:37:35 INFO - PROCESS | 25157 | _x_x_mozilla_page_load_details 21:37:35 INFO - PROCESS | 25157 | |i|pagename|runs| 21:37:35 INFO - PROCESS | 25157 | |0;dojo.html;2519.9244022679322;2531.8227724059325;2570.13900343385;2578.200757765093;2586.2241327601714;4439.733615983043;4540.523245059271;4597.609203217727;4624.606908412785;4638.582527572517;4544.931826022612;4552.795124219409;4577.130345234403;4596.931046034312;4650.534946505348;4196.580341965794;4203.138356636898;4206;4223.894402639928;4311.91376172478;4335.761533115678;4364.67264955128;4367.956320436787;4409.757463339515;4410.2943529035365;4099.549049604541;4127.8968025799295;4128.896777580554;4222.831086756526;4263.232618128735;4151.418801367811;4179.185058913513;4187.748735075906;4205.264078786231;4210.915781684349;4128.215639028605;4134.73124246926;4142.1922725068625;4145.419641250227;4193.937090943638;4544.227481328182;4552.4764652065105;4583.839565615188;4584.083183363307;4593.908121837578;4711.199096153662;4755.762211889391;4862.051899879525;4909.312696222496;4910.754462276872;4842.66101372904;4844.394450693663;4854.12625727369;4915.066137433876;4952.281919121743;4585.037142200175;4593.379893714373;4619.86140415788;4620.607248383858;4670.579647831712;4832.975835120802;4893.094777466109;4894.779734911937;4944.53026962438;5037.647364684511;4737;4749.121412538691;4754.619630429557;4759.262314341283;4761.071591039714;4817.566419022305;4821.397325334333;4823.204171311764;4826.372571565744;4831.685940413862;4758.857234282977;4766.785494652749;4785.473597904228;4798.064377446434;4865.294532292798;4713.717176969393;4763.7141771493825;4769.14155452015;4825.4933232010135;4827.975860120747;4105.035316700573;4138.317177665712;4140.4617399738445;4188.937165942513;4201.306784380543;3588.964110358915;3594.5506811648543;3603.94594081089;3690.4648825920626;3697.186618943828;4204.222218889515;4226.1758957003085;4241.7879106044575;4247.893802654959;4284.228838808982;4881.609471242292;4889.119958407449;4889.608831293559;4891.388576427947;4940.184869496565;4138.193052354822;4222.809973551198;4224.746515209097;4228.894277643022;4278.315469524861;4346.978265108717;4396.274614688605;4420.84527041552;4444.777761111996;4453.487848897354;4653.395058642355;4655.627549796076;4698.1308457936075;4709.670323077488;4710.8351207707565;4939.678920870132;4941.555260026615;4942.752862356796;4945.134601444661;5011.047900898818;4486.865394038184;4498.662600305056;4642.2108241598335;4651.558101980307;4713.31656909753;4822.758862056953;4859.538343857328;4863.221884498464;4872.14737420957;4917.729524876167;4935.4570997190995;4936.629752768628;4947.925781113214;4948.554630083166;5005.599552035901;4703.106409782131;4802.327674125555;4813.687110337817;4822.059698358927;4875.7074575525585;4716.056788642354;4759.524047595212;4761.666683332133;4762.595179409789;4823.011282686971;4616.8614941551805;4649.3026046093355;4669.906601868011;4680.3915490985955;4733.100710864925;4742.454617718869;4773.952260477489;4786.928196077131;4788.018456216537;4847.5394837490385;4575.359449677115;4612.146752850734;4614.054118905683;4618.122556714214;4651.162790697707 21:37:35 INFO - PROCESS | 25157 | |1;ext.html;533.0378666506955;545.435474284116;550.0896017091715;557.7239266563049;560.3639868748969;28065.71934280659;28766.712332876665;31270.53094203586;38476.80761596195;39842.8007859961;40497.797511012475;40791.79604101983;40897.386539201936;40989.385159222635;41027;7588.506747061437;7744.148143704188;7746.728864489744;7749.496282741604;7755;7568.810779730496;7660.731874384398;7662.348700360476;7664.846703065935;7666.655000524962;7689.500182488148;7719;7744.070711514626;7750.302472777449;7752.108507521622;7649.04386951631;7691.346235569983;7694.153643099255;7700.499467534648;7705.73029943952;7587.582682952436;7633.503822251591;7634.885476717854;7642.770716878503;7649.961750191269;37046.62953370459;37278;37303.25393492142;37337;37434.43848342277;2933.090741870027;2940.955885661717;2952.1881482592457;2975.8065725727756;3068.8772449102007;27933.301667458272;28322.71677283242;28698.71301286981;28880;29194.562081568794;3387.2209391840015;3398.9660103398896;3401.914952126192;3425.537552430415;3445.6898879101;173420;173933;174289;175617;175693.99999999872;51875.22187167196;52165.47834521606;52271.47728522742;52292.738536307836;52353;32706.345873082406;33475.832620837224;33526.664733352845;35406;55010;13110.344482776014;13190.538331158363;13211;13263.535776247785;13277.668058298426;10264.332818366782;10291.279610427348;10361.585536578603;10372.896271037192;10380.480975951172;17688.91155544214;17927.282908683508;17942;18048.20987592594;18097.819021809875;6677.666116694243;6784.253732089466;6817.284185160586;6912.896306555405;6948.93051069493;744.8957145999565;824.7072289337319;850.0819115355401;863.8963324401112;942.2885721280389;26579.734202657724;28262.43475130527;28474.430511389655;28549.594681663963;28814.855925720236;743.2678811370796;838.8322335532918;878.8154487557684;916.0610374366328;933.2160984772823;11583.478743456564;14307.92846035784;14497.202653853928;14669.48656797007;14792.704145917236;361799;364581;365026;365095;365984;48182.75908620434;48664;48734.51265487371;48819.511804882204;48829;1031.1802117316752;1051.379685985257;1126.4705588373615;1147.971300717472;1149.4482648329017;27542.5868611975;28959.276018099717;29309.85345073261;29501.704982949897;29743.405131897674;41831.37252941269;42534.36198456964;42547;42591.57408425876;42611;230757;231484;232719;233013;375263;35303.470447943815;35955.82022089873;36018;37158.071048222926;37388;42044;42072.579274206866;42243.7887810559;42996.78501607472;43188.11306982387;32174.517382239752;32247.51628725524;32380.676193237767;32746.672533274363;33167.43796377517;34819;35592;35672;35913.82043089768;36341.27317453583;35131.83813456699;35653.465198021535;35837.10407239736;35857.282854342244;36176.095597609215;31044.844775775975;31357.795231528962;32805.34389312248;32981.340373192885;33144.83427582846;25437;25614.615780763677;25636.487270254864;25750.26902076406;25919 21:37:35 INFO - PROCESS | 25157 | |2;jquery.html;347.3625896479959;350.98771542996;371.77136061322284;378.5797764481425;391.6631696740802;11983.460744266507;12363.567275145371;15702;16034.759478607815;16620.916895415507;15753.448629297976;15899.28453219605;16066.116363599996;16070.59823504413;16216.108114053723;3722.497462842509;4909.582685471739;5139.460356662534;5139.743012849342;5140.820071297505;5076.060928728197;5092.210707340369;5104.132297509433;5109.054824857395;5118.897622047557;4869.05053514563;5054.772535235923;5072.365954255718;5073.46728593496;5076.974615126919;4934.0625281196635;5043.84868453947;5072.594192464612;5072.6195535335;5093.770780314895;4559.840405585822;4559.863204103882;4563.543645635443;4569.611583015448;4573.725576465389;18136.546586335317;18803.435896923114;18884.43346699601;19679.31122410723;19864.404067877986;1885.5474686075381;1936.1868015433552;2181.9781802181933;2403.110848985869;2410.8312418130736;8987.14622110905;9204.263658907272;9301.069893010712;11923.821142682868;12142.239375290621;1668.1659170414794;1711.161530849887;1716.2105431501525;1752.9386471473565;1774.1218097041917;67834.66082669554;68751.65624171897;69332.65333673349;69885.3011469884;71146;9511.14399704016;9782.608695652094;9880.851787223197;9897.109260166619;9902.455364954852;13371.933140334237;13435.126716763574;13476.797848032287;13480.662983425493;13484.932575337256;6438.645874476949;6634.568753031038;6749.763758268437;6797;6845.589264644137;6176.8764624707255;6195.473384762256;6260.843478913063;6283.37166283368;6327.525435592349;4189.706720529594;4216.746995180299;4267.487901451846;4349.28236840924;4351.891202719894;1670.9164541772864;1703.6166862455848;1707.4792188382662;1717.9141042947804;1744.476657002894;821.8109834738044;822.4982760516081;824.6124321568853;872.2062922740275;899.1817446123996;15759.921200394154;15909.05688436004;16239.388667620533;16484.83515164857;16542.172891355625;825.7687847402736;833.851588347964;855.4696088425217;880.9867851982225;884.0673089890099;8745.912540874637;8849.646014159362;9025.954870225607;9057.77355566116;9232.215261702697;343001;344345;347920;359701;364441;69323.65338173378;69484;70829.64585177042;71855.64072179605;72278;858.1718641510972;865.1002956924727;871.1071152069053;881.4270724029304;940.6143481172686;14519.201443920685;14852.702945941237;15376.154311512973;15383.538493845203;15465.536033919001;32521.837390812896;34531.82734086414;37501.43747843839;37933.24133517369;38001.23997520089;47108.29337560008;47226.055478890914;47447;47557.52442475531;48098.75950620364;6976.720931162697;7305.52514086604;7401.370883474965;7487.6630551626395;7700.499467534592;9910.702678919644;11502.712432189262;11623.244489108181;11710.297382156758;11874.406279686154;9934.304598678023;9966.900330996597;10060.647877324258;10151.54318055704;10727.731806704895;9959;10337.224708146769;10441.738956526147;10472.424016679155;10676.733081673021;10362.637307694195;10375.792484150426;10381.688549343531;10680.89319106799;11013;6477.546571739933;6645.966770166312;6678.966605166943;6987.441004719712;7382;8114.797130071795;9619.067886784389;9830.213582913493;10021;10715.839262411226 21:37:35 INFO - PROCESS | 25157 | |3;mootools.html;1196.437674293082;1317.8616245294245;1363.5704753002803;1384.4669802126184;1681.2602454919834;6352.301246862841;7231.746888858891;7464.06699162604;7475.663595138219;7675.501092429002;7502.81242968926;7566.470347075693;7578.3558397536135;7579.621018949044;7586.848263034736;2020.4140799168224;2030.786767389425;2031.2179810772811;2032.8451841048536;2036.4908772806798;1979.8812071275697;2001.9480032966253;2008.4878356019194;2025.574629327843;2032.959340813183;2001.8999050047512;2018.7072874433272;2022.0900594732357;2029.1578994717174;2031.1976769176167;1990.5620763432166;1991.5120795405073;1996.0319245166083;1997.490639886834;2001.2995451591971;2010.2963962613114;2021.5350469391974;2032.9796702033086;2033.6136134134615;2037.3684157911096;7471.813204669872;7569.394448444111;7571.280728330799;7571.356434703057;7575.204603516607;4275.700700950934;4417.469903611555;4425.491068527096;4456.153330867157;4464.709793863389;2620.475904819044;2725.4004119093966;2759.0343379817105;2759.351552385188;2760;859.7764581208868;888.8932980818334;895.4285229422322;902.309733054214;909.3543584055328;10063.39619622825;10197.79604407915;10203.693889183336;10211.489425528694;10215.795684086352;3651.087228192952;3770.71719621024;3894.201688653819;3946.230485055444;3951.9604803952166;8043.517388956564;8060.476069055492;8063.717769878026;8067.39494537912;8068.152843951418;4347.978260108743;4351.19502891966;4351.651867850627;4352.847650332286;4354.129174165179;3405.3019131078067;3459.8789042383396;3807.695384369244;4046.59534046593;4054.8175332110127;3151.6060492438446;3171.349873275973;3292.3909076820864;3303.339332133583;3307;962.6245764151986;965.4979410706534;970.825251454745;990.2127808392345;994.8855881573567;662.4137638190236;810.343621666452;820.7660816667221;831.1356189562907;861.2722249698994;4800.279958006327;4921.9507804921495;4927.989762098761;4929.260610908393;5209.505097015777;350.3675865063534;361.1639055586309;366.93762060449785;369.76335145506897;370.8312717713434;3426.468897320919;3434.072800343893;3478.3738926993383;3501.6848483636595;3597.442396428558;8997.730068097968;9272.582733776997;9363.672271470467;9364.719058428258;9375.48434836077;9141.588628511732;9173.678921237724;9195.724128276162;9257.166854983085;9275.072492750805;6903.792886213421;6946.687399066953;6967.7212911482975;6972.152379619405;6981.79054628362;4969.8260560881645;5018.473060328759;5040.84877453677;5067.569256613229;5276.5251127398715;8598.78503037429;8622.741317760478;8625.611847466753;8625.69810056645;8670.956645216733;7976.7208147714555;8243.25810677042;8343.624536895975;8662.350323725872;8679.522626255617;6358.745650174126;6531.9020214695865;6688.163979502562;6696.531242812956;6701.363370479797;7241.384482319062;7242.203357630551;7295.854082918206;7309.488335816442;7311.8537629248185;6364.204474440695;6496;6516.5112616553;6564.343565643589;6605.735770569124;6482;6504.1219435375615;6560.507961902781;6563.310852360433;6583.111279977334;5870.119482077723;5971.164037034905;5982.790602328898;5983.401659834156;5984.640921544721;4277.850275240477;4315.719478233905;4382.956170438255;4437.911241775082;4492.011757413364;4256.510501292391;4324.113556720802;4346.195953748566;4355.323200567741;4418.541881179268 21:37:35 INFO - PROCESS | 25157 | |4;prototype.html;285.3679100791746;293.63295880149815;296.98812047518095;301.75859312549954;303.56286946796627;4748.216544270195;4763.761811909408;4778.6619746471;4779.160023390993;4786.138495070886;4707.446542640929;4712.740799256039;4717.905641887169;4723.574878260956;4795.328653988445;3777.7922214278206;3781.6596506314427;3785.167263202105;3785.7728536287773;3793.6775374093236;3584.336897673939;3785.867494637688;3788.4617306404775;3789.7726136431766;3792.696584273265;3702.907427314325;3713.3687273163628;3726.3851464508457;3737.8131093445218;3754.774713517184;3713.8885833425043;3723.1064544509395;3731.533558305212;3736.916294274657;3785.488958990556;3052.923676908073;3129.405412971528;3291.8354082296028;3304;3312.585926759155;4490.126319155743;4638.721676699375;4645.140648979949;4652.55800698933;4661.72029678217;4181;4187.895302617429;4190.898734936156;4193.895152621209;4235.597618226264;4572.337011133401;4669.272369223409;4934.5312195341385;4937.925931111036;4949.455559888409;3568.7145028397667;3573.6069032406413;3577.159367548624;3596.3166998270244;3603.063203567065;5122.795088196468;5137.922931156073;5148.5623721983675;5154.149565321717;5155.200943853709;3640.453931910182;3647.9635203648154;3652.652997965189;3653.94519082214;3657.5428071491065;3399.3881101401985;3586.6234045425376;3605.152789094561;3638.490611314418;3648.5770549485724;4138.91722165555;4144.544100148981;4154.729942553724;4155.252054630196;4156.937645935313;4916.188828843201;4921.138800709861;4926.704397736075;4928.236123400879;4932.975335123301;1202.7594481103815;1224.3449754381363;1237.127824883455;1241.6895776055985;1244.7821631214501;783.295034468971;783.5259667900951;789.2029050658875;790.671871173468;792.5086446403152;3748.2878253131817;3961.782101984361;3969.226000929849;3983.8008099594904;3985.2501773776003;4486.3494793254795;4490;4496.39298694672;4499.672596584016;4503.189425903369;3962.3754260752953;3963.710120599895;3964.3458829292845;3965.2466031453932;3985.5217373915316;2395.3711476196354;2402.25530085674;2412.372783076378;2412.4560281419904;2550.528152291832;4539.909201816011;4762.9523704763205;4806.399200099988;4812.639052071108;4841.878953026203;5203.7918483261;5211.478852114834;5218.860267290393;5238.554722848525;5244.711540865213;4825.252085926687;4839.661223714306;4845.63657725672;4856.975715121402;4862.538058884471;4975.179095449211;5043.394792624908;5062.519060689228;5064;5139.691618502752;4981.829270121591;4998;5017.3226614406585;5020.196768517019;5032.119379108714;4828.348172996741;4841.2496063110275;4843.588294994965;4857.732824694675;4858.708477491362;3470.2018535736415;3571.8214089295952;3602.85588576454;3610.693091087287;3613.403788374994;5085.46602606721;5104.642675012714;5111.670965548909;5115.9232611510115;5117.667351622133;4936.284238785428;4951.8266860659705;4964.039204514269;4964.627652926118;4975.378077740283;4801.351817504592;4958.735522441899;4962.354893863775;4975.626827987988;4984.22744474607;4862.440819305825;4868.318435419115;4888.193448081027;4894.657373983787;4901.509849015212;4983.707494552546;5000.699958002531;5005.474425185449;5008.824691135793;5013.147764880052;4661.720296782204;4861.4895435978715;4889.63327750413;4902.63230257725;4905 21:37:35 INFO - PROCESS | 25157 | |5;yui.html;625.4996003197442;636.5035272487462;651.4885814635512;725.611797688237;741.3290971670639;12733.745325093505;13767.724645507109;13791.448342066318;13800.861991380083;13807.516736914222;13091.279979601119;13218.471261149567;13235.536756213534;13252.469901203964;13256.270905100215;599.6641880546886;612.7640858269576;722.4473277942378;729.7920092773561;742.9294217049398;754.9962250188769;757.7082823113113;757.893894854718;757.9317861392474;758.298573819215;802.1937952357872;804.5534728225832;804.7706403674954;805.3195050182586;805.3677862877643;620.9379062093777;636.4208570201095;636.7994081864198;641.8555824939398;789.5420656019495;473.3727810650901;563.2621266141327;570.54356514788;576.469647923911;578;12617;12642.735726427376;12651.620451386472;12655.114142010063;12658.74682506354;11970.940145299304;12376.62870113898;12448.190867593577;12741.299228542426;12945.352732363439;11703.94148029263;11822;11937.820932686016;12022.458989345412;12593.181443206255;4068.4304197412384;4084.611961863618;4087.6116768906904;4205.537390887;4227.957720422787;59435.70282148562;60993.390066099215;61391.693041534505;61574.69212653908;62129;9591.136797688241;9884.80230395388;9926.900730992742;10054.748631284276;10076.143527800072;18307.63384732298;18772.624547508975;19015.33446329372;19103.52241193981;19126.80873191278;7015.684294206773;7249.492535522463;7250.6374681265725;7251.4923955323675;7398.593077380796;3629.8366573504254;3633.65480279373;3653.7442379033746;3674.11821162919;3702.9629703702617;2937.19227212514;3011.036468330113;3027.2885871820104;3031.1361262040214;3032.454158251536;517.5962749055742;543.8259756877841;547.887683024979;554.7697705452273;557.4342042826535;570.1447828257614;599.87166924489;604.0697326117818;614.6066517428849;633.3002032753741;8264;8289.58552072394;8354.331653467709;8526.976762788505;8805.955970220108;463.6962789372966;484.9684770489907;544.2516539757833;557.701629628147;584.8567101060268;3753.737238393286;3779.4708740776314;3803.030227292023;3821.808909554511;4067.8576249831112;97389;99546;103464;105815;105996;47423.28865067027;50309;77875.22124778794;83650;83895;77664.22335776682;77688;77984.61007694925;78464.60767696126;79981.60009199916;7002.299770023161;7558.546487210785;7705.845883082419;7769.339606133542;7792.922070779219;44385;45791;46030.76984615056;46559.06881862412;46773.29840052334;63443.6827815858;66530.66734666296;67318;69248.6537567329;69428.3057169442;10286.331388459726;10546.367217966947;10765.084967777826;10852.565897364333;10955.287906286067;11751;12168.574099906815;12381.504739810307;12412.56556020535;12638.747225055264;11612.883871161519;11657.050530840632;11946.104042196695;12092.334921579397;12165;10455.686329409826;10875.728106797076;11165.665030049111;11245.381504017358;11403.372814495282;11178.99389054989;11190.272632278877;11217.102631789601;11486.425678716198;12089.15375923677;9083.500407477388;9213.723588292361;9266.768330791785;9631.855522167314;9929.205663547044;9840.803183936137;10061.144802691853;10084.94957525237;10107.39355638664;10179.541920613738 21:37:35 INFO - PROCESS | 25157 | __end_tp_report 21:37:35 INFO - PROCESS | 25157 | __start_cc_report 21:37:35 INFO - PROCESS | 25157 | _x_x_mozilla_cycle_collect,1168 21:37:35 INFO - PROCESS | 25157 | __end_cc_report 21:37:35 INFO - PROCESS | 25157 | __startTimestamp1475901455031__endTimestamp 21:37:35 INFO - PROCESS | 25157 | 21:37:35 INFO - PROCESS | 25157 | ------- Summary: start ------- 21:37:35 INFO - PROCESS | 25157 | Number of tests: 6 21:37:35 INFO - PROCESS | 25157 | 21:37:35 INFO - PROCESS | 25157 | [#0] dojo.html Cycles:165 Average:4516.82 Median:4650.53 stddev:465.30 (10.0%) stddev-sans-first:439.57 21:37:35 INFO - PROCESS | 25157 | Values: 2519.9 2531.8 2570.1 2578.2 2586.2 4439.7 4540.5 4597.6 4624.6 4638.6 4544.9 4552.8 4577.1 4596.9 4650.5 4196.6 4203.1 4206.0 4223.9 4311.9 4335.8 4364.7 4368.0 4409.8 4410.3 4099.5 4127.9 4128.9 4222.8 4263.2 4151.4 4179.2 4187.7 4205.3 4210.9 4128.2 4134.7 4142.2 4145.4 4193.9 4544.2 4552.5 4583.8 4584.1 4593.9 4711.2 4755.8 4862.1 4909.3 4910.8 4842.7 4844.4 4854.1 4915.1 4952.3 4585.0 4593.4 4619.9 4620.6 4670.6 4833.0 4893.1 4894.8 4944.5 5037.6 4737.0 4749.1 4754.6 4759.3 4761.1 4817.6 4821.4 4823.2 4826.4 4831.7 4758.9 4766.8 4785.5 4798.1 4865.3 4713.7 4763.7 4769.1 4825.5 4828.0 4105.0 4138.3 4140.5 4188.9 4201.3 3589.0 3594.6 3603.9 3690.5 3697.2 4204.2 4226.2 4241.8 4247.9 4284.2 4881.6 4889.1 4889.6 4891.4 4940.2 4138.2 4222.8 4224.7 4228.9 4278.3 4347.0 4396.3 4420.8 4444.8 4453.5 4653.4 4655.6 4698.1 4709.7 4710.8 4939.7 4941.6 4942.8 4945.1 5011.0 4486.9 4498.7 4642.2 4651.6 4713.3 4822.8 4859.5 4863.2 4872.1 4917.7 4935.5 4936.6 4947.9 4948.6 5005.6 4703.1 4802.3 4813.7 4822.1 4875.7 4716.1 4759.5 4761.7 4762.6 4823.0 4616.9 4649.3 4669.9 4680.4 4733.1 4742.5 4774.0 4786.9 4788.0 4847.5 4575.4 4612.1 4614.1 4618.1 4651.2 21:37:35 INFO - PROCESS | 25157 | 21:37:35 INFO - PROCESS | 25157 | [#1] ext.html Cycles:180 Average:42482.53 Median:35986.91 stddev:73661.22 (204.7%) stddev-sans-first:73800.52 21:37:35 INFO - PROCESS | 25157 | Values: 533.0 545.4 550.1 557.7 560.4 28065.7 28766.7 31270.5 38476.8 39842.8 40497.8 40791.8 40897.4 40989.4 41027.0 7588.5 7744.1 7746.7 7749.5 7755.0 7568.8 7660.7 7662.3 7664.8 7666.7 7689.5 7719.0 7744.1 7750.3 7752.1 7649.0 7691.3 7694.2 7700.5 7705.7 7587.6 7633.5 7634.9 7642.8 7650.0 37046.6 37278.0 37303.3 37337.0 37434.4 2933.1 2941.0 2952.2 2975.8 3068.9 27933.3 28322.7 28698.7 28880.0 29194.6 3387.2 3399.0 3401.9 3425.5 3445.7 173420.0 173933.0 174289.0 175617.0 175694.0 51875.2 52165.5 52271.5 52292.7 52353.0 32706.3 33475.8 33526.7 35406.0 55010.0 13110.3 13190.5 13211.0 13263.5 13277.7 10264.3 10291.3 10361.6 10372.9 10380.5 17688.9 17927.3 17942.0 18048.2 18097.8 6677.7 6784.3 6817.3 6912.9 6948.9 744.9 824.7 850.1 863.9 942.3 26579.7 28262.4 28474.4 28549.6 28814.9 743.3 838.8 878.8 916.1 933.2 11583.5 14307.9 14497.2 14669.5 14792.7 361799.0 364581.0 365026.0 365095.0 365984.0 48182.8 48664.0 48734.5 48819.5 48829.0 1031.2 1051.4 1126.5 1148.0 1149.4 27542.6 28959.3 29309.9 29501.7 29743.4 41831.4 42534.4 42547.0 42591.6 42611.0 230757.0 231484.0 232719.0 233013.0 375263.0 35303.5 35955.8 36018.0 37158.1 37388.0 42044.0 42072.6 42243.8 42996.8 43188.1 32174.5 32247.5 32380.7 32746.7 33167.4 34819.0 35592.0 35672.0 35913.8 36341.3 35131.8 35653.5 35837.1 35857.3 36176.1 31044.8 31357.8 32805.3 32981.3 33144.8 25437.0 25614.6 25636.5 25750.3 25919.0 21:37:35 INFO - PROCESS | 25157 | 21:37:35 INFO - PROCESS | 25157 | [#2] jquery.html Cycles:180 Average:22658.10 Median:25841.01 stddev:58250.80 (225.4%) stddev-sans-first:58390.12 21:37:35 INFO - PROCESS | 25157 | Values: 347.4 351.0 371.8 378.6 391.7 11983.5 12363.6 15702.0 16034.8 16620.9 15753.4 15899.3 16066.1 16070.6 16216.1 3722.5 4909.6 5139.5 5139.7 5140.8 5076.1 5092.2 5104.1 5109.1 5118.9 4869.1 5054.8 5072.4 5073.5 5077.0 4934.1 5043.8 5072.6 5072.6 5093.8 4559.8 4559.9 4563.5 4569.6 4573.7 18136.5 18803.4 18884.4 19679.3 19864.4 1885.5 1936.2 2182.0 2403.1 2410.8 8987.1 9204.3 9301.1 11923.8 12142.2 1668.2 1711.2 1716.2 1752.9 1774.1 67834.7 68751.7 69332.7 69885.3 71146.0 9511.1 9782.6 9880.9 9897.1 9902.5 13371.9 13435.1 13476.8 13480.7 13484.9 6438.6 6634.6 6749.8 6797.0 6845.6 6176.9 6195.5 6260.8 6283.4 6327.5 4189.7 4216.7 4267.5 4349.3 4351.9 1670.9 1703.6 1707.5 1717.9 1744.5 821.8 822.5 824.6 872.2 899.2 15759.9 15909.1 16239.4 16484.8 16542.2 825.8 833.9 855.5 881.0 884.1 8745.9 8849.6 9026.0 9057.8 9232.2 343001.0 344345.0 347920.0 359701.0 364441.0 69323.7 69484.0 70829.6 71855.6 72278.0 858.2 865.1 871.1 881.4 940.6 14519.2 14852.7 15376.2 15383.5 15465.5 32521.8 34531.8 37501.4 37933.2 38001.2 47108.3 47226.1 47447.0 47557.5 48098.8 6976.7 7305.5 7401.4 7487.7 7700.5 9910.7 11502.7 11623.2 11710.3 11874.4 9934.3 9966.9 10060.6 10151.5 10727.7 9959.0 10337.2 10441.7 10472.4 10676.7 10362.6 10375.8 10381.7 10680.9 11013.0 6477.5 6646.0 6679.0 6987.4 7382.0 8114.8 9619.1 9830.2 10021.0 10715.8 21:37:35 INFO - PROCESS | 25157 | 21:37:35 INFO - PROCESS | 25157 | [#3] mootools.html Cycles:180 Average:4860.91 Median:5029.66 stddev:2779.73 (55.3%) stddev-sans-first:2773.88 21:37:35 INFO - PROCESS | 25157 | Values: 1196.4 1317.9 1363.6 1384.5 1681.3 6352.3 7231.7 7464.1 7475.7 7675.5 7502.8 7566.5 7578.4 7579.6 7586.8 2020.4 2030.8 2031.2 2032.8 2036.5 1979.9 2001.9 2008.5 2025.6 2033.0 2001.9 2018.7 2022.1 2029.2 2031.2 1990.6 1991.5 1996.0 1997.5 2001.3 2010.3 2021.5 2033.0 2033.6 2037.4 7471.8 7569.4 7571.3 7571.4 7575.2 4275.7 4417.5 4425.5 4456.2 4464.7 2620.5 2725.4 2759.0 2759.4 2760.0 859.8 888.9 895.4 902.3 909.4 10063.4 10197.8 10203.7 10211.5 10215.8 3651.1 3770.7 3894.2 3946.2 3952.0 8043.5 8060.5 8063.7 8067.4 8068.2 4348.0 4351.2 4351.7 4352.8 4354.1 3405.3 3459.9 3807.7 4046.6 4054.8 3151.6 3171.3 3292.4 3303.3 3307.0 962.6 965.5 970.8 990.2 994.9 662.4 810.3 820.8 831.1 861.3 4800.3 4922.0 4928.0 4929.3 5209.5 350.4 361.2 366.9 369.8 370.8 3426.5 3434.1 3478.4 3501.7 3597.4 8997.7 9272.6 9363.7 9364.7 9375.5 9141.6 9173.7 9195.7 9257.2 9275.1 6903.8 6946.7 6967.7 6972.2 6981.8 4969.8 5018.5 5040.8 5067.6 5276.5 8598.8 8622.7 8625.6 8625.7 8671.0 7976.7 8243.3 8343.6 8662.4 8679.5 6358.7 6531.9 6688.2 6696.5 6701.4 7241.4 7242.2 7295.9 7309.5 7311.9 6364.2 6496.0 6516.5 6564.3 6605.7 6482.0 6504.1 6560.5 6563.3 6583.1 5870.1 5971.2 5982.8 5983.4 5984.6 4277.9 4315.7 4383.0 4437.9 4492.0 4256.5 4324.1 4346.2 4355.3 4418.5 21:37:35 INFO - PROCESS | 25157 | 21:37:35 INFO - PROCESS | 25157 | [#4] prototype.html Cycles:180 Average:4071.06 Median:4657.14 stddev:1198.22 (25.7%) stddev-sans-first:1167.41 21:37:35 INFO - PROCESS | 25157 | Values: 285.4 293.6 297.0 301.8 303.6 4748.2 4763.8 4778.7 4779.2 4786.1 4707.4 4712.7 4717.9 4723.6 4795.3 3777.8 3781.7 3785.2 3785.8 3793.7 3584.3 3785.9 3788.5 3789.8 3792.7 3702.9 3713.4 3726.4 3737.8 3754.8 3713.9 3723.1 3731.5 3736.9 3785.5 3052.9 3129.4 3291.8 3304.0 3312.6 4490.1 4638.7 4645.1 4652.6 4661.7 4181.0 4187.9 4190.9 4193.9 4235.6 4572.3 4669.3 4934.5 4937.9 4949.5 3568.7 3573.6 3577.2 3596.3 3603.1 5122.8 5137.9 5148.6 5154.1 5155.2 3640.5 3648.0 3652.7 3653.9 3657.5 3399.4 3586.6 3605.2 3638.5 3648.6 4138.9 4144.5 4154.7 4155.3 4156.9 4916.2 4921.1 4926.7 4928.2 4933.0 1202.8 1224.3 1237.1 1241.7 1244.8 783.3 783.5 789.2 790.7 792.5 3748.3 3961.8 3969.2 3983.8 3985.3 4486.3 4490.0 4496.4 4499.7 4503.2 3962.4 3963.7 3964.3 3965.2 3985.5 2395.4 2402.3 2412.4 2412.5 2550.5 4539.9 4763.0 4806.4 4812.6 4841.9 5203.8 5211.5 5218.9 5238.6 5244.7 4825.3 4839.7 4845.6 4857.0 4862.5 4975.2 5043.4 5062.5 5064.0 5139.7 4981.8 4998.0 5017.3 5020.2 5032.1 4828.3 4841.2 4843.6 4857.7 4858.7 3470.2 3571.8 3602.9 3610.7 3613.4 5085.5 5104.6 5111.7 5115.9 5117.7 4936.3 4951.8 4964.0 4964.6 4975.4 4801.4 4958.7 4962.4 4975.6 4984.2 4862.4 4868.3 4888.2 4894.7 4901.5 4983.7 5000.7 5005.5 5008.8 5013.1 4661.7 4861.5 4889.6 4902.6 4905.0 21:37:35 INFO - PROCESS | 25157 | 21:37:35 INFO - PROCESS | 25157 | [#5] yui.html Cycles:180 Average:17690.28 Median:23948.33 stddev:25391.58 (106.0%) stddev-sans-first:25430.48 21:37:35 INFO - PROCESS | 25157 | Values: 625.5 636.5 651.5 725.6 741.3 12733.7 13767.7 13791.4 13800.9 13807.5 13091.3 13218.5 13235.5 13252.5 13256.3 599.7 612.8 722.4 729.8 742.9 755.0 757.7 757.9 757.9 758.3 802.2 804.6 804.8 805.3 805.4 620.9 636.4 636.8 641.9 789.5 473.4 563.3 570.5 576.5 578.0 12617.0 12642.7 12651.6 12655.1 12658.7 11970.9 12376.6 12448.2 12741.3 12945.4 11703.9 11822.0 11937.8 12022.5 12593.2 4068.4 4084.6 4087.6 4205.5 4228.0 59435.7 60993.4 61391.7 61574.7 62129.0 9591.1 9884.8 9926.9 10054.7 10076.1 18307.6 18772.6 19015.3 19103.5 19126.8 7015.7 7249.5 7250.6 7251.5 7398.6 3629.8 3633.7 3653.7 3674.1 3703.0 2937.2 3011.0 3027.3 3031.1 3032.5 517.6 543.8 547.9 554.8 557.4 570.1 599.9 604.1 614.6 633.3 8264.0 8289.6 8354.3 8527.0 8806.0 463.7 485.0 544.3 557.7 584.9 3753.7 3779.5 3803.0 3821.8 4067.9 97389.0 99546.0 103464.0 105815.0 105996.0 47423.3 50309.0 77875.2 83650.0 83895.0 77664.2 77688.0 77984.6 78464.6 79981.6 7002.3 7558.5 7705.8 7769.3 7792.9 44385.0 45791.0 46030.8 46559.1 46773.3 63443.7 66530.7 67318.0 69248.7 69428.3 10286.3 10546.4 10765.1 10852.6 10955.3 11751.0 12168.6 12381.5 12412.6 12638.7 11612.9 11657.1 11946.1 12092.3 12165.0 10455.7 10875.7 11165.7 11245.4 11403.4 11179.0 11190.3 11217.1 11486.4 12089.2 9083.5 9213.7 9266.8 9631.9 9929.2 9840.8 10061.1 10084.9 10107.4 10179.5 21:37:35 INFO - PROCESS | 25157 | -------- Summary: end -------- 21:37:35 INFO - PROCESS | 25157 | 21:37:36 INFO - TEST-INFO | 25157: exit 0 21:37:36 INFO - TEST-OK | dromaeo_css | took 1121459ms 21:37:36 INFO - TEST-START | kraken 21:37:36 INFO - operating with platform_type : linux_ 21:37:36 INFO - Initialising browser for kraken test... 21:37:36 INFO - TEST-INFO | started process 25465 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRfbBu1/profile http://localhost:51434/getInfo.html) 21:37:40 INFO - PROCESS | 25465 | __metrics Screen width/height:1600/1200 21:37:40 INFO - PROCESS | 25465 | colorDepth:24 21:37:40 INFO - PROCESS | 25465 | Browser inner width/height: 1024/697 21:37:40 INFO - PROCESS | 25465 | __metrics 21:37:41 INFO - PROCESS | 25465 | 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" 21:37:41 INFO - PROCESS | 25465 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:37:41 INFO - PROCESS | 25465 | console.error: PushService: 21:37:41 INFO - PROCESS | 25465 | stateChangeProcessEnqueue: Error transitioning state 21:37:41 INFO - PROCESS | 25465 | UnknownError 21:37:42 INFO - TEST-INFO | 25465: exit 0 21:37:42 INFO - Browser initialized. 21:37:42 INFO - Running cycle 1/1 for kraken test... 21:37:42 INFO - TEST-INFO | started process 25547 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRfbBu1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:37:54 INFO - PROCESS | 25547 | RSS: Main: 174231552 21:37:54 INFO - PROCESS | 25547 | 21:37:57 INFO - PROCESS | 25547 | Cycle 1(1): loaded http://localhost:51434/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51434/tests/kraken/driver.html?testName=audio-beat-detection) 21:37:58 INFO - PROCESS | 25547 | RSS: Main: 233037824 21:37:58 INFO - PROCESS | 25547 | 21:38:01 INFO - PROCESS | 25547 | Cycle 1(1): loaded http://localhost:51434/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51434/tests/kraken/driver.html?testName=audio-dft) 21:38:01 INFO - PROCESS | 25547 | RSS: Main: 218562560 21:38:01 INFO - PROCESS | 25547 | 21:38:05 INFO - PROCESS | 25547 | Cycle 1(1): loaded http://localhost:51434/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51434/tests/kraken/driver.html?testName=audio-fft) 21:38:05 INFO - PROCESS | 25547 | RSS: Main: 300003328 21:38:05 INFO - PROCESS | 25547 | 21:38:07 INFO - PROCESS | 25547 | Cycle 1(1): loaded http://localhost:51434/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51434/tests/kraken/driver.html?testName=audio-oscillator) 21:38:08 INFO - PROCESS | 25547 | RSS: Main: 209018880 21:38:08 INFO - PROCESS | 25547 | 21:38:10 INFO - PROCESS | 25547 | Cycle 1(1): loaded http://localhost:51434/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51434/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:38:11 INFO - PROCESS | 25547 | RSS: Main: 213090304 21:38:11 INFO - PROCESS | 25547 | 21:38:14 INFO - PROCESS | 25547 | Cycle 1(1): loaded http://localhost:51434/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51434/tests/kraken/driver.html?testName=imaging-darkroom) 21:38:15 INFO - PROCESS | 25547 | RSS: Main: 249634816 21:38:15 INFO - PROCESS | 25547 | 21:38:18 INFO - PROCESS | 25547 | Cycle 1(1): loaded http://localhost:51434/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51434/tests/kraken/driver.html?testName=imaging-desaturate) 21:38:19 INFO - PROCESS | 25547 | RSS: Main: 243449856 21:38:19 INFO - PROCESS | 25547 | 21:38:22 INFO - PROCESS | 25547 | Cycle 1(1): loaded http://localhost:51434/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51434/tests/kraken/driver.html?testName=json-parse-financial) 21:38:22 INFO - PROCESS | 25547 | RSS: Main: 246824960 21:38:22 INFO - PROCESS | 25547 | 21:38:24 INFO - PROCESS | 25547 | Cycle 1(1): loaded http://localhost:51434/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51434/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:38:25 INFO - PROCESS | 25547 | RSS: Main: 209625088 21:38:25 INFO - PROCESS | 25547 | 21:38:27 INFO - PROCESS | 25547 | Cycle 1(1): loaded http://localhost:51434/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51434/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:38:27 INFO - PROCESS | 25547 | RSS: Main: 217264128 21:38:27 INFO - PROCESS | 25547 | 21:38:29 INFO - PROCESS | 25547 | Cycle 1(1): loaded http://localhost:51434/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51434/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:38:30 INFO - PROCESS | 25547 | RSS: Main: 226541568 21:38:30 INFO - PROCESS | 25547 | 21:38:33 INFO - PROCESS | 25547 | Cycle 1(1): loaded http://localhost:51434/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51434/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:38:34 INFO - PROCESS | 25547 | RSS: Main: 234885120 21:38:34 INFO - PROCESS | 25547 | 21:38:37 INFO - PROCESS | 25547 | Cycle 1(1): loaded http://localhost:51434/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51434/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:38:37 INFO - PROCESS | 25547 | RSS: Main: 231649280 21:38:37 INFO - PROCESS | 25547 | 21:38:39 INFO - PROCESS | 25547 | Cycle 1(1): loaded http://localhost:51434/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51434/tests/kraken/driver.html?testName=ai-astar) 21:38:39 INFO - PROCESS | 25547 | RSS: Main: 282992640 21:38:39 INFO - PROCESS | 25547 | 21:38:39 INFO - PROCESS | 25547 | __start_tp_report 21:38:39 INFO - PROCESS | 25547 | _x_x_mozilla_page_load 21:38:39 INFO - PROCESS | 25547 | _x_x_mozilla_page_load_details 21:38:39 INFO - PROCESS | 25547 | |i|pagename|runs| 21:38:39 INFO - PROCESS | 25547 | |0;ai-astar;111;116;114;115;115;116;114;114;114;114 21:38:39 INFO - PROCESS | 25547 | |1;audio-beat-detection;158;125;125;167;126;128;127;126;158;129 21:38:39 INFO - PROCESS | 25547 | |2;audio-dft;162;160;161;163;164;163;164;161;161;161 21:38:39 INFO - PROCESS | 25547 | |3;audio-fft;75;76;77;114;77;77;76;76;105;75 21:38:39 INFO - PROCESS | 25547 | |4;audio-oscillator;84;85;113;83;84;84;104;83;83;123 21:38:39 INFO - PROCESS | 25547 | |5;imaging-gaussian-blur;117;117;116;117;117;116;117;117;117;116 21:38:39 INFO - PROCESS | 25547 | |6;imaging-darkroom;146;182;147;148;146;147;147;147;147;146 21:38:39 INFO - PROCESS | 25547 | |7;imaging-desaturate;95;95;96;95;95;95;94;95;95;95 21:38:39 INFO - PROCESS | 25547 | |8;json-parse-financial;64;63;67;64;65;65;65;70;65;65 21:38:39 INFO - PROCESS | 25547 | |9;json-stringify-tinderbox;66;66;66;66;66;66;68;66;67;68 21:38:39 INFO - PROCESS | 25547 | |10;stanford-crypto-aes;84;84;85;84;84;83;84;84;83;83 21:38:39 INFO - PROCESS | 25547 | |11;stanford-crypto-ccm;157;144;150;137;149;136;139;137;183;140 21:38:39 INFO - PROCESS | 25547 | |12;stanford-crypto-pbkdf2;177;176;180;176;178;176;175;176;177;175 21:38:39 INFO - PROCESS | 25547 | |13;stanford-crypto-sha256-iterative;70;72;70;70;70;70;71;70;69;69 21:38:39 INFO - PROCESS | 25547 | __end_tp_report 21:38:39 INFO - PROCESS | 25547 | __start_cc_report 21:38:39 INFO - PROCESS | 25547 | _x_x_mozilla_cycle_collect,1907 21:38:39 INFO - PROCESS | 25547 | __end_cc_report 21:38:39 INFO - PROCESS | 25547 | __startTimestamp1475901519694__endTimestamp 21:38:39 INFO - PROCESS | 25547 | 21:38:39 INFO - PROCESS | 25547 | ------- Summary: start ------- 21:38:39 INFO - PROCESS | 25547 | Number of tests: 14 21:38:39 INFO - PROCESS | 25547 | 21:38:39 INFO - PROCESS | 25547 | [#0] ai-astar Cycles:10 Average:114.30 Median:114.50 stddev:1.42 (1.2%) stddev-sans-first:0.87 21:38:39 INFO - PROCESS | 25547 | Values: 111.0 116.0 114.0 115.0 115.0 116.0 114.0 114.0 114.0 114.0 21:38:39 INFO - PROCESS | 25547 | 21:38:39 INFO - PROCESS | 25547 | [#1] audio-beat-detection Cycles:10 Average:136.90 Median:128.50 stddev:16.86 (13.1%) stddev-sans-first:16.06 21:38:39 INFO - PROCESS | 25547 | Values: 158.0 125.0 125.0 167.0 126.0 128.0 127.0 126.0 158.0 129.0 21:38:39 INFO - PROCESS | 25547 | 21:38:39 INFO - PROCESS | 25547 | [#2] audio-dft Cycles:10 Average:162.00 Median:162.50 stddev:1.41 (0.9%) stddev-sans-first:1.50 21:38:39 INFO - PROCESS | 25547 | Values: 162.0 160.0 161.0 163.0 164.0 163.0 164.0 161.0 161.0 161.0 21:38:39 INFO - PROCESS | 25547 | 21:38:39 INFO - PROCESS | 25547 | [#3] audio-fft Cycles:10 Average:82.80 Median:76.00 stddev:14.25 (18.8%) stddev-sans-first:14.83 21:38:39 INFO - PROCESS | 25547 | Values: 75.0 76.0 77.0 114.0 77.0 77.0 76.0 76.0 105.0 75.0 21:38:39 INFO - PROCESS | 25547 | 21:38:39 INFO - PROCESS | 25547 | [#4] audio-oscillator Cycles:10 Average:92.60 Median:83.50 stddev:15.01 (18.0%) stddev-sans-first:15.59 21:38:39 INFO - PROCESS | 25547 | Values: 84.0 85.0 113.0 83.0 84.0 84.0 104.0 83.0 83.0 123.0 21:38:39 INFO - PROCESS | 25547 | 21:38:39 INFO - PROCESS | 25547 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 21:38:39 INFO - PROCESS | 25547 | Values: 117.0 117.0 116.0 117.0 117.0 116.0 117.0 117.0 117.0 116.0 21:38:39 INFO - PROCESS | 25547 | 21:38:39 INFO - PROCESS | 25547 | [#6] imaging-darkroom Cycles:10 Average:150.30 Median:147.00 stddev:11.16 (7.6%) stddev-sans-first:11.72 21:38:39 INFO - PROCESS | 25547 | Values: 146.0 182.0 147.0 148.0 146.0 147.0 147.0 147.0 147.0 146.0 21:38:39 INFO - PROCESS | 25547 | 21:38:39 INFO - PROCESS | 25547 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 21:38:39 INFO - PROCESS | 25547 | Values: 95.0 95.0 96.0 95.0 95.0 95.0 94.0 95.0 95.0 95.0 21:38:39 INFO - PROCESS | 25547 | 21:38:39 INFO - PROCESS | 25547 | [#8] json-parse-financial Cycles:10 Average:65.30 Median:65.00 stddev:1.95 (3.0%) stddev-sans-first:2.01 21:38:39 INFO - PROCESS | 25547 | Values: 64.0 63.0 67.0 64.0 65.0 65.0 65.0 70.0 65.0 65.0 21:38:39 INFO - PROCESS | 25547 | 21:38:39 INFO - PROCESS | 25547 | [#9] json-stringify-tinderbox Cycles:10 Average:66.50 Median:66.00 stddev:0.85 (1.3%) stddev-sans-first:0.88 21:38:39 INFO - PROCESS | 25547 | Values: 66.0 66.0 66.0 66.0 66.0 66.0 68.0 66.0 67.0 68.0 21:38:39 INFO - PROCESS | 25547 | 21:38:39 INFO - PROCESS | 25547 | [#10] stanford-crypto-aes Cycles:10 Average:83.80 Median:84.00 stddev:0.63 (0.8%) stddev-sans-first:0.67 21:38:39 INFO - PROCESS | 25547 | Values: 84.0 84.0 85.0 84.0 84.0 83.0 84.0 84.0 83.0 83.0 21:38:39 INFO - PROCESS | 25547 | 21:38:39 INFO - PROCESS | 25547 | [#11] stanford-crypto-ccm Cycles:10 Average:147.20 Median:146.50 stddev:14.34 (9.8%) stddev-sans-first:14.77 21:38:39 INFO - PROCESS | 25547 | Values: 157.0 144.0 150.0 137.0 149.0 136.0 139.0 137.0 183.0 140.0 21:38:39 INFO - PROCESS | 25547 | 21:38:39 INFO - PROCESS | 25547 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.60 Median:176.50 stddev:1.51 (0.9%) stddev-sans-first:1.59 21:38:39 INFO - PROCESS | 25547 | Values: 177.0 176.0 180.0 176.0 178.0 176.0 175.0 176.0 177.0 175.0 21:38:39 INFO - PROCESS | 25547 | 21:38:39 INFO - PROCESS | 25547 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.10 Median:70.00 stddev:0.88 (1.3%) stddev-sans-first:0.93 21:38:39 INFO - PROCESS | 25547 | Values: 70.0 72.0 70.0 70.0 70.0 70.0 71.0 70.0 69.0 69.0 21:38:39 INFO - PROCESS | 25547 | -------- Summary: end -------- 21:38:39 INFO - PROCESS | 25547 | 21:38:41 INFO - TEST-INFO | 25547: exit 0 21:38:41 INFO - TEST-OK | kraken | took 64987ms 21:38:41 INFO - SUITE-END | took 1186s 21:38:41 INFO - Completed test suite (00:19:46) 21:38:41 INFO - javascript benchmark 21:38:41 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2519.9244022679322, 2531.8227724059325, 2570.13900343385, 2578.200757765093, 2586.2241327601714, 4439.733615983043, 4540.523245059271, 4597.609203217727, 4624.606908412785, 4638.582527572517, 4544.931826022612, 4552.795124219409, 4577.130345234403, 4596.931046034312, 4650.534946505348, 4196.580341965794, 4203.138356636898, 4206.0, 4223.894402639928, 4311.91376172478, 4335.761533115678, 4364.67264955128, 4367.956320436787, 4409.757463339515, 4410.2943529035365, 4099.549049604541, 4127.8968025799295, 4128.896777580554, 4222.831086756526, 4263.232618128735, 4151.418801367811, 4179.185058913513, 4187.748735075906, 4205.264078786231, 4210.915781684349, 4128.215639028605, 4134.73124246926, 4142.1922725068625, 4145.419641250227, 4193.937090943638, 4544.227481328182, 4552.4764652065105, 4583.839565615188, 4584.083183363307, 4593.908121837578, 4711.199096153662, 4755.762211889391, 4862.051899879525, 4909.312696222496, 4910.754462276872, 4842.66101372904, 4844.394450693663, 4854.12625727369, 4915.066137433876, 4952.281919121743, 4585.037142200175, 4593.379893714373, 4619.86140415788, 4620.607248383858, 4670.579647831712, 4832.975835120802, 4893.094777466109, 4894.779734911937, 4944.53026962438, 5037.647364684511, 4737.0, 4749.121412538691, 4754.619630429557, 4759.262314341283, 4761.071591039714, 4817.566419022305, 4821.397325334333, 4823.204171311764, 4826.372571565744, 4831.685940413862, 4758.857234282977, 4766.785494652749, 4785.473597904228, 4798.064377446434, 4865.294532292798, 4713.717176969393, 4763.7141771493825, 4769.14155452015, 4825.4933232010135, 4827.975860120747, 4105.035316700573, 4138.317177665712, 4140.4617399738445, 4188.937165942513, 4201.306784380543, 3588.964110358915, 3594.5506811648543, 3603.94594081089, 3690.4648825920626, 3697.186618943828, 4204.222218889515, 4226.1758957003085, 4241.7879106044575, 4247.893802654959, 4284.228838808982, 4881.609471242292, 4889.119958407449, 4889.608831293559, 4891.388576427947, 4940.184869496565, 4138.193052354822, 4222.809973551198, 4224.746515209097, 4228.894277643022, 4278.315469524861, 4346.978265108717, 4396.274614688605, 4420.84527041552, 4444.777761111996, 4453.487848897354, 4653.395058642355, 4655.627549796076, 4698.1308457936075, 4709.670323077488, 4710.8351207707565, 4939.678920870132, 4941.555260026615, 4942.752862356796, 4945.134601444661, 5011.047900898818, 4486.865394038184, 4498.662600305056, 4642.2108241598335, 4651.558101980307, 4713.31656909753, 4822.758862056953, 4859.538343857328, 4863.221884498464, 4872.14737420957, 4917.729524876167, 4935.4570997190995, 4936.629752768628, 4947.925781113214, 4948.554630083166, 5005.599552035901, 4703.106409782131, 4802.327674125555, 4813.687110337817, 4822.059698358927, 4875.7074575525585, 4716.056788642354, 4759.524047595212, 4761.666683332133, 4762.595179409789, 4823.011282686971, 4616.8614941551805, 4649.3026046093355, 4669.906601868011, 4680.3915490985955, 4733.100710864925, 4742.454617718869, 4773.952260477489, 4786.928196077131, 4788.018456216537, 4847.5394837490385, 4575.359449677115, 4612.146752850734, 4614.054118905683, 4618.122556714214, 4651.162790697707], "value": 4487.435412587355, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [533.0378666506955, 545.435474284116, 550.0896017091715, 557.7239266563049, 560.3639868748969, 28065.71934280659, 28766.712332876665, 31270.53094203586, 38476.80761596195, 39842.8007859961, 40497.797511012475, 40791.79604101983, 40897.386539201936, 40989.385159222635, 41027.0, 7588.506747061437, 7744.148143704188, 7746.728864489744, 7749.496282741604, 7755.0, 7568.810779730496, 7660.731874384398, 7662.348700360476, 7664.846703065935, 7666.655000524962, 7689.500182488148, 7719.0, 7744.070711514626, 7750.302472777449, 7752.108507521622, 7649.04386951631, 7691.346235569983, 7694.153643099255, 7700.499467534648, 7705.73029943952, 7587.582682952436, 7633.503822251591, 7634.885476717854, 7642.770716878503, 7649.961750191269, 37046.62953370459, 37278.0, 37303.25393492142, 37337.0, 37434.43848342277, 2933.090741870027, 2940.955885661717, 2952.1881482592457, 2975.8065725727756, 3068.8772449102007, 27933.301667458272, 28322.71677283242, 28698.71301286981, 28880.0, 29194.562081568794, 3387.2209391840015, 3398.9660103398896, 3401.914952126192, 3425.537552430415, 3445.6898879101, 173420.0, 173933.0, 174289.0, 175617.0, 175693.99999999872, 51875.22187167196, 52165.47834521606, 52271.47728522742, 52292.738536307836, 52353.0, 32706.345873082406, 33475.832620837224, 33526.664733352845, 35406.0, 55010.0, 13110.344482776014, 13190.538331158363, 13211.0, 13263.535776247785, 13277.668058298426, 10264.332818366782, 10291.279610427348, 10361.585536578603, 10372.896271037192, 10380.480975951172, 17688.91155544214, 17927.282908683508, 17942.0, 18048.20987592594, 18097.819021809875, 6677.666116694243, 6784.253732089466, 6817.284185160586, 6912.896306555405, 6948.93051069493, 744.8957145999565, 824.7072289337319, 850.0819115355401, 863.8963324401112, 942.2885721280389, 26579.734202657724, 28262.43475130527, 28474.430511389655, 28549.594681663963, 28814.855925720236, 743.2678811370796, 838.8322335532918, 878.8154487557684, 916.0610374366328, 933.2160984772823, 11583.478743456564, 14307.92846035784, 14497.202653853928, 14669.48656797007, 14792.704145917236, 361799.0, 364581.0, 365026.0, 365095.0, 365984.0, 48182.75908620434, 48664.0, 48734.51265487371, 48819.511804882204, 48829.0, 1031.1802117316752, 1051.379685985257, 1126.4705588373615, 1147.971300717472, 1149.4482648329017, 27542.5868611975, 28959.276018099717, 29309.85345073261, 29501.704982949897, 29743.405131897674, 41831.37252941269, 42534.36198456964, 42547.0, 42591.57408425876, 42611.0, 230757.0, 231484.0, 232719.0, 233013.0, 375263.0, 35303.470447943815, 35955.82022089873, 36018.0, 37158.071048222926, 37388.0, 42044.0, 42072.579274206866, 42243.7887810559, 42996.78501607472, 43188.11306982387, 32174.517382239752, 32247.51628725524, 32380.676193237767, 32746.672533274363, 33167.43796377517, 34819.0, 35592.0, 35672.0, 35913.82043089768, 36341.27317453583, 35131.83813456699, 35653.465198021535, 35837.10407239736, 35857.282854342244, 36176.095597609215, 31044.844775775975, 31357.795231528962, 32805.34389312248, 32981.340373192885, 33144.83427582846, 25437.0, 25614.615780763677, 25636.487270254864, 25750.26902076406, 25919.0], "value": 16765.55666797237, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [347.3625896479959, 350.98771542996, 371.77136061322284, 378.5797764481425, 391.6631696740802, 11983.460744266507, 12363.567275145371, 15702.0, 16034.759478607815, 16620.916895415507, 15753.448629297976, 15899.28453219605, 16066.116363599996, 16070.59823504413, 16216.108114053723, 3722.497462842509, 4909.582685471739, 5139.460356662534, 5139.743012849342, 5140.820071297505, 5076.060928728197, 5092.210707340369, 5104.132297509433, 5109.054824857395, 5118.897622047557, 4869.05053514563, 5054.772535235923, 5072.365954255718, 5073.46728593496, 5076.974615126919, 4934.0625281196635, 5043.84868453947, 5072.594192464612, 5072.6195535335, 5093.770780314895, 4559.840405585822, 4559.863204103882, 4563.543645635443, 4569.611583015448, 4573.725576465389, 18136.546586335317, 18803.435896923114, 18884.43346699601, 19679.31122410723, 19864.404067877986, 1885.5474686075381, 1936.1868015433552, 2181.9781802181933, 2403.110848985869, 2410.8312418130736, 8987.14622110905, 9204.263658907272, 9301.069893010712, 11923.821142682868, 12142.239375290621, 1668.1659170414794, 1711.161530849887, 1716.2105431501525, 1752.9386471473565, 1774.1218097041917, 67834.66082669554, 68751.65624171897, 69332.65333673349, 69885.3011469884, 71146.0, 9511.14399704016, 9782.608695652094, 9880.851787223197, 9897.109260166619, 9902.455364954852, 13371.933140334237, 13435.126716763574, 13476.797848032287, 13480.662983425493, 13484.932575337256, 6438.645874476949, 6634.568753031038, 6749.763758268437, 6797.0, 6845.589264644137, 6176.8764624707255, 6195.473384762256, 6260.843478913063, 6283.37166283368, 6327.525435592349, 4189.706720529594, 4216.746995180299, 4267.487901451846, 4349.28236840924, 4351.891202719894, 1670.9164541772864, 1703.6166862455848, 1707.4792188382662, 1717.9141042947804, 1744.476657002894, 821.8109834738044, 822.4982760516081, 824.6124321568853, 872.2062922740275, 899.1817446123996, 15759.921200394154, 15909.05688436004, 16239.388667620533, 16484.83515164857, 16542.172891355625, 825.7687847402736, 833.851588347964, 855.4696088425217, 880.9867851982225, 884.0673089890099, 8745.912540874637, 8849.646014159362, 9025.954870225607, 9057.77355566116, 9232.215261702697, 343001.0, 344345.0, 347920.0, 359701.0, 364441.0, 69323.65338173378, 69484.0, 70829.64585177042, 71855.64072179605, 72278.0, 858.1718641510972, 865.1002956924727, 871.1071152069053, 881.4270724029304, 940.6143481172686, 14519.201443920685, 14852.702945941237, 15376.154311512973, 15383.538493845203, 15465.536033919001, 32521.837390812896, 34531.82734086414, 37501.43747843839, 37933.24133517369, 38001.23997520089, 47108.29337560008, 47226.055478890914, 47447.0, 47557.52442475531, 48098.75950620364, 6976.720931162697, 7305.52514086604, 7401.370883474965, 7487.6630551626395, 7700.499467534592, 9910.702678919644, 11502.712432189262, 11623.244489108181, 11710.297382156758, 11874.406279686154, 9934.304598678023, 9966.900330996597, 10060.647877324258, 10151.54318055704, 10727.731806704895, 9959.0, 10337.224708146769, 10441.738956526147, 10472.424016679155, 10676.733081673021, 10362.637307694195, 10375.792484150426, 10381.688549343531, 10680.89319106799, 11013.0, 6477.546571739933, 6645.966770166312, 6678.966605166943, 6987.441004719712, 7382.0, 8114.797130071795, 9619.067886784389, 9830.213582913493, 10021.0, 10715.839262411226], "value": 7876.71845988778, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1196.437674293082, 1317.8616245294245, 1363.5704753002803, 1384.4669802126184, 1681.2602454919834, 6352.301246862841, 7231.746888858891, 7464.06699162604, 7475.663595138219, 7675.501092429002, 7502.81242968926, 7566.470347075693, 7578.3558397536135, 7579.621018949044, 7586.848263034736, 2020.4140799168224, 2030.786767389425, 2031.2179810772811, 2032.8451841048536, 2036.4908772806798, 1979.8812071275697, 2001.9480032966253, 2008.4878356019194, 2025.574629327843, 2032.959340813183, 2001.8999050047512, 2018.7072874433272, 2022.0900594732357, 2029.1578994717174, 2031.1976769176167, 1990.5620763432166, 1991.5120795405073, 1996.0319245166083, 1997.490639886834, 2001.2995451591971, 2010.2963962613114, 2021.5350469391974, 2032.9796702033086, 2033.6136134134615, 2037.3684157911096, 7471.813204669872, 7569.394448444111, 7571.280728330799, 7571.356434703057, 7575.204603516607, 4275.700700950934, 4417.469903611555, 4425.491068527096, 4456.153330867157, 4464.709793863389, 2620.475904819044, 2725.4004119093966, 2759.0343379817105, 2759.351552385188, 2760.0, 859.7764581208868, 888.8932980818334, 895.4285229422322, 902.309733054214, 909.3543584055328, 10063.39619622825, 10197.79604407915, 10203.693889183336, 10211.489425528694, 10215.795684086352, 3651.087228192952, 3770.71719621024, 3894.201688653819, 3946.230485055444, 3951.9604803952166, 8043.517388956564, 8060.476069055492, 8063.717769878026, 8067.39494537912, 8068.152843951418, 4347.978260108743, 4351.19502891966, 4351.651867850627, 4352.847650332286, 4354.129174165179, 3405.3019131078067, 3459.8789042383396, 3807.695384369244, 4046.59534046593, 4054.8175332110127, 3151.6060492438446, 3171.349873275973, 3292.3909076820864, 3303.339332133583, 3307.0, 962.6245764151986, 965.4979410706534, 970.825251454745, 990.2127808392345, 994.8855881573567, 662.4137638190236, 810.343621666452, 820.7660816667221, 831.1356189562907, 861.2722249698994, 4800.279958006327, 4921.9507804921495, 4927.989762098761, 4929.260610908393, 5209.505097015777, 350.3675865063534, 361.1639055586309, 366.93762060449785, 369.76335145506897, 370.8312717713434, 3426.468897320919, 3434.072800343893, 3478.3738926993383, 3501.6848483636595, 3597.442396428558, 8997.730068097968, 9272.582733776997, 9363.672271470467, 9364.719058428258, 9375.48434836077, 9141.588628511732, 9173.678921237724, 9195.724128276162, 9257.166854983085, 9275.072492750805, 6903.792886213421, 6946.687399066953, 6967.7212911482975, 6972.152379619405, 6981.79054628362, 4969.8260560881645, 5018.473060328759, 5040.84877453677, 5067.569256613229, 5276.5251127398715, 8598.78503037429, 8622.741317760478, 8625.611847466753, 8625.69810056645, 8670.956645216733, 7976.7208147714555, 8243.25810677042, 8343.624536895975, 8662.350323725872, 8679.522626255617, 6358.745650174126, 6531.9020214695865, 6688.163979502562, 6696.531242812956, 6701.363370479797, 7241.384482319062, 7242.203357630551, 7295.854082918206, 7309.488335816442, 7311.8537629248185, 6364.204474440695, 6496.0, 6516.5112616553, 6564.343565643589, 6605.735770569124, 6482.0, 6504.1219435375615, 6560.507961902781, 6563.310852360433, 6583.111279977334, 5870.119482077723, 5971.164037034905, 5982.790602328898, 5983.401659834156, 5984.640921544721, 4277.850275240477, 4315.719478233905, 4382.956170438255, 4437.911241775082, 4492.011757413364, 4256.510501292391, 4324.113556720802, 4346.195953748566, 4355.323200567741, 4418.541881179268], "value": 3814.0849179888396, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [285.3679100791746, 293.63295880149815, 296.98812047518095, 301.75859312549954, 303.56286946796627, 4748.216544270195, 4763.761811909408, 4778.6619746471, 4779.160023390993, 4786.138495070886, 4707.446542640929, 4712.740799256039, 4717.905641887169, 4723.574878260956, 4795.328653988445, 3777.7922214278206, 3781.6596506314427, 3785.167263202105, 3785.7728536287773, 3793.6775374093236, 3584.336897673939, 3785.867494637688, 3788.4617306404775, 3789.7726136431766, 3792.696584273265, 3702.907427314325, 3713.3687273163628, 3726.3851464508457, 3737.8131093445218, 3754.774713517184, 3713.8885833425043, 3723.1064544509395, 3731.533558305212, 3736.916294274657, 3785.488958990556, 3052.923676908073, 3129.405412971528, 3291.8354082296028, 3304.0, 3312.585926759155, 4490.126319155743, 4638.721676699375, 4645.140648979949, 4652.55800698933, 4661.72029678217, 4181.0, 4187.895302617429, 4190.898734936156, 4193.895152621209, 4235.597618226264, 4572.337011133401, 4669.272369223409, 4934.5312195341385, 4937.925931111036, 4949.455559888409, 3568.7145028397667, 3573.6069032406413, 3577.159367548624, 3596.3166998270244, 3603.063203567065, 5122.795088196468, 5137.922931156073, 5148.5623721983675, 5154.149565321717, 5155.200943853709, 3640.453931910182, 3647.9635203648154, 3652.652997965189, 3653.94519082214, 3657.5428071491065, 3399.3881101401985, 3586.6234045425376, 3605.152789094561, 3638.490611314418, 3648.5770549485724, 4138.91722165555, 4144.544100148981, 4154.729942553724, 4155.252054630196, 4156.937645935313, 4916.188828843201, 4921.138800709861, 4926.704397736075, 4928.236123400879, 4932.975335123301, 1202.7594481103815, 1224.3449754381363, 1237.127824883455, 1241.6895776055985, 1244.7821631214501, 783.295034468971, 783.5259667900951, 789.2029050658875, 790.671871173468, 792.5086446403152, 3748.2878253131817, 3961.782101984361, 3969.226000929849, 3983.8008099594904, 3985.2501773776003, 4486.3494793254795, 4490.0, 4496.39298694672, 4499.672596584016, 4503.189425903369, 3962.3754260752953, 3963.710120599895, 3964.3458829292845, 3965.2466031453932, 3985.5217373915316, 2395.3711476196354, 2402.25530085674, 2412.372783076378, 2412.4560281419904, 2550.528152291832, 4539.909201816011, 4762.9523704763205, 4806.399200099988, 4812.639052071108, 4841.878953026203, 5203.7918483261, 5211.478852114834, 5218.860267290393, 5238.554722848525, 5244.711540865213, 4825.252085926687, 4839.661223714306, 4845.63657725672, 4856.975715121402, 4862.538058884471, 4975.179095449211, 5043.394792624908, 5062.519060689228, 5064.0, 5139.691618502752, 4981.829270121591, 4998.0, 5017.3226614406585, 5020.196768517019, 5032.119379108714, 4828.348172996741, 4841.2496063110275, 4843.588294994965, 4857.732824694675, 4858.708477491362, 3470.2018535736415, 3571.8214089295952, 3602.85588576454, 3610.693091087287, 3613.403788374994, 5085.46602606721, 5104.642675012714, 5111.670965548909, 5115.9232611510115, 5117.667351622133, 4936.284238785428, 4951.8266860659705, 4964.039204514269, 4964.627652926118, 4975.378077740283, 4801.351817504592, 4958.735522441899, 4962.354893863775, 4975.626827987988, 4984.22744474607, 4862.440819305825, 4868.318435419115, 4888.193448081027, 4894.657373983787, 4901.509849015212, 4983.707494552546, 5000.699958002531, 5005.474425185449, 5008.824691135793, 5013.147764880052, 4661.720296782204, 4861.4895435978715, 4889.63327750413, 4902.63230257725, 4905.0], "value": 3687.645471311161, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [625.4996003197442, 636.5035272487462, 651.4885814635512, 725.611797688237, 741.3290971670639, 12733.745325093505, 13767.724645507109, 13791.448342066318, 13800.861991380083, 13807.516736914222, 13091.279979601119, 13218.471261149567, 13235.536756213534, 13252.469901203964, 13256.270905100215, 599.6641880546886, 612.7640858269576, 722.4473277942378, 729.7920092773561, 742.9294217049398, 754.9962250188769, 757.7082823113113, 757.893894854718, 757.9317861392474, 758.298573819215, 802.1937952357872, 804.5534728225832, 804.7706403674954, 805.3195050182586, 805.3677862877643, 620.9379062093777, 636.4208570201095, 636.7994081864198, 641.8555824939398, 789.5420656019495, 473.3727810650901, 563.2621266141327, 570.54356514788, 576.469647923911, 578.0, 12617.0, 12642.735726427376, 12651.620451386472, 12655.114142010063, 12658.74682506354, 11970.940145299304, 12376.62870113898, 12448.190867593577, 12741.299228542426, 12945.352732363439, 11703.94148029263, 11822.0, 11937.820932686016, 12022.458989345412, 12593.181443206255, 4068.4304197412384, 4084.611961863618, 4087.6116768906904, 4205.537390887, 4227.957720422787, 59435.70282148562, 60993.390066099215, 61391.693041534505, 61574.69212653908, 62129.0, 9591.136797688241, 9884.80230395388, 9926.900730992742, 10054.748631284276, 10076.143527800072, 18307.63384732298, 18772.624547508975, 19015.33446329372, 19103.52241193981, 19126.80873191278, 7015.684294206773, 7249.492535522463, 7250.6374681265725, 7251.4923955323675, 7398.593077380796, 3629.8366573504254, 3633.65480279373, 3653.7442379033746, 3674.11821162919, 3702.9629703702617, 2937.19227212514, 3011.036468330113, 3027.2885871820104, 3031.1361262040214, 3032.454158251536, 517.5962749055742, 543.8259756877841, 547.887683024979, 554.7697705452273, 557.4342042826535, 570.1447828257614, 599.87166924489, 604.0697326117818, 614.6066517428849, 633.3002032753741, 8264.0, 8289.58552072394, 8354.331653467709, 8526.976762788505, 8805.955970220108, 463.6962789372966, 484.9684770489907, 544.2516539757833, 557.701629628147, 584.8567101060268, 3753.737238393286, 3779.4708740776314, 3803.030227292023, 3821.808909554511, 4067.8576249831112, 97389.0, 99546.0, 103464.0, 105815.0, 105996.0, 47423.28865067027, 50309.0, 77875.22124778794, 83650.0, 83895.0, 77664.22335776682, 77688.0, 77984.61007694925, 78464.60767696126, 79981.60009199916, 7002.299770023161, 7558.546487210785, 7705.845883082419, 7769.339606133542, 7792.922070779219, 44385.0, 45791.0, 46030.76984615056, 46559.06881862412, 46773.29840052334, 63443.6827815858, 66530.66734666296, 67318.0, 69248.6537567329, 69428.3057169442, 10286.331388459726, 10546.367217966947, 10765.084967777826, 10852.565897364333, 10955.287906286067, 11751.0, 12168.574099906815, 12381.504739810307, 12412.56556020535, 12638.747225055264, 11612.883871161519, 11657.050530840632, 11946.104042196695, 12092.334921579397, 12165.0, 10455.686329409826, 10875.728106797076, 11165.665030049111, 11245.381504017358, 11403.372814495282, 11178.99389054989, 11190.272632278877, 11217.102631789601, 11486.425678716198, 12089.15375923677, 9083.500407477388, 9213.723588292361, 9266.768330791785, 9631.855522167314, 9929.205663547044, 9840.803183936137, 10061.144802691853, 10084.94957525237, 10107.39355638664, 10179.541920613738], "value": 6496.197544395648, "unit": "score"}], "name": "dromaeo_css", "value": 6150.854929051384, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 116.0, 114.0, 115.0, 115.0, 116.0, 114.0, 114.0, 114.0, 114.0], "value": 114.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 125.0, 125.0, 167.0, 126.0, 128.0, 127.0, 126.0, 158.0, 129.0], "value": 136.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 160.0, 161.0, 163.0, 164.0, 163.0, 164.0, 161.0, 161.0, 161.0], "value": 162.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 77.0, 114.0, 77.0, 77.0, 76.0, 76.0, 105.0, 75.0], "value": 82.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 113.0, 83.0, 84.0, 84.0, 104.0, 83.0, 83.0, 123.0], "value": 92.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 116.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 182.0, 147.0, 148.0, 146.0, 147.0, 147.0, 147.0, 147.0, 146.0], "value": 150.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 67.0, 64.0, 65.0, 65.0, 65.0, 70.0, 65.0, 65.0], "value": 65.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 66.0, 66.0, 66.0, 66.0, 68.0, 66.0, 67.0, 68.0], "value": 66.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 85.0, 84.0, 84.0, 83.0, 84.0, 84.0, 83.0, 83.0], "value": 83.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 144.0, 150.0, 137.0, 149.0, 136.0, 139.0, 137.0, 183.0, 140.0], "value": 147.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 176.0, 180.0, 176.0, 178.0, 176.0, 175.0, 176.0, 177.0, 175.0], "value": 176.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 72.0, 70.0, 70.0, 70.0, 70.0, 71.0, 70.0, 69.0, 69.0], "value": 70.1, "unit": "score"}], "name": "kraken", "value": 1560.1, "alertThreshold": 2.0}]} 21:38:41 INFO - Return code: 0 21:38:41 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 21:38:41 INFO - # TBPL SUCCESS # 21:38:41 INFO - Running post-action listener: _resource_record_post_action 21:38:41 INFO - [mozharness: 2016-10-08 04:38:41.488631Z] Finished run-tests step (success) 21:38:41 INFO - Running post-run listener: _resource_record_post_run 21:38:41 INFO - Total resource usage - Wall time: 1203s; CPU: 13.0%; Read bytes: 40960; Write bytes: 408391680; Read time: 344; Write time: 249040 21:38:41 INFO - TinderboxPrint: CPU usage
13.0% 21:38:41 INFO - TinderboxPrint: I/O read bytes / time
40,960 / 344 21:38:41 INFO - TinderboxPrint: I/O write bytes / time
408,391,680 / 249,040 21:38:41 INFO - TinderboxPrint: CPU idle
8,345.0 (86.9%) 21:38:41 INFO - TinderboxPrint: CPU user
1,203.6 (12.5%) 21:38:41 INFO - TinderboxPrint: Swap in / out
0 / 0 21:38:41 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 4096; Write bytes: 106754048; Read time: 152; Write time: 55548 21:38:41 INFO - run-tests - Wall time: 1187s; CPU: 13.0%; Read bytes: 28672; Write bytes: 291405824; Read time: 172; Write time: 192472 21:38:42 INFO - Running post-run listener: _upload_blobber_files 21:38:42 INFO - Blob upload gear active. 21:38:42 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 21:38:42 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 21:38:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 21:38:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 21:38:42 INFO - (blobuploader) - INFO - Open directory for files ... 21:38:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 21:38:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:38:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:38:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 21:38:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:38:43 INFO - (blobuploader) - INFO - Done attempting. 21:38:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 21:38:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:38:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:38:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 21:38:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:38:44 INFO - (blobuploader) - INFO - Done attempting. 21:38:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 21:38:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:38:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:38:47 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 21:38:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:38:47 INFO - (blobuploader) - INFO - Done attempting. 21:38:47 INFO - (blobuploader) - INFO - Iteration through files over. 21:38:47 INFO - Return code: 0 21:38:47 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 21:38:47 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 21:38:47 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/187cf449fc804943dbb0a42fafb5df5934e74735d397e6eeb6ff207f172d73268ad95583358df98c39a50a740cee7742c5b2ca199b8048c150f79c775617f9ad", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a55fd0dd25c40ff49536af7f1e57041a6d00fab1237561997fa9e5a37c7b689e4062186cc09c25525f98c567357dc9330226cafed8a2174fc5bc41d3b05689c1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b7c10b0c8c99797a7890d260c648ef0529d352c7d36985e3ea2a6bdcb01de2135d00b12724d1514ec12f5307736e3b26fa60e6db83e4779eb08e8ffc5743faaa"} 21:38:47 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 21:38:47 INFO - Writing to file /builds/slave/test/properties/blobber_files 21:38:47 INFO - Contents: 21:38:47 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/187cf449fc804943dbb0a42fafb5df5934e74735d397e6eeb6ff207f172d73268ad95583358df98c39a50a740cee7742c5b2ca199b8048c150f79c775617f9ad", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a55fd0dd25c40ff49536af7f1e57041a6d00fab1237561997fa9e5a37c7b689e4062186cc09c25525f98c567357dc9330226cafed8a2174fc5bc41d3b05689c1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b7c10b0c8c99797a7890d260c648ef0529d352c7d36985e3ea2a6bdcb01de2135d00b12724d1514ec12f5307736e3b26fa60e6db83e4779eb08e8ffc5743faaa"} 21:38:47 INFO - Running post-run listener: copy_logs_to_upload_dir 21:38:47 INFO - Copying logs to upload dir... 21:38:47 INFO - mkdir: /builds/slave/test/build/upload/logs 21:38:47 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.857027 ========= master_lag: 0.27 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-10-07 21:38:48.028067) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-07 21:38:48.032600) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=74d6aec007b0fa31a864ebd7000001f8-1475899969.994681-1799934594 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/187cf449fc804943dbb0a42fafb5df5934e74735d397e6eeb6ff207f172d73268ad95583358df98c39a50a740cee7742c5b2ca199b8048c150f79c775617f9ad", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a55fd0dd25c40ff49536af7f1e57041a6d00fab1237561997fa9e5a37c7b689e4062186cc09c25525f98c567357dc9330226cafed8a2174fc5bc41d3b05689c1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b7c10b0c8c99797a7890d260c648ef0529d352c7d36985e3ea2a6bdcb01de2135d00b12724d1514ec12f5307736e3b26fa60e6db83e4779eb08e8ffc5743faaa"} build_url:https://queue.taskcluster.net/v1/task/VFgeObhNTxS8XK-dc_Wtjw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011348 build_url: 'https://queue.taskcluster.net/v1/task/VFgeObhNTxS8XK-dc_Wtjw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/187cf449fc804943dbb0a42fafb5df5934e74735d397e6eeb6ff207f172d73268ad95583358df98c39a50a740cee7742c5b2ca199b8048c150f79c775617f9ad", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a55fd0dd25c40ff49536af7f1e57041a6d00fab1237561997fa9e5a37c7b689e4062186cc09c25525f98c567357dc9330226cafed8a2174fc5bc41d3b05689c1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b7c10b0c8c99797a7890d260c648ef0529d352c7d36985e3ea2a6bdcb01de2135d00b12724d1514ec12f5307736e3b26fa60e6db83e4779eb08e8ffc5743faaa"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-07 21:38:48.061035) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-07 21:38:48.061402) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=74d6aec007b0fa31a864ebd7000001f8-1475899969.994681-1799934594 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004534 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-07 21:38:48.110826) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-07 21:38:48.111133) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-07 21:38:48.114452) ========= ========= Total master_lag: 0.40 =========