builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-059 starttime: 1480180657.28 results: success (0) buildid: 20161126062719 builduid: 30124f9638c94b50b6f27fa53bf20f66 revision: fe8d7e54713a87a4a356a77ff35b0830a8567e76 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-26 09:17:37.278515) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-26 09:17:37.279014) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-26 09:17:37.279340) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-26 09:17:37.295360) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-26 09:17:37.295683) ========= 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=3a3620fb28aea1604ab609ef000001d2-1480179242.764757-1433683382 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-26 09:17:37-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 94.4M=0s 2016-11-26 09:17:37 (94.4 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.091469 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-26 09:17:37.401077) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-26 09:17:37.401409) ========= 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=3a3620fb28aea1604ab609ef000001d2-1480179242.764757-1433683382 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022480 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-26 09:17:37.452024) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-26 09:17:37.452399) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev fe8d7e54713a87a4a356a77ff35b0830a8567e76 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev fe8d7e54713a87a4a356a77ff35b0830a8567e76 --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=3a3620fb28aea1604ab609ef000001d2-1480179242.764757-1433683382 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-26 09:17:38,054 truncating revision to first 12 chars 2016-11-26 09:17:38,054 Setting DEBUG logging. 2016-11-26 09:17:38,054 attempt 1/10 2016-11-26 09:17:38,054 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/fe8d7e54713a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-26 09:17:38,362 unpacking tar archive at: mozilla-aurora-fe8d7e54713a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.636076 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-26 09:17:38.102793) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-26 09:17:38.103156) ========= script_repo_revision: fe8d7e54713a87a4a356a77ff35b0830a8567e76 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-26 09:17:38.103628) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-26 09:17:38.103949) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-26 09:17:38.113320) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-11-26 09:17:38.113665) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=3a3620fb28aea1604ab609ef000001d2-1480179242.764757-1433683382 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:17:38 INFO - MultiFileLogger online at 20161126 09:17:38 in /builds/slave/test 09:17:38 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 09:17:38 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:17:38 INFO - {'append_to_log': False, 09:17:38 INFO - 'base_work_dir': '/builds/slave/test', 09:17:38 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 09:17:38 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:17:38 INFO - 'branch': 'Mozilla-Aurora', 09:17:38 INFO - 'buildbot_json_path': 'buildprops.json', 09:17:38 INFO - 'config_files': ('talos/linux_config.py',), 09:17:38 INFO - 'default_actions': ('clobber', 09:17:38 INFO - 'read-buildbot-config', 09:17:38 INFO - 'download-and-extract', 09:17:38 INFO - 'populate-webroot', 09:17:38 INFO - 'create-virtualenv', 09:17:38 INFO - 'install', 09:17:38 INFO - 'run-tests'), 09:17:38 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:17:38 INFO - 'download_minidump_stackwalk': True, 09:17:38 INFO - 'download_symbols': 'ondemand', 09:17:38 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:17:38 INFO - 'tooltool.py': '/tools/tooltool.py', 09:17:38 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:17:38 INFO - '/tools/misc-python/virtualenv.py')}, 09:17:38 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:17:38 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:17:38 INFO - 'installer_path': 'installer.exe', 09:17:38 INFO - 'log_level': 'info', 09:17:38 INFO - 'log_name': 'talos', 09:17:38 INFO - 'log_to_console': True, 09:17:38 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:17:38 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:17:38 INFO - 'opt_config_files': (), 09:17:38 INFO - 'pip_index': False, 09:17:38 INFO - 'sps_profile': False, 09:17:38 INFO - 'sps_profile_interval': 0, 09:17:38 INFO - 'suite': 'dromaeojs', 09:17:38 INFO - 'system_bits': '32', 09:17:38 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:17:38 INFO - 'title': 'talos-linux64-ix-059', 09:17:38 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:17:38 INFO - 'use_talos_json': True, 09:17:38 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:17:38 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:17:38 INFO - 'work_dir': 'build'} 09:17:38 INFO - [mozharness: 2016-11-26 17:17:38.805831Z] Running clobber step. 09:17:38 INFO - Running pre-action listener: _resource_record_pre_action 09:17:38 INFO - Running main action method: clobber 09:17:38 INFO - rmtree: /builds/slave/test/build 09:17:38 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:17:39 INFO - Running post-action listener: _resource_record_post_action 09:17:39 INFO - [mozharness: 2016-11-26 17:17:39.264322Z] Finished clobber step (success) 09:17:39 INFO - [mozharness: 2016-11-26 17:17:39.264422Z] Running read-buildbot-config step. 09:17:39 INFO - Running pre-action listener: _resource_record_pre_action 09:17:39 INFO - Running main action method: read_buildbot_config 09:17:39 INFO - Using buildbot properties: 09:17:39 INFO - { 09:17:39 INFO - "project": "", 09:17:39 INFO - "product": "firefox", 09:17:39 INFO - "script_repo_revision": "production", 09:17:39 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 09:17:39 INFO - "repository": "", 09:17:39 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 09:17:39 INFO - "buildid": "20161126062719", 09:17:39 INFO - "pgo_build": "True", 09:17:39 INFO - "basedir": "/builds/slave/test", 09:17:39 INFO - "buildnumber": 928, 09:17:39 INFO - "slavename": "talos-linux64-ix-059", 09:17:39 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 09:17:39 INFO - "platform": "ubuntu64_hw", 09:17:39 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 09:17:39 INFO - "branch": "mozilla-aurora", 09:17:39 INFO - "repo_path": "releases/mozilla-aurora", 09:17:39 INFO - "revision": "fe8d7e54713a87a4a356a77ff35b0830a8567e76", 09:17:39 INFO - "stage_platform": "linux64-pgo", 09:17:39 INFO - "builduid": "30124f9638c94b50b6f27fa53bf20f66", 09:17:39 INFO - "slavebuilddir": "test" 09:17:39 INFO - } 09:17:39 INFO - Found installer url https://queue.taskcluster.net/v1/task/TNeSr781SQuei-4aJv5Dfw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2. 09:17:39 INFO - Running post-action listener: _resource_record_post_action 09:17:39 INFO - [mozharness: 2016-11-26 17:17:39.266850Z] Finished read-buildbot-config step (success) 09:17:39 INFO - [mozharness: 2016-11-26 17:17:39.266938Z] Running download-and-extract step. 09:17:39 INFO - Running pre-action listener: _resource_record_pre_action 09:17:39 INFO - Running main action method: download_and_extract 09:17:39 INFO - mkdir: /builds/slave/test/build/tests 09:17:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:17:39 INFO - trying https://queue.taskcluster.net/v1/task/TNeSr781SQuei-4aJv5Dfw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 09:17:39 INFO - Downloading https://queue.taskcluster.net/v1/task/TNeSr781SQuei-4aJv5Dfw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 09:17:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TNeSr781SQuei-4aJv5Dfw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 09:17:39 INFO - Downloaded 1361 bytes. 09:17:39 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 09:17:39 INFO - Using the following test package requirements: 09:17:39 INFO - {u'common': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 09:17:39 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 09:17:39 INFO - u'firefox-52.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 09:17:39 INFO - u'gtest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 09:17:39 INFO - u'firefox-52.0a2.en-US.linux-x86_64.gtest.tests.zip'], 09:17:39 INFO - u'jittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 09:17:39 INFO - u'jsshell-linux-x86_64.zip'], 09:17:39 INFO - u'mochitest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 09:17:39 INFO - u'firefox-52.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 09:17:39 INFO - u'mozbase': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 09:17:39 INFO - u'reftest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 09:17:39 INFO - u'firefox-52.0a2.en-US.linux-x86_64.reftest.tests.zip'], 09:17:39 INFO - u'talos': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 09:17:39 INFO - u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'], 09:17:39 INFO - u'web-platform': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 09:17:39 INFO - u'firefox-52.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 09:17:39 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 09:17:39 INFO - u'firefox-52.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 09:17:39 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:17:39 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TNeSr781SQuei-4aJv5Dfw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 09:17:39 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TNeSr781SQuei-4aJv5Dfw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:17:39 INFO - Fetch https://queue.taskcluster.net/v1/task/TNeSr781SQuei-4aJv5Dfw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 09:17:40 INFO - Http code: 200 09:17:40 INFO - via: 1.1 441811a054e8d055b893175754efd0c3.cloudfront.net (CloudFront) 09:17:40 INFO - x-amz-cf-id: hLQM0Dw1HNP46FbglqLKR4Bdr58KZYhjv-lyDkRx5v2J3TTgMGJtEA== 09:17:40 INFO - x-amz-version-id: 7OKOiiZTqMXrNDIvyZbzeEY_Zy2l3fYA 09:17:40 INFO - Expected file size: 21951407 09:17:40 INFO - Obtained file size: 21951407 09:17:44 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 09:17:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TNeSr781SQuei-4aJv5Dfw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 09:17:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TNeSr781SQuei-4aJv5Dfw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:17:44 INFO - Fetch https://queue.taskcluster.net/v1/task/TNeSr781SQuei-4aJv5Dfw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 09:17:45 INFO - Http code: 200 09:17:45 INFO - via: 1.1 9baadab4e4d95afe7af7bcba342b29c6.cloudfront.net (CloudFront) 09:17:45 INFO - x-amz-cf-id: UJEpx2d4kqhRbTbJnmPCOmJu7_wnEnMJQZ4obbqD31b1rnKTb20dUw== 09:17:45 INFO - x-amz-version-id: 7OKOiiZTqMXrNDIvyZbzeEY_Zy2l3fYA 09:17:45 INFO - Expected file size: 21951407 09:17:45 INFO - Obtained file size: 21951407 09:17:49 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TNeSr781SQuei-4aJv5Dfw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip 09:17:49 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TNeSr781SQuei-4aJv5Dfw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 09:17:49 INFO - Fetch https://queue.taskcluster.net/v1/task/TNeSr781SQuei-4aJv5Dfw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip into memory 09:17:50 INFO - Http code: 200 09:17:50 INFO - via: 1.1 ff555a0cc6346f82fe74596f8ed6cc33.cloudfront.net (CloudFront) 09:17:50 INFO - x-amz-cf-id: SI9M8oxImMLNYkA22_Lhr82mquZTSGlCe0LmohsHntO6PncOeIv1wg== 09:17:50 INFO - x-amz-version-id: HQBp6Mo546IVZ4t91ANO1QAFy4x3WkWe 09:17:51 INFO - Expected file size: 14409038 09:17:51 INFO - Obtained file size: 14409038 09:17:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:17:51 INFO - trying https://queue.taskcluster.net/v1/task/TNeSr781SQuei-4aJv5Dfw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 09:17:51 INFO - Downloading https://queue.taskcluster.net/v1/task/TNeSr781SQuei-4aJv5Dfw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 09:17:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TNeSr781SQuei-4aJv5Dfw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 09:17:52 INFO - Downloaded 63966616 bytes. 09:17:52 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/TNeSr781SQuei-4aJv5Dfw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 09:17:52 INFO - mkdir: /builds/slave/test/properties 09:17:52 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:17:52 INFO - Writing to file /builds/slave/test/properties/build_url 09:17:52 INFO - Contents: 09:17:52 INFO - build_url:https://queue.taskcluster.net/v1/task/TNeSr781SQuei-4aJv5Dfw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 09:17:53 INFO - Running post-action listener: _resource_record_post_action 09:17:53 INFO - Running post-action listener: set_extra_try_arguments 09:17:53 INFO - [mozharness: 2016-11-26 17:17:53.493114Z] Finished download-and-extract step (success) 09:17:53 INFO - [mozharness: 2016-11-26 17:17:53.493338Z] Running populate-webroot step. 09:17:53 INFO - Running pre-action listener: _resource_record_pre_action 09:17:53 INFO - Running main action method: populate_webroot 09:17:53 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:17:53 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:17:53 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:17:53 INFO - '--tppagecycles', 09:17:53 INFO - '7'], 09:17:53 INFO - 'tests': ['tsvgm']}}, 09:17:53 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:17:53 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:17:53 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:17:53 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:17:53 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:17:53 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:17:53 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:17:53 INFO - 'talos_options': ['--disable-e10s'], 09:17:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:17:53 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:17:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:17:53 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:17:53 INFO - 'talos_options': ['--disable-e10s'], 09:17:53 INFO - 'tests': ['damp', 'tps']}, 09:17:53 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:17:53 INFO - 'tests': ['damp', 'tps']}, 09:17:53 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:17:53 INFO - 'tests': ['dromaeo_dom']}, 09:17:53 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:17:53 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:17:53 INFO - 'tests': ['basic_compositor_video']}, 09:17:53 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:17:53 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:17:53 INFO - 'tests': ['a11yr', 09:17:53 INFO - 'ts_paint', 09:17:53 INFO - 'tpaint', 09:17:53 INFO - 'sessionrestore', 09:17:53 INFO - 'sessionrestore_no_auto_restore', 09:17:53 INFO - 'tabpaint']}, 09:17:53 INFO - 'other-e10s': {'tests': ['a11yr', 09:17:53 INFO - 'ts_paint', 09:17:53 INFO - 'tpaint', 09:17:53 INFO - 'sessionrestore', 09:17:53 INFO - 'sessionrestore_no_auto_restore', 09:17:53 INFO - 'tabpaint']}, 09:17:53 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:17:53 INFO - 'ts_paint', 09:17:53 INFO - 'tpaint', 09:17:53 INFO - 'sessionrestore', 09:17:53 INFO - 'sessionrestore_no_auto_restore', 09:17:53 INFO - 'tabpaint']}, 09:17:53 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:17:53 INFO - 'ts_paint', 09:17:53 INFO - 'tpaint', 09:17:53 INFO - 'sessionrestore', 09:17:53 INFO - 'sessionrestore_no_auto_restore', 09:17:53 INFO - 'tabpaint']}, 09:17:53 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:17:53 INFO - 'tests': ['a11yr', 09:17:53 INFO - 'ts_paint', 09:17:53 INFO - 'tpaint', 09:17:53 INFO - 'sessionrestore', 09:17:53 INFO - 'sessionrestore_no_auto_restore', 09:17:53 INFO - 'tabpaint']}, 09:17:53 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:17:53 INFO - 'tests': ['a11yr', 09:17:53 INFO - 'ts_paint', 09:17:53 INFO - 'tpaint', 09:17:53 INFO - 'sessionrestore', 09:17:53 INFO - 'sessionrestore_no_auto_restore', 09:17:53 INFO - 'tabpaint']}, 09:17:53 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:17:53 INFO - 'tests': ['tsvgx', 09:17:53 INFO - 'tsvgr_opacity', 09:17:53 INFO - 'tart', 09:17:53 INFO - 'tscrollx', 09:17:53 INFO - 'cart']}, 09:17:53 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:17:53 INFO - 'tsvgr_opacity', 09:17:53 INFO - 'tart', 09:17:53 INFO - 'tscrollx', 09:17:53 INFO - 'cart']}, 09:17:53 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:17:53 INFO - 'talos_options': ['--disable-e10s'], 09:17:53 INFO - 'tests': ['tp5o']}, 09:17:53 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:17:53 INFO - 'tests': ['tp5o']}, 09:17:53 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:17:53 INFO - 'talos_options': ['--disable-e10s', 09:17:53 INFO - '--xperf_path', 09:17:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:17:53 INFO - 'tests': ['tp5n']}, 09:17:53 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:17:53 INFO - 'talos_options': ['--xperf_path', 09:17:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:17:53 INFO - 'tests': ['tp5n']}}, 09:17:53 INFO - 'talos.zip': {'path': '', 09:17:53 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:17:53 INFO - Running post-action listener: _resource_record_post_action 09:17:53 INFO - [mozharness: 2016-11-26 17:17:53.511832Z] Finished populate-webroot step (success) 09:17:53 INFO - [mozharness: 2016-11-26 17:17:53.511918Z] Running create-virtualenv step. 09:17:53 INFO - Running pre-action listener: _resource_record_pre_action 09:17:53 INFO - Running main action method: create_virtualenv 09:17:53 INFO - Creating virtualenv /builds/slave/test/build/venv 09:17:53 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 09:17:53 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:17:53 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:17:53 INFO - Using real prefix '/usr' 09:17:53 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:17:54 INFO - Installing distribute.............................................................................................................................................................................................done. 09:17:56 INFO - Installing pip.................done. 09:17:56 INFO - Return code: 0 09:17:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:17:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:17:56 INFO - Reading from file tmpfile_stdout 09:17:56 INFO - Output received: 09:17:56 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 09:17:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:17:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:17:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:17:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:17:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:17:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:17:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:17:56 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 0x7ffd3b01cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27bb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2888ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2885f60>, '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 0x2886d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28871d0>, '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': '3a3620fb28aea1604ab609ef000001d2-1480179242.764757-1433683382', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:17:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 09:17:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:17:56 INFO - Using env: {'DISPLAY': ':0', 09:17:56 INFO - 'HOME': '/home/cltbld', 09:17:56 INFO - 'LANG': 'en_US.UTF-8', 09:17:56 INFO - 'LANGUAGE': 'en_US:en', 09:17:56 INFO - 'LOGNAME': 'cltbld', 09:17:56 INFO - 'MAIL': '/var/mail/cltbld', 09:17:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:17:56 INFO - 'MOZ_NO_REMOTE': '1', 09:17:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:17:56 INFO - 'NO_EM_RESTART': '1', 09:17:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:17:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:17:56 INFO - 'PWD': '/builds/slave/test', 09:17:56 INFO - 'SHELL': '/bin/bash', 09:17:56 INFO - 'SHLVL': '1', 09:17:56 INFO - 'TERM': 'linux', 09:17:56 INFO - 'TMOUT': '86400', 09:17:56 INFO - 'USER': 'cltbld', 09:17:56 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1480179242.764757-1433683382', 09:17:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:17:56 INFO - '_': '/tools/buildbot/bin/python'} 09:17:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:17:56 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 09:17:56 INFO - Cleaning up... 09:17:56 INFO - Return code: 0 09:17:56 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:17:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:17:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:17:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:17:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:17:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:17:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:17:56 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 0x7ffd3b01cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27bb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2888ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2885f60>, '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 0x2886d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28871d0>, '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': '3a3620fb28aea1604ab609ef000001d2-1480179242.764757-1433683382', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:17:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 09:17:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 09:17:56 INFO - Using env: {'DISPLAY': ':0', 09:17:56 INFO - 'HOME': '/home/cltbld', 09:17:56 INFO - 'LANG': 'en_US.UTF-8', 09:17:56 INFO - 'LANGUAGE': 'en_US:en', 09:17:56 INFO - 'LOGNAME': 'cltbld', 09:17:56 INFO - 'MAIL': '/var/mail/cltbld', 09:17:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:17:56 INFO - 'MOZ_NO_REMOTE': '1', 09:17:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:17:56 INFO - 'NO_EM_RESTART': '1', 09:17:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:17:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:17:56 INFO - 'PWD': '/builds/slave/test', 09:17:56 INFO - 'SHELL': '/bin/bash', 09:17:56 INFO - 'SHLVL': '1', 09:17:56 INFO - 'TERM': 'linux', 09:17:56 INFO - 'TMOUT': '86400', 09:17:56 INFO - 'USER': 'cltbld', 09:17:56 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1480179242.764757-1433683382', 09:17:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:17:56 INFO - '_': '/tools/buildbot/bin/python'} 09:17:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:17:56 INFO - Downloading/unpacking psutil>=3.1.1 09:17:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:17:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:17:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:17:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:17:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:17:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:17:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:17:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:17:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:17:58 INFO - Installing collected packages: psutil 09:17:58 INFO - Running setup.py install for psutil 09:17:58 INFO - building 'psutil._psutil_linux' extension 09:17:58 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 09:17:59 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 09:17:59 INFO - building 'psutil._psutil_posix' extension 09:17:59 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 09:17:59 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 09:17:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:17:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:17:59 INFO - Successfully installed psutil 09:17:59 INFO - Cleaning up... 09:17:59 INFO - Return code: 0 09:17:59 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:17:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:17:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:17:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:17:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:17:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:17:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:17:59 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 0x7ffd3b01cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27bb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2888ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2885f60>, '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 0x2886d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28871d0>, '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': '3a3620fb28aea1604ab609ef000001d2-1480179242.764757-1433683382', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:17:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 09:17:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 09:17:59 INFO - Using env: {'DISPLAY': ':0', 09:17:59 INFO - 'HOME': '/home/cltbld', 09:17:59 INFO - 'LANG': 'en_US.UTF-8', 09:17:59 INFO - 'LANGUAGE': 'en_US:en', 09:17:59 INFO - 'LOGNAME': 'cltbld', 09:17:59 INFO - 'MAIL': '/var/mail/cltbld', 09:17:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:17:59 INFO - 'MOZ_NO_REMOTE': '1', 09:17:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:17:59 INFO - 'NO_EM_RESTART': '1', 09:17:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:17:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:17:59 INFO - 'PWD': '/builds/slave/test', 09:17:59 INFO - 'SHELL': '/bin/bash', 09:17:59 INFO - 'SHLVL': '1', 09:17:59 INFO - 'TERM': 'linux', 09:17:59 INFO - 'TMOUT': '86400', 09:17:59 INFO - 'USER': 'cltbld', 09:17:59 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1480179242.764757-1433683382', 09:17:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:17:59 INFO - '_': '/tools/buildbot/bin/python'} 09:17:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:17:59 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:17:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:17:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:17:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:17:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:17:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:17:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:18:01 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:18:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:18:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:18:01 INFO - Installing collected packages: mozsystemmonitor 09:18:01 INFO - Running setup.py install for mozsystemmonitor 09:18:01 INFO - Successfully installed mozsystemmonitor 09:18:01 INFO - Cleaning up... 09:18:01 INFO - Return code: 0 09:18:01 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:18:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:18:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:18:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:18:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:18:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18:01 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 0x7ffd3b01cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27bb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2888ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2885f60>, '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 0x2886d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28871d0>, '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': '3a3620fb28aea1604ab609ef000001d2-1480179242.764757-1433683382', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:18:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 09:18:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 09:18:01 INFO - Using env: {'DISPLAY': ':0', 09:18:01 INFO - 'HOME': '/home/cltbld', 09:18:01 INFO - 'LANG': 'en_US.UTF-8', 09:18:01 INFO - 'LANGUAGE': 'en_US:en', 09:18:01 INFO - 'LOGNAME': 'cltbld', 09:18:01 INFO - 'MAIL': '/var/mail/cltbld', 09:18:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:18:01 INFO - 'MOZ_NO_REMOTE': '1', 09:18:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:18:01 INFO - 'NO_EM_RESTART': '1', 09:18:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:18:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:18:01 INFO - 'PWD': '/builds/slave/test', 09:18:01 INFO - 'SHELL': '/bin/bash', 09:18:01 INFO - 'SHLVL': '1', 09:18:01 INFO - 'TERM': 'linux', 09:18:01 INFO - 'TMOUT': '86400', 09:18:01 INFO - 'USER': 'cltbld', 09:18:01 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1480179242.764757-1433683382', 09:18:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:18:01 INFO - '_': '/tools/buildbot/bin/python'} 09:18:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:18:01 INFO - Downloading/unpacking jsonschema==2.5.1 09:18:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:18:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:18:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:18:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:18:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:18:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:18:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:18:03 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:18:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:18:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:18:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:18:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:18:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:18:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:18:04 INFO - Downloading functools32-3.2.3-2.tar.gz 09:18:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:18:04 INFO - warning: no files found matching '*.txt' 09:18:04 INFO - no previously-included directories found matching 'build' 09:18:04 INFO - no previously-included directories found matching 'dist' 09:18:04 INFO - no previously-included directories found matching '.git*' 09:18:04 INFO - Installing collected packages: jsonschema, functools32 09:18:04 INFO - Running setup.py install for functools32 09:18:04 INFO - warning: no files found matching '*.txt' 09:18:04 INFO - no previously-included directories found matching 'build' 09:18:04 INFO - no previously-included directories found matching 'dist' 09:18:04 INFO - no previously-included directories found matching '.git*' 09:18:04 INFO - Successfully installed jsonschema functools32 09:18:04 INFO - Cleaning up... 09:18:04 INFO - Return code: 0 09:18:04 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:18:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:18:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:18:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:18:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:18:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18:04 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 0x7ffd3b01cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27bb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2888ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2885f60>, '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 0x2886d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28871d0>, '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': '3a3620fb28aea1604ab609ef000001d2-1480179242.764757-1433683382', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:18:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 09:18:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 09:18:04 INFO - Using env: {'DISPLAY': ':0', 09:18:04 INFO - 'HOME': '/home/cltbld', 09:18:04 INFO - 'LANG': 'en_US.UTF-8', 09:18:04 INFO - 'LANGUAGE': 'en_US:en', 09:18:04 INFO - 'LOGNAME': 'cltbld', 09:18:04 INFO - 'MAIL': '/var/mail/cltbld', 09:18:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:18:04 INFO - 'MOZ_NO_REMOTE': '1', 09:18:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:18:04 INFO - 'NO_EM_RESTART': '1', 09:18:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:18:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:18:04 INFO - 'PWD': '/builds/slave/test', 09:18:04 INFO - 'SHELL': '/bin/bash', 09:18:04 INFO - 'SHLVL': '1', 09:18:04 INFO - 'TERM': 'linux', 09:18:04 INFO - 'TMOUT': '86400', 09:18:04 INFO - 'USER': 'cltbld', 09:18:04 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1480179242.764757-1433683382', 09:18:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:18:04 INFO - '_': '/tools/buildbot/bin/python'} 09:18:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:18:04 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:18:04 INFO - Cleaning up... 09:18:04 INFO - Return code: 0 09:18:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:18:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:18:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:18:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:18:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:18:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18:04 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 0x7ffd3b01cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27bb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2888ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2885f60>, '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 0x2886d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28871d0>, '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': '3a3620fb28aea1604ab609ef000001d2-1480179242.764757-1433683382', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:18:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:18:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:18:04 INFO - Using env: {'DISPLAY': ':0', 09:18:04 INFO - 'HOME': '/home/cltbld', 09:18:04 INFO - 'LANG': 'en_US.UTF-8', 09:18:04 INFO - 'LANGUAGE': 'en_US:en', 09:18:04 INFO - 'LOGNAME': 'cltbld', 09:18:04 INFO - 'MAIL': '/var/mail/cltbld', 09:18:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:18:04 INFO - 'MOZ_NO_REMOTE': '1', 09:18:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:18:04 INFO - 'NO_EM_RESTART': '1', 09:18:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:18:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:18:04 INFO - 'PWD': '/builds/slave/test', 09:18:04 INFO - 'SHELL': '/bin/bash', 09:18:04 INFO - 'SHLVL': '1', 09:18:04 INFO - 'TERM': 'linux', 09:18:04 INFO - 'TMOUT': '86400', 09:18:04 INFO - 'USER': 'cltbld', 09:18:04 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1480179242.764757-1433683382', 09:18:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:18:04 INFO - '_': '/tools/buildbot/bin/python'} 09:18:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:18:04 INFO - Downloading/unpacking blobuploader==1.2.4 09:18:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:18:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:18:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:18:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:18:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:18:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:18:06 INFO - Downloading blobuploader-1.2.4.tar.gz 09:18:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:18:06 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:18:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:18:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:18:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:18:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:18:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:18:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:18:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:18:07 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:18:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:18:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:18:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:18:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:18:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:18:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:18:07 INFO - Downloading docopt-0.6.1.tar.gz 09:18:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:18:07 INFO - Installing collected packages: blobuploader, requests, docopt 09:18:07 INFO - Running setup.py install for blobuploader 09:18:07 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:18:07 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:18:07 INFO - Running setup.py install for requests 09:18:07 INFO - Running setup.py install for docopt 09:18:08 INFO - Successfully installed blobuploader requests docopt 09:18:08 INFO - Cleaning up... 09:18:08 INFO - Return code: 0 09:18:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:18:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:18:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:18:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:18:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:18:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18:08 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 0x7ffd3b01cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27bb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2888ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2885f60>, '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 0x2886d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28871d0>, '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': '3a3620fb28aea1604ab609ef000001d2-1480179242.764757-1433683382', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:18:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:18:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:18:08 INFO - Using env: {'DISPLAY': ':0', 09:18:08 INFO - 'HOME': '/home/cltbld', 09:18:08 INFO - 'LANG': 'en_US.UTF-8', 09:18:08 INFO - 'LANGUAGE': 'en_US:en', 09:18:08 INFO - 'LOGNAME': 'cltbld', 09:18:08 INFO - 'MAIL': '/var/mail/cltbld', 09:18:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:18:08 INFO - 'MOZ_NO_REMOTE': '1', 09:18:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:18:08 INFO - 'NO_EM_RESTART': '1', 09:18:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:18:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:18:08 INFO - 'PWD': '/builds/slave/test', 09:18:08 INFO - 'SHELL': '/bin/bash', 09:18:08 INFO - 'SHLVL': '1', 09:18:08 INFO - 'TERM': 'linux', 09:18:08 INFO - 'TMOUT': '86400', 09:18:08 INFO - 'USER': 'cltbld', 09:18:08 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1480179242.764757-1433683382', 09:18:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:18:08 INFO - '_': '/tools/buildbot/bin/python'} 09:18:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:18:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:18:08 INFO - Running setup.py (path:/tmp/pip-UIKRSB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:18:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:18:08 INFO - Running setup.py (path:/tmp/pip-t9FlHd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:18:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:18:08 INFO - Running setup.py (path:/tmp/pip-8OiCdG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:18:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:18:08 INFO - Running setup.py (path:/tmp/pip-7x9rsJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:18:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:18:08 INFO - Running setup.py (path:/tmp/pip-b7AHJ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:18:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:18:08 INFO - Running setup.py (path:/tmp/pip-c9GGFO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:18:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:18:08 INFO - Running setup.py (path:/tmp/pip-TR6FDt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:18:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:18:08 INFO - Running setup.py (path:/tmp/pip-aqMkcE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:18:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:18:08 INFO - Running setup.py (path:/tmp/pip-sXYsbV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:18:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:18:09 INFO - Running setup.py (path:/tmp/pip-S8QraR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:18:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:18:09 INFO - Running setup.py (path:/tmp/pip-GzoOUQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:18:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:18:09 INFO - Running setup.py (path:/tmp/pip-r8yREF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:18:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:18:09 INFO - Running setup.py (path:/tmp/pip-mYNzUM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:18:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:18:09 INFO - Running setup.py (path:/tmp/pip-mVvWEJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:18:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:18:09 INFO - Running setup.py (path:/tmp/pip-4o1lHN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:18:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:18:09 INFO - Running setup.py (path:/tmp/pip-nScKem-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:18:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:18:09 INFO - Running setup.py (path:/tmp/pip-NBb5PO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:18:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:18:09 INFO - Running setup.py install for manifestparser 09:18:09 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:18:09 INFO - Running setup.py install for mozcrash 09:18:09 INFO - Running setup.py install for mozdebug 09:18:09 INFO - Running setup.py install for mozdevice 09:18:09 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:18:09 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:18:10 INFO - Running setup.py install for mozfile 09:18:10 INFO - Running setup.py install for mozhttpd 09:18:10 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:18:10 INFO - Running setup.py install for mozinfo 09:18:10 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:18:10 INFO - Running setup.py install for mozInstall 09:18:10 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:18:10 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:18:10 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:18:10 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:18:10 INFO - Running setup.py install for mozleak 09:18:10 INFO - Running setup.py install for mozlog 09:18:10 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:18:10 INFO - Running setup.py install for moznetwork 09:18:10 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:18:10 INFO - Running setup.py install for mozprocess 09:18:10 INFO - Running setup.py install for mozprofile 09:18:10 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:18:10 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:18:10 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:18:10 INFO - Running setup.py install for mozrunner 09:18:11 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:18:11 INFO - Running setup.py install for mozscreenshot 09:18:11 INFO - Running setup.py install for moztest 09:18:11 INFO - Running setup.py install for mozversion 09:18:11 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:18:11 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:18:11 INFO - Cleaning up... 09:18:11 INFO - Return code: 0 09:18:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:18:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:18:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:18:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:18:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:18:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18:11 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 0x7ffd3b01cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27bb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2888ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2885f60>, '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 0x2886d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28871d0>, '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': '3a3620fb28aea1604ab609ef000001d2-1480179242.764757-1433683382', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:18:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:18:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:18:11 INFO - Using env: {'DISPLAY': ':0', 09:18:11 INFO - 'HOME': '/home/cltbld', 09:18:11 INFO - 'LANG': 'en_US.UTF-8', 09:18:11 INFO - 'LANGUAGE': 'en_US:en', 09:18:11 INFO - 'LOGNAME': 'cltbld', 09:18:11 INFO - 'MAIL': '/var/mail/cltbld', 09:18:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:18:11 INFO - 'MOZ_NO_REMOTE': '1', 09:18:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:18:11 INFO - 'NO_EM_RESTART': '1', 09:18:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:18:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:18:11 INFO - 'PWD': '/builds/slave/test', 09:18:11 INFO - 'SHELL': '/bin/bash', 09:18:11 INFO - 'SHLVL': '1', 09:18:11 INFO - 'TERM': 'linux', 09:18:11 INFO - 'TMOUT': '86400', 09:18:11 INFO - 'USER': 'cltbld', 09:18:11 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1480179242.764757-1433683382', 09:18:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:18:11 INFO - '_': '/tools/buildbot/bin/python'} 09:18:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:18:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:18:11 INFO - Running setup.py (path:/tmp/pip-JAOCfs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:18:11 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 09:18:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:18:11 INFO - Running setup.py (path:/tmp/pip-3SccFI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:18:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:18:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:18:11 INFO - Running setup.py (path:/tmp/pip-CEJ_lX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:18:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:18:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:18:11 INFO - Running setup.py (path:/tmp/pip-KRf_Wt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:18:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:18:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:18:11 INFO - Running setup.py (path:/tmp/pip-eraHB_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:18:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 09:18:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:18:11 INFO - Running setup.py (path:/tmp/pip-POFJU6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:18:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 09:18:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:18:12 INFO - Running setup.py (path:/tmp/pip-JxB3zG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:18:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 09:18:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:18:12 INFO - Running setup.py (path:/tmp/pip-lPtizJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:18:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 09:18:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:18:12 INFO - Running setup.py (path:/tmp/pip-Z4BWnN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:18:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 09:18:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:18:12 INFO - Running setup.py (path:/tmp/pip-eESN2K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:18:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:18:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:18:12 INFO - Running setup.py (path:/tmp/pip-UuqqO5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:18:12 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 09:18:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:18:12 INFO - Running setup.py (path:/tmp/pip-yqHZs9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:18:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 09:18:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:18:12 INFO - Running setup.py (path:/tmp/pip-BWW8f7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:18:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 09:18:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:18:12 INFO - Running setup.py (path:/tmp/pip-ES2A7V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:18:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 09:18:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:18:12 INFO - Running setup.py (path:/tmp/pip-Max4bw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:18:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 09:18:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:18:12 INFO - Running setup.py (path:/tmp/pip-Qdq7pY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:18:12 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 09:18:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:18:12 INFO - Running setup.py (path:/tmp/pip-5bBuj2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:18:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 09:18:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:18:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:18:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:18:12 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:18:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:18:12 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:18:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:18:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:18:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:18:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:18:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:18:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:18:14 INFO - Downloading blessings-1.6.tar.gz 09:18:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:18:14 INFO - Installing collected packages: blessings 09:18:14 INFO - Running setup.py install for blessings 09:18:14 INFO - Successfully installed blessings 09:18:14 INFO - Cleaning up... 09:18:15 INFO - Return code: 0 09:18:15 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:18:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:18:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:18:15 INFO - Reading from file tmpfile_stdout 09:18:15 INFO - Current package versions: 09:18:15 INFO - argparse == 1.2.1 09:18:15 INFO - blessings == 1.6 09:18:15 INFO - blobuploader == 1.2.4 09:18:15 INFO - docopt == 0.6.1 09:18:15 INFO - functools32 == 3.2.3-2 09:18:15 INFO - jsonschema == 2.5.1 09:18:15 INFO - manifestparser == 1.1 09:18:15 INFO - mozInstall == 1.12 09:18:15 INFO - mozcrash == 1.0 09:18:15 INFO - mozdebug == 0.1 09:18:15 INFO - mozdevice == 0.48 09:18:15 INFO - mozfile == 1.2 09:18:15 INFO - mozhttpd == 0.7 09:18:15 INFO - mozinfo == 0.9 09:18:15 INFO - mozleak == 0.1 09:18:15 INFO - mozlog == 3.4 09:18:15 INFO - moznetwork == 0.27 09:18:15 INFO - mozprocess == 0.23 09:18:15 INFO - mozprofile == 0.28 09:18:15 INFO - mozrunner == 6.13 09:18:15 INFO - mozscreenshot == 0.1 09:18:15 INFO - mozsystemmonitor == 0.3 09:18:15 INFO - moztest == 0.7 09:18:15 INFO - mozversion == 1.4 09:18:15 INFO - psutil == 3.1.1 09:18:15 INFO - requests == 1.2.3 09:18:15 INFO - wsgiref == 0.1.2 09:18:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:18:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:18:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:18:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:18:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:18:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18:15 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 0x7ffd3b01cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27bb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2888ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2885f60>, '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 0x2886d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28871d0>, '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': '3a3620fb28aea1604ab609ef000001d2-1480179242.764757-1433683382', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:18:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 09:18:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:18:15 INFO - Using env: {'DISPLAY': ':0', 09:18:15 INFO - 'HOME': '/home/cltbld', 09:18:15 INFO - 'LANG': 'en_US.UTF-8', 09:18:15 INFO - 'LANGUAGE': 'en_US:en', 09:18:15 INFO - 'LOGNAME': 'cltbld', 09:18:15 INFO - 'MAIL': '/var/mail/cltbld', 09:18:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:18:15 INFO - 'MOZ_NO_REMOTE': '1', 09:18:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:18:15 INFO - 'NO_EM_RESTART': '1', 09:18:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:18:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:18:15 INFO - 'PWD': '/builds/slave/test', 09:18:15 INFO - 'SHELL': '/bin/bash', 09:18:15 INFO - 'SHLVL': '1', 09:18:15 INFO - 'TERM': 'linux', 09:18:15 INFO - 'TMOUT': '86400', 09:18:15 INFO - 'USER': 'cltbld', 09:18:15 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1480179242.764757-1433683382', 09:18:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:18:15 INFO - '_': '/tools/buildbot/bin/python'} 09:18:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:18:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:18:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 09:18:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 09:18:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:18:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 09:18:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 09:18:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 09:18:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 09:18:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 09:18:15 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:18:15 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:18:15 INFO - Cleaning up... 09:18:15 INFO - Return code: 0 09:18:15 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:18:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:18:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:18:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:18:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:18:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffd3b01cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27bb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2888ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2885f60>, '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 0x2886d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28871d0>, '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': '3a3620fb28aea1604ab609ef000001d2-1480179242.764757-1433683382', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:18:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:18:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:18:15 INFO - Using env: {'DISPLAY': ':0', 09:18:15 INFO - 'HOME': '/home/cltbld', 09:18:15 INFO - 'LANG': 'en_US.UTF-8', 09:18:15 INFO - 'LANGUAGE': 'en_US:en', 09:18:15 INFO - 'LOGNAME': 'cltbld', 09:18:15 INFO - 'MAIL': '/var/mail/cltbld', 09:18:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:18:15 INFO - 'MOZ_NO_REMOTE': '1', 09:18:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:18:15 INFO - 'NO_EM_RESTART': '1', 09:18:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:18:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:18:15 INFO - 'PWD': '/builds/slave/test', 09:18:15 INFO - 'SHELL': '/bin/bash', 09:18:15 INFO - 'SHLVL': '1', 09:18:15 INFO - 'TERM': 'linux', 09:18:15 INFO - 'TMOUT': '86400', 09:18:15 INFO - 'USER': 'cltbld', 09:18:15 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1480179242.764757-1433683382', 09:18:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:18:15 INFO - '_': '/tools/buildbot/bin/python'} 09:18:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:18:15 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:18:15 INFO - Cleaning up... 09:18:15 INFO - Return code: 0 09:18:15 INFO - Running post-action listener: _resource_record_post_action 09:18:15 INFO - Running post-action listener: _start_resource_monitoring 09:18:15 INFO - Starting resource monitoring. 09:18:15 INFO - [mozharness: 2016-11-26 17:18:15.766996Z] Finished create-virtualenv step (success) 09:18:15 INFO - [mozharness: 2016-11-26 17:18:15.767499Z] Running install step. 09:18:15 INFO - Running pre-action listener: _resource_record_pre_action 09:18:15 INFO - Running main action method: install 09:18:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:18:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:18:15 INFO - Reading from file tmpfile_stdout 09:18:15 INFO - Detecting whether we're running mozinstall >=1.0... 09:18:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:18:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:18:16 INFO - Reading from file tmpfile_stdout 09:18:16 INFO - Output received: 09:18:16 INFO - Usage: mozinstall [options] installer 09:18:16 INFO - Options: 09:18:16 INFO - -h, --help show this help message and exit 09:18:16 INFO - -d DEST, --destination=DEST 09:18:16 INFO - Directory to install application into. [default: 09:18:16 INFO - "/builds/slave/test"] 09:18:16 INFO - --app=APP Application being installed. [default: firefox] 09:18:16 INFO - mkdir: /builds/slave/test/build/application 09:18:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 09:18:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 09:18:32 INFO - Reading from file tmpfile_stdout 09:18:32 INFO - Output received: 09:18:32 INFO - /builds/slave/test/build/application/firefox/firefox 09:18:32 INFO - Running post-action listener: _resource_record_post_action 09:18:32 INFO - [mozharness: 2016-11-26 17:18:32.674456Z] Finished install step (success) 09:18:32 INFO - [mozharness: 2016-11-26 17:18:32.674698Z] Running run-tests step. 09:18:32 INFO - Running pre-action listener: _resource_record_pre_action 09:18:32 INFO - Running main action method: run_tests 09:18:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:18:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:18:32 INFO - Python 2.7.3 09:18:32 INFO - Return code: 0 09:18:32 INFO - grabbing minidump binary from tooltool 09:18:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:18:32 INFO - 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 0x2885f60>, '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 0x2886d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28871d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:18:32 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 09:18:32 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 09:18:32 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 09:18:32 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:18:32 INFO - Return code: 0 09:18:32 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:18:32 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:18:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:18:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:18:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:18:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TNeSr781SQuei-4aJv5Dfw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-059', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 09:18:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/TNeSr781SQuei-4aJv5Dfw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-059 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 09:18:32 INFO - Using env: {'DISPLAY': ':0', 09:18:32 INFO - 'HOME': '/home/cltbld', 09:18:32 INFO - 'LANG': 'en_US.UTF-8', 09:18:32 INFO - 'LANGUAGE': 'en_US:en', 09:18:32 INFO - 'LOGNAME': 'cltbld', 09:18:32 INFO - 'MAIL': '/var/mail/cltbld', 09:18:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:18:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:18:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:18:32 INFO - 'MOZ_NO_REMOTE': '1', 09:18:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:18:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:18:32 INFO - 'NO_EM_RESTART': '1', 09:18:32 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:18:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:18:32 INFO - 'PWD': '/builds/slave/test', 09:18:32 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:18:32 INFO - 'SHELL': '/bin/bash', 09:18:32 INFO - 'SHLVL': '1', 09:18:32 INFO - 'TERM': 'linux', 09:18:32 INFO - 'TMOUT': '86400', 09:18:32 INFO - 'USER': 'cltbld', 09:18:32 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1480179242.764757-1433683382', 09:18:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:18:32 INFO - '_': '/tools/buildbot/bin/python'} 09:18:32 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TNeSr781SQuei-4aJv5Dfw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-059', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 09:18:32 INFO - mozversion application_buildid: 20161126062719 09:18:32 INFO - mozversion application_changeset: fe8d7e54713a87a4a356a77ff35b0830a8567e76 09:18:32 INFO - mozversion application_display_name: FirefoxDeveloperEdition 09:18:32 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:18:32 INFO - mozversion application_name: Firefox 09:18:32 INFO - mozversion application_remotingname: firefox-dev 09:18:32 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:18:32 INFO - mozversion application_vendor: Mozilla 09:18:32 INFO - mozversion application_version: 52.0a2 09:18:32 INFO - mozversion platform_buildid: 20161126062719 09:18:32 INFO - mozversion platform_changeset: fe8d7e54713a87a4a356a77ff35b0830a8567e76 09:18:32 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:18:32 INFO - mozversion platform_version: 52.0a2 09:18:32 INFO - using testdate: 1480180712 09:18:32 INFO - actual date: 1480180712 09:18:32 INFO - starting webserver on 'localhost:38217' 09:18:32 INFO - SUITE-START | Running 2 tests 09:18:32 INFO - TEST-START | dromaeo_css 09:18:32 INFO - operating with platform_type : linux_ 09:18:32 INFO - Initialising browser for dromaeo_css test... 09:18:32 INFO - TEST-INFO | started process 25243 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOnvj74/profile http://localhost:38217/getInfo.html) 09:18:36 INFO - PROCESS | 25243 | __metrics Screen width/height:1600/1200 09:18:36 INFO - PROCESS | 25243 | colorDepth:24 09:18:36 INFO - PROCESS | 25243 | Browser inner width/height: 1024/697 09:18:36 INFO - PROCESS | 25243 | __metrics 09:18:37 INFO - PROCESS | 25243 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:18:37 INFO - PROCESS | 25243 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:18:37 INFO - PROCESS | 25243 | console.error: PushService: 09:18:37 INFO - PROCESS | 25243 | stateChangeProcessEnqueue: Error transitioning state 09:18:37 INFO - PROCESS | 25243 | UnknownError 09:18:38 INFO - TEST-INFO | 25243: exit 0 09:18:38 INFO - Browser initialized. 09:18:38 INFO - Running cycle 1/1 for dromaeo_css test... 09:18:38 INFO - TEST-INFO | started process 25337 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOnvj74/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:18:50 INFO - PROCESS | 25337 | RSS: Main: 144924672 09:18:50 INFO - PROCESS | 25337 | 09:19:41 INFO - PROCESS | 25337 | 1480180781312 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 09:21:51 INFO - PROCESS | 25337 | Cycle 1(1): loaded http://localhost:38217/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38217/tests/dromaeo/cssquery-ext.html) 09:21:52 INFO - PROCESS | 25337 | RSS: Main: 233041920 09:21:52 INFO - PROCESS | 25337 | 09:24:54 INFO - PROCESS | 25337 | Cycle 1(1): loaded http://localhost:38217/tests/dromaeo/cssquery-ext.html (next: http://localhost:38217/tests/dromaeo/cssquery-jquery.html) 09:24:55 INFO - PROCESS | 25337 | RSS: Main: 225083392 09:24:55 INFO - PROCESS | 25337 | 09:27:57 INFO - PROCESS | 25337 | Cycle 1(1): loaded http://localhost:38217/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38217/tests/dromaeo/cssquery-mootools.html) 09:27:58 INFO - PROCESS | 25337 | RSS: Main: 202121216 09:27:58 INFO - PROCESS | 25337 | 09:31:00 INFO - PROCESS | 25337 | Cycle 1(1): loaded http://localhost:38217/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38217/tests/dromaeo/cssquery-prototype.html) 09:31:00 INFO - PROCESS | 25337 | RSS: Main: 216375296 09:31:00 INFO - PROCESS | 25337 | 09:34:03 INFO - PROCESS | 25337 | Cycle 1(1): loaded http://localhost:38217/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38217/tests/dromaeo/cssquery-yui.html) 09:34:03 INFO - PROCESS | 25337 | RSS: Main: 174411776 09:34:03 INFO - PROCESS | 25337 | 09:37:06 INFO - PROCESS | 25337 | Cycle 1(1): loaded http://localhost:38217/tests/dromaeo/cssquery-yui.html (next: http://localhost:38217/tests/dromaeo/cssquery-dojo.html) 09:37:06 INFO - PROCESS | 25337 | RSS: Main: 265814016 09:37:06 INFO - PROCESS | 25337 | 09:37:06 INFO - PROCESS | 25337 | __start_tp_report 09:37:06 INFO - PROCESS | 25337 | _x_x_mozilla_page_load 09:37:06 INFO - PROCESS | 25337 | _x_x_mozilla_page_load_details 09:37:06 INFO - PROCESS | 25337 | |i|pagename|runs| 09:37:06 INFO - PROCESS | 25337 | |0;dojo.html;3061.969380306197;3197.5523426720256;3209.6469388367277;3222.081706713587;3251.561039259699;5474.452554744524;5532;5544.722763861801;5549.112142057266;5576.944230557693;5489.972550137244;5537.972310138453;5546.944530554693;5565.972170139154;5571.554275657948;5009.073321435528;5024.196128619404;5053.51991560803;5067.543921047105;5111.642185047048;4987.451380348159;4990.700557966534;4996.7001979881325;5064.6961182329;5112.821051263207;5018.673786203885;5107.182850743881;5124.538791508763;5128.769205385748;5141.0489059523925;5127.641065125443;5129;5138.820141295074;5142.228665700156;5173.948260517422;4908.754562271908;4909.239067944474;5033.169527028036;5037.924431133536;5084.949150508484;5387.057264978652;5403.945960540384;5432.402435732066;5453.100238460649;5456.563474921997;5819.854503637401;5839.503642190419;5869.383714709937;5878.970605146989;5897.557683173779;5726.713664316768;5947.821565353003;5960.165576819206;5968.462838344526;5973.551983601247;5411.18832175173;5435.42927992563;5488.725563721838;5490.780368785284;5530.944690553043;5964.7315870785915;5966.164736936832;5978.4021597839865;5981.162637230791;6018.638881667026;5640.125780504029;5796.043652797325;5797.246357973437;5803.187553742479;5808.854778630483;5755.309362876482;5845.473907348359;5885.176075349455;5898.2332296802;5992.0712289595185;5877.177195192677;5912.940870591325;5924.11138329254;5930.406959304121;5932.881342373128;5936.762529498858;5941.524678025748;5946.137810017523;5947.881042379215;5981.252343457068;4455.398521199661;4473.329000649864;4478.596926276586;4493.865184044418;4507.391502147234;4062.5937406259136;4072.8778136655947;4075.89810254746;4076.898077548026;4086.9795651021554;5547.55619550443;5551.528120109755;5552.000639884859;5554.472325129106;5558.416366281483;5774.769009239583;5837.29952405714;5864.325602555676;5869.735861886225;5876.44173803488;5486.369067557282;5517.917231241535;5544.750486228129;5568.220449137124;5616.831495055155;5041.294218809369;5097.974510127426;5100.183970564766;5107;5117.053345131163;6068.271807383142;6107.480864126599;6114.388561143939;6115.266168059683;6122.081687746784;5739.397363276963;5753.165790960371;5807.157962095557;5855.2095467113095;5876.118582212703;6155.384461553988;6174.073888916699;6174.25908890936;6178.876422471615;6181.84545386351;5825.679587622722;5833.679147646751;5833.67914764692;5834.03738383162;5873.794417195549;5628.549716022791;5754;5825.50483208932;5909.881802363842;5926.170336152856;5690.971545142248;5772.278465191851;5803.100519419497;5805.042168042226;5823.8835223294445;5744.310682718101;5772.04761214395;5775.364709881994;5777.62445441045;5781.595288329945;5567.192757050124;5570.331560212639;5737.168110624019;5763.452472015152;5768.855778605401;5702.800401985911;5741.569382296428;5781.82654520365;5805.535557155502;5829.358770535323;5610.102383618601;5654.293213348332;5657.547396208376;5660.15097735343;5662.716864156858 09:37:06 INFO - PROCESS | 25337 | |1;ext.html;587.9706014699267;618.1716499890147;653.5653790229497;665.623922483797;679.7994591595478;33356.83321583392;44078.33882491761;44720.77639611797;44865;44943.32585011228;46373;46531.53468465315;46864;46866.531334686646;46913;8339.749807505785;8910.287177025839;9047.050059743731;9078.319126065539;9081.318901082412;8359.038710548273;10630.415327157003;10863.348199108039;10897.945510272437;11208.943955280212;10864.674059778179;10947.069499092586;10950.34297942122;10954.561817527288;10959.397233152173;10823.567057317698;10878.259478483405;10892.128629709605;10897.618583349546;10900.618478353259;10753.516091775811;10845.240833141683;10846.29499082557;10849.240553161282;10854.077403420719;44006;44119.55880441186;44241.115177696585;44331;44402.111957760666;3730.5896351401325;3763.078045878777;3835.5397352317623;3842.7886466244345;3868.516435445569;33311.3337733244;33358.83320583381;33448.975715099856;33966.32067358639;34217.48673769896;4272.29507131326;4310.2672545667;4311.525732169459;4342.283523218665;4343.413639158704;365839;366718;369687;371231;377598.11200944096;62981;63310.20138791687;63417.46330146835;63553;63583;39910.60089399127;40996;41041.38437923433;43065.78467107644;65891.34108658948;17121.14394280281;17295.74056389155;17316.480505584852;17322.133893305283;17324.740128898076;12475.438605262603;12696.873031269753;13042.54351097726;13198.934005329911;13291.268980206181;19988.400347989584;20740.274090406765;20815.8959205203;20823.8958805205;20931;7320.755471569846;7407.85184296311;7415.295546923034;7417.480776345604;7624.941265858187;982.6167794560128;1042.8800687920834;1067.204932325407;1098.1763677242068;1129.9491522881326;33903.32193356168;34069.48895766516;35100;36004.56928502657;37117.44323835144;1122.9494672739747;1140.0879296562716;1152.2049785648044;1162.2910024884814;1162.6802629277017;14770.92614536942;17778.288868445376;18773.34293299728;18814.153363098692;19559.902200489192;516683;520362;521271;522105;522245;61510.69244653748;61948;61960.69019654873;61983;62019.37980620226;1327.9004074694244;1375.7042235919325;1414.7382734194207;1424.7533408267973;1470.3383477435198;30949.535756963214;33964.660353396146;34281.314373712885;34632.13419664528;34850;52579.21131182959;52969;53208.20187697265;53234;53615.463845361046;403310;405596;406092;406188;408188;30363.392732145676;30411.2397190072;31144.688553114178;31382.215444614067;32970;50394.244086339466;50468.74765626148;50633;50852;51784.74107629438;42371.7881410591;43280.78359608182;43684.56315436805;44076.77961610172;44668;42032.57967420287;42153.78923105365;42391.3641295387;43351.566484336014;43892.56107439013;42681.57318426776;43341.34987975246;43488.565114349716;43607.56392436162;43749.78125109354;36209.094772630895;37896.81051594725;38271.617283827916;38700.2259954805;38834.223315534095;28569.42861142807;28764.712352876202;29201.269968250963;29375.41249174962;29454 09:37:06 INFO - PROCESS | 25337 | |2;jquery.html;389.01988876618043;436.32587652077547;439.56043956043953;440.1417236389041;445.41215537725833;16635.916820415896;19443.416697499062;20068.69896951547;20102.994850257484;20283.188672453085;19493.415197544095;19497.707534386995;19512.707309390335;19533;19829.801701982975;5436.2661040759485;5453;5609.242752228458;5702.54379649627;5832.795852145176;5637.210790489335;5734.68459234744;5738.196652468658;5742.138679198112;5742.339630942432;5478.91781623276;5692.715364231772;5704.429557044304;5730.742116604742;5737.053386191274;5692.5161361284345;5735.11105778605;5737.569682273846;5744.281964754406;5748.367679555246;5067.771950262247;5333.226682131108;5381.569474442035;5427.6472029317965;5429.945700542983;14188.787168192486;14263.001589888712;14303.785443218256;14417.85582144186;14437.566872993722;2379.702537182852;2460.667809845666;2478.628205769131;2521.722610512842;2936.6769655337894;9691.951540242253;10061;10340.741481463023;10815.080718138968;12882.420291086924;1876.333901464974;1921.932732354361;2000;2028.4523178741804;2032.2379107834563;84525;86599;89134.5543272286;90638;93156.53421732916;9541.570629321697;9736.902630973742;9975.900240997642;10052.145567626687;11623.476943537562;14357.712845743026;14394.568162955127;14406.927965360106;14440.061396009225;14446.349914253884;7951;8039.638216280281;8046;8111.82378555118;8114.715984940499;8021.7994550135545;8107.473014254055;8242.876356854653;8270.338372930271;8291.046529649047;4344.261475549164;4393;4396.406485124531;4431.180231657154;4552.066826300666;2063.31627206244;2085.3496702353837;2092.4141240452695;2101.894905254762;2179.6512557990645;1000.6597756762735;1014.2443879309961;1025.646152077532;1052.2791887556896;1069.7379142110233;18704.625907481775;20540.383788486368;20608.21756663125;20726.58546829055;20815.271465498634;1006.3207335048959;1018.8675472188717;1046.8639076920103;1067;1068.4123731947398;10600.522976466078;11564.595239166758;11647.12646551512;11652.475638596283;11676;461107;485935;511603;523603;526613;96013;97036;98062;101199;102308;986.3539381704994;1016.5679586175846;1068.7915856407926;1094.6168840905777;1099.274478843959;17420.30318787285;17628.206730697406;17829.821701782817;18106.09469526492;18200.908995454938;45139.097218056115;45253;46242.30636540387;46375.53624463712;46616.7669161652;61402;62049;62470;62821;63929.6803515998;8492.363072769444;8746.256568191775;8768.167024132697;8776.561171941505;9358.766030849283;12844.743105137659;13769.242691651654;13892.16647001183;14140.50508232207;14261.358238879482;12079.51681932713;12249.326287053942;12276.508939642314;12392.256464612152;12596.685082873002;11962.820557691815;12214.022878169548;12445;12447.875521245034;12719.364031798557;11801.645950621494;12143.089268304735;12297.938510307391;12335.259884406963;12459.314737689514;8677.088905664814;8716.564171791511;8887.289016878505;8919.55402229873;9293.442393456415;7680.078390593165;11966.940165299118;12263.632091037283;12459.314737689152;12493.25040497573 09:37:06 INFO - PROCESS | 25337 | |3;mootools.html;1324.2054767139723;1451.470213372119;1483.1768368555452;1611.3232442374208;1758.7098128808748;7166.641667916603;7690.846183076335;7983.600819958993;8033.477823941447;8170.877436838452;8035.799105022377;8086.878696819553;8089;8147.348212143014;8167.264946154844;2383.618621020637;2410.758924107593;2414.0947144820693;2415.8912848921755;2417.033186725306;2368.2539999900064;2415.3720032791425;2418.5646583614944;2428.7449817769143;2429.4047958250167;2384.1655420602824;2386.2960426674085;2407.2176542623715;2424.5029768897334;2424.781769640732;2283.862968221904;2284.5088306014122;2288.6338185890263;2293.3005433342823;2364.385259832456;2265.127925748582;2268.6823844661762;2297.184499502669;2300.1029598456616;2303.527776805751;7860.253275938777;7871.291583757489;7947.761567152995;8053.677852885878;8074.798130046737;4930.3344048553345;5120.871978200537;5123.129068058439;5129.794808207667;5132.5893928486;3348.8995330140133;3406.2165701888703;3458;3503.9824800876086;3538.752287339887;1108.5344155454648;1133.7902488039656;1156.7802117597714;1195.4978908858213;1218.5308656167351;10722.14222862177;10794.082502987256;10801.945990270155;10820.891791082067;10839.891601083968;4161.8959526012095;4378.715383500063;4425.181341451842;4443.800028998703;4481.708688935209;9116.544172791333;9137.862932056025;9145.542722863964;9146.222571081533;9157;5121.61587880903;5133.153029750124;5136.30659860914;5137.12668846297;5141.897162056738;4213.157368526246;4337.956620433818;4625.930611040837;4728.503507131771;4780.211265141213;3771.07608635886;3771.4342848572387;3819.5416550014174;3863.7102217333813;3872.4384964180035;1196.300164403816;1198.9100817438728;1203.278033180085;1208.5407545132794;1210.915235933494;973.8052389522123;992.8262554053011;1011.858339832424;1014.4927536231884;1015.5430056474469;5501;5568.136938774496;5587.3015873015875;5747.798827041033;5829.446202610745;965.8020105878278;970.6457143142843;970.8058388322364;976.472704739447;1014.8985101489792;3773.188764415609;3893.7032914612614;3979.323515002399;3981.8009099544906;3988.860389886398;9428.528573571431;9794.608215671436;9977.850332245021;9995.550200241007;10012.098911098035;9655.179309758749;9862.161716254199;9865.06281903218;9866.408015519091;9878.407295562145;7605.23947605235;7846.803829904184;7860.803479912934;7866.331361834308;7870.331021863206;5470.452954704498;5586.692731899784;5602.607817452739;5639.295088113986;5697.088465845445;9063.728088157366;9090.909090909006;9098.545072746469;9199.724008279762;9250.537473126451;9102.36283460178;9106.408083474553;9247.352685311964;9421.481818500048;9484.146426821619;6477.935220647733;6668.233153187251;6893.241743408121;7051.964740176266;7212.8918066228;7925.445218834857;8186.3860210485645;8192.631331590212;8200.384971127309;8202.343812495106;7254.202037775946;7336.7432139874845;7439.739609113655;7480.3641690456925;7577.621118944141;7171.892421613576;7212.278772122746;7243.311885370881;7405.296496832792;7463.17905030457;6614.536982411185;6724.630145341857;6776.220734615582;6781.6270105144695;6785.457163426815;4931.235658472942;5051.479731410097;5088.465711100429;5127.66670166438;5154.716490592903;5029.4719054498755;5048.3941926969;5098.745062746922;5160.974195129151;5210.687358758487 09:37:06 INFO - PROCESS | 25337 | |4;prototype.html;345.7787016309562;350.680880398837;355.62836835506886;357.1499830403639;361.17291402687846;5384.9230153969265;5401.756920938557;5432.2123292122615;5440.455954404558;5445.264889239951;5059.494050594939;5165.251038599401;5196;5264.92102618461;5332.866678333044;4140.6273435390885;4174.874753757392;4181;4196.958030419687;4224.387463817745;4202.97898510507;4222.472190976128;4225.7887105644595;4230.809613567397;4253.106847562016;4107.240160570289;4161.3549899765585;4175.060611362434;4200.97899510502;4209.410682504452;4171.353440216772;4179.861936682692;4195.62239398454;4196.181744559812;4197.769122698235;3719.367707489733;3723.0320116769562;3729.347364211252;3731.7014638828828;3751.681107105899;4995.550400463976;5175.767090480937;5192.273081768555;5221.895562088775;5250.553702935255;4778.737169455679;4788.474891227791;4790.856274311776;4807.759612019385;4823.734694591796;5541.501264886139;5542.501174894239;5568.805091821807;5571.721413929287;5572.832815015556;3848.5766565677754;4046.3525835866412;4110.219058378928;4117.794110294473;4133.503979522447;5710.77156913723;5748.655080695172;5759.625624334447;5761.654300741969;5767.740451679642;4133.8966525837095;4137.275976704064;4138.482689663792;4142.71001029925;4153.480814898137;4154.480689913761;4160.625543701081;4219.620234178878;4250.617444429954;4251.829926802955;4729.385179926657;4741.478437371887;4752.976235118802;4774.880627984258;4777.904441911142;5567.387587365387;5576.358718747315;5587.552995760329;5594.440555944454;5596.160575913564;1395.8325000999946;1403.6841710615233;1407.9648008799861;1409.7039621679357;1411.2943528235883;1007.7833265847878;1009.2228983682523;1035.1873779083535;1036.512838965685;1046.2937517175876;5251.2123181523075;5252.474752524793;5268.552173065255;5270.288511051036;5275.182346736262;5488.643238189505;5494.230807686847;5503.734141147558;5526.696031718214;5534.972325138348;5087.491250874883;5223.216517522402;5246.291750613618;5273.551748101454;5275.340582427197;2899.5505696617056;2903.3032072302494;2912.461194678991;2919.5110493647967;2923.8830446782317;5711.858053230038;5721.656700597978;5724.942750572524;5726.656400615893;5734.197212390269;5334.51989320963;5531.25328080712;5560.443955604488;5563;5575.219469274305;5677.716114194356;5682.374938756733;5698.629589076697;5701.7434215461235;5701.771929122871;5226.712530810842;5401.567874569946;5419.4309597493275;5481.780728770805;5509.807156749494;5413.53984911287;5432.9185062223305;5445.128779395278;5498.367687715964;5500.614956953135;5617.943820561905;5690.9430905690415;5692.203091567101;5720.799772007959;5728.598998070095;3970.563238043755;4129.174165166918;4149.543550209414;4154.273002224659;4184.7070705050355;5378.892422151614;5480.835574932758;5557.666540007613;5603.411641777718;5718.485336319751;5578.553715702815;5584.525315348078;5585.972070139624;5588.776448941997;5617.466340697627;5345.358556973188;5533;5579.944200558105;5586.245856809279;5587.916181257203;5547.362053363915;5563.221149039218;5572.247746554325;5573.944260557342;5581.9162712560155;5634.830955071355;5643.363424606982;5649.7740090397565;5652.095664693629;5655.095184770417;5260.237265596391;5508.476694713996;5512.586556008396;5533.474319939599;5548.171761484563 09:37:06 INFO - PROCESS | 25337 | |5;yui.html;771.0939645916047;778.7352300217925;829.925306722395;849.2484151525899;896.5114012862989;14660.340284687189;14967.850321496782;14998.250087495637;15160.620984475394;15174;14868.47960321389;15066.472673456405;15086.170260635661;15513.612159696013;15874.206289685528;853.6457370191363;874.0167311774254;874.2350443362059;874.4796845876725;876.071364353787;728.10806761717;749.108560812634;833.791552111972;856;863.2058506174335;910.2626872233479;911.7811725185974;912.561970254275;912.885889263842;912.9452232866049;761.5697131120899;898.7932775461647;906.0169715858269;906.1799071839929;908.0601577367426;572.2560671127518;643.6492111799081;661.1240106858431;666.1539844397636;666.3203532396928;15618.297176627078;15619.140947247897;15648.374065037386;15667.686646267011;15667.843321566752;14037.438502459889;14330.283485825667;14431.855681443156;14543.854561454356;14569.198694071822;13267.867321326856;13385.397657105355;13412.865871341259;13622.455101795917;14111.78832317516;4528.660350473728;4536.590677370518;4537.636989040901;4548.135854187727;4600.884977875547;48156.5184348159;48331.75834120842;48462.5153748465;48467.03065938661;48513.757431212616;10843.985692793567;11161.83257251142;11309.434528273554;11338.773224535464;11597.420128993685;19038.33365832189;19509.609807803765;19533;20685.069171887302;20687.27594534184;8826.514541700268;8858.73423797287;8889.644414223489;8917.55412229386;9138.908610913939;4581.931271030937;4885.877853053702;4901.730404827768;4961.03259864323;5022.4977502249485;3577.606463289036;3644.526211592476;3650.1969566695284;3685.7972811495624;3698.9630103699155;629.2386212682705;634.8381162803455;636.8121404185777;642.8039447968321;646.2116218213772;738.4572339330695;747.0848210941554;761.77146855943;766.7431410477441;810.9026916770025;9464.148226659496;10016.449095299682;10196.898031019744;10201.132903703268;10205.285630005828;757.6401209425479;773.3697036914897;779.6998155710093;785.658238666182;813.4753084260738;4503.7973291201315;4689.859304220879;4793.904121917542;4922.556969872729;4926.359573255526;87817.56091219503;88316.55841720878;92763.53618231865;93760.53119734494;100287;78356.60821695969;80392;84120;85813.14186858176;89168.10831891728;55172;72749;73473.6326318365;74982.62508687531;76734;9325.906740932503;9374.203192728695;9376.109269619375;9377.859332109887;9415.81168376615;51217.7439112802;51275.743621281654;51783;52371;54354;65330.346696532426;68565.77232618115;69478;70476.64761676159;72236.63881680768;11433.828492572451;11993.580224692094;12036.939815300868;12200;12206.084543659084;13608.183508989492;14001.789973150615;14015.159090454605;14131.505397311044;14798.334074966437;11695.941520292345;11870.584529541424;12526.311052892179;12650.810237846255;13043;13631.25028123423;13695.58166803866;13757.210434921602;13890.166590004632;14544.272786360429;12730.490780368682;13089.345532723135;13160.80258796138;14109.647258818612;14149.929250353682;10181.694549163536;11085.22403431752;11329.212593326896;11421.714457138305;11463.369514676438;11250.718732031764;11454.709444659273;11499.367534785668;11505.94247028793;11626.53493860236 09:37:06 INFO - PROCESS | 25337 | __end_tp_report 09:37:06 INFO - PROCESS | 25337 | __start_cc_report 09:37:06 INFO - PROCESS | 25337 | _x_x_mozilla_cycle_collect,1261 09:37:06 INFO - PROCESS | 25337 | __end_cc_report 09:37:06 INFO - PROCESS | 25337 | __startTimestamp1480181826748__endTimestamp 09:37:06 INFO - PROCESS | 25337 | 09:37:06 INFO - PROCESS | 25337 | ------- Summary: start ------- 09:37:06 INFO - PROCESS | 25337 | Number of tests: 6 09:37:06 INFO - PROCESS | 25337 | 09:37:06 INFO - PROCESS | 25337 | [#0] dojo.html Cycles:165 Average:5476.88 Median:5660.15 stddev:611.23 (10.8%) stddev-sans-first:583.01 09:37:06 INFO - PROCESS | 25337 | Values: 3062.0 3197.6 3209.6 3222.1 3251.6 5474.5 5532.0 5544.7 5549.1 5576.9 5490.0 5538.0 5546.9 5566.0 5571.6 5009.1 5024.2 5053.5 5067.5 5111.6 4987.5 4990.7 4996.7 5064.7 5112.8 5018.7 5107.2 5124.5 5128.8 5141.0 5127.6 5129.0 5138.8 5142.2 5173.9 4908.8 4909.2 5033.2 5037.9 5084.9 5387.1 5403.9 5432.4 5453.1 5456.6 5819.9 5839.5 5869.4 5879.0 5897.6 5726.7 5947.8 5960.2 5968.5 5973.6 5411.2 5435.4 5488.7 5490.8 5530.9 5964.7 5966.2 5978.4 5981.2 6018.6 5640.1 5796.0 5797.2 5803.2 5808.9 5755.3 5845.5 5885.2 5898.2 5992.1 5877.2 5912.9 5924.1 5930.4 5932.9 5936.8 5941.5 5946.1 5947.9 5981.3 4455.4 4473.3 4478.6 4493.9 4507.4 4062.6 4072.9 4075.9 4076.9 4087.0 5547.6 5551.5 5552.0 5554.5 5558.4 5774.8 5837.3 5864.3 5869.7 5876.4 5486.4 5517.9 5544.8 5568.2 5616.8 5041.3 5098.0 5100.2 5107.0 5117.1 6068.3 6107.5 6114.4 6115.3 6122.1 5739.4 5753.2 5807.2 5855.2 5876.1 6155.4 6174.1 6174.3 6178.9 6181.8 5825.7 5833.7 5833.7 5834.0 5873.8 5628.5 5754.0 5825.5 5909.9 5926.2 5691.0 5772.3 5803.1 5805.0 5823.9 5744.3 5772.0 5775.4 5777.6 5781.6 5567.2 5570.3 5737.2 5763.5 5768.9 5702.8 5741.6 5781.8 5805.5 5829.4 5610.1 5654.3 5657.5 5660.2 5662.7 09:37:06 INFO - PROCESS | 25337 | 09:37:06 INFO - PROCESS | 25337 | [#1] ext.html Cycles:180 Average:60460.74 Median:3855.65 stddev:115413.03 (2993.3%) stddev-sans-first:115649.25 09:37:06 INFO - PROCESS | 25337 | Values: 588.0 618.2 653.6 665.6 679.8 33356.8 44078.3 44720.8 44865.0 44943.3 46373.0 46531.5 46864.0 46866.5 46913.0 8339.7 8910.3 9047.1 9078.3 9081.3 8359.0 10630.4 10863.3 10897.9 11208.9 10864.7 10947.1 10950.3 10954.6 10959.4 10823.6 10878.3 10892.1 10897.6 10900.6 10753.5 10845.2 10846.3 10849.2 10854.1 44006.0 44119.6 44241.1 44331.0 44402.1 3730.6 3763.1 3835.5 3842.8 3868.5 33311.3 33358.8 33449.0 33966.3 34217.5 4272.3 4310.3 4311.5 4342.3 4343.4 365839.0 366718.0 369687.0 371231.0 377598.1 62981.0 63310.2 63417.5 63553.0 63583.0 39910.6 40996.0 41041.4 43065.8 65891.3 17121.1 17295.7 17316.5 17322.1 17324.7 12475.4 12696.9 13042.5 13198.9 13291.3 19988.4 20740.3 20815.9 20823.9 20931.0 7320.8 7407.9 7415.3 7417.5 7624.9 982.6 1042.9 1067.2 1098.2 1129.9 33903.3 34069.5 35100.0 36004.6 37117.4 1122.9 1140.1 1152.2 1162.3 1162.7 14770.9 17778.3 18773.3 18814.2 19559.9 516683.0 520362.0 521271.0 522105.0 522245.0 61510.7 61948.0 61960.7 61983.0 62019.4 1327.9 1375.7 1414.7 1424.8 1470.3 30949.5 33964.7 34281.3 34632.1 34850.0 52579.2 52969.0 53208.2 53234.0 53615.5 403310.0 405596.0 406092.0 406188.0 408188.0 30363.4 30411.2 31144.7 31382.2 32970.0 50394.2 50468.7 50633.0 50852.0 51784.7 42371.8 43280.8 43684.6 44076.8 44668.0 42032.6 42153.8 42391.4 43351.6 43892.6 42681.6 43341.3 43488.6 43607.6 43749.8 36209.1 37896.8 38271.6 38700.2 38834.2 28569.4 28764.7 29201.3 29375.4 29454.0 09:37:06 INFO - PROCESS | 25337 | 09:37:06 INFO - PROCESS | 25337 | [#2] jquery.html Cycles:180 Average:29853.82 Median:2279.68 stddev:83152.31 (3647.5%) stddev-sans-first:83356.14 09:37:06 INFO - PROCESS | 25337 | Values: 389.0 436.3 439.6 440.1 445.4 16635.9 19443.4 20068.7 20103.0 20283.2 19493.4 19497.7 19512.7 19533.0 19829.8 5436.3 5453.0 5609.2 5702.5 5832.8 5637.2 5734.7 5738.2 5742.1 5742.3 5478.9 5692.7 5704.4 5730.7 5737.1 5692.5 5735.1 5737.6 5744.3 5748.4 5067.8 5333.2 5381.6 5427.6 5429.9 14188.8 14263.0 14303.8 14417.9 14437.6 2379.7 2460.7 2478.6 2521.7 2936.7 9692.0 10061.0 10340.7 10815.1 12882.4 1876.3 1921.9 2000.0 2028.5 2032.2 84525.0 86599.0 89134.6 90638.0 93156.5 9541.6 9736.9 9975.9 10052.1 11623.5 14357.7 14394.6 14406.9 14440.1 14446.3 7951.0 8039.6 8046.0 8111.8 8114.7 8021.8 8107.5 8242.9 8270.3 8291.0 4344.3 4393.0 4396.4 4431.2 4552.1 2063.3 2085.3 2092.4 2101.9 2179.7 1000.7 1014.2 1025.6 1052.3 1069.7 18704.6 20540.4 20608.2 20726.6 20815.3 1006.3 1018.9 1046.9 1067.0 1068.4 10600.5 11564.6 11647.1 11652.5 11676.0 461107.0 485935.0 511603.0 523603.0 526613.0 96013.0 97036.0 98062.0 101199.0 102308.0 986.4 1016.6 1068.8 1094.6 1099.3 17420.3 17628.2 17829.8 18106.1 18200.9 45139.1 45253.0 46242.3 46375.5 46616.8 61402.0 62049.0 62470.0 62821.0 63929.7 8492.4 8746.3 8768.2 8776.6 9358.8 12844.7 13769.2 13892.2 14140.5 14261.4 12079.5 12249.3 12276.5 12392.3 12596.7 11962.8 12214.0 12445.0 12447.9 12719.4 11801.6 12143.1 12297.9 12335.3 12459.3 8677.1 8716.6 8887.3 8919.6 9293.4 7680.1 11966.9 12263.6 12459.3 12493.3 09:37:06 INFO - PROCESS | 25337 | 09:37:06 INFO - PROCESS | 25337 | [#3] mootools.html Cycles:180 Average:5433.46 Median:5139.51 stddev:2908.15 (56.6%) stddev-sans-first:2899.91 09:37:06 INFO - PROCESS | 25337 | Values: 1324.2 1451.5 1483.2 1611.3 1758.7 7166.6 7690.8 7983.6 8033.5 8170.9 8035.8 8086.9 8089.0 8147.3 8167.3 2383.6 2410.8 2414.1 2415.9 2417.0 2368.3 2415.4 2418.6 2428.7 2429.4 2384.2 2386.3 2407.2 2424.5 2424.8 2283.9 2284.5 2288.6 2293.3 2364.4 2265.1 2268.7 2297.2 2300.1 2303.5 7860.3 7871.3 7947.8 8053.7 8074.8 4930.3 5120.9 5123.1 5129.8 5132.6 3348.9 3406.2 3458.0 3504.0 3538.8 1108.5 1133.8 1156.8 1195.5 1218.5 10722.1 10794.1 10801.9 10820.9 10839.9 4161.9 4378.7 4425.2 4443.8 4481.7 9116.5 9137.9 9145.5 9146.2 9157.0 5121.6 5133.2 5136.3 5137.1 5141.9 4213.2 4338.0 4625.9 4728.5 4780.2 3771.1 3771.4 3819.5 3863.7 3872.4 1196.3 1198.9 1203.3 1208.5 1210.9 973.8 992.8 1011.9 1014.5 1015.5 5501.0 5568.1 5587.3 5747.8 5829.4 965.8 970.6 970.8 976.5 1014.9 3773.2 3893.7 3979.3 3981.8 3988.9 9428.5 9794.6 9977.9 9995.6 10012.1 9655.2 9862.2 9865.1 9866.4 9878.4 7605.2 7846.8 7860.8 7866.3 7870.3 5470.5 5586.7 5602.6 5639.3 5697.1 9063.7 9090.9 9098.5 9199.7 9250.5 9102.4 9106.4 9247.4 9421.5 9484.1 6477.9 6668.2 6893.2 7052.0 7212.9 7925.4 8186.4 8192.6 8200.4 8202.3 7254.2 7336.7 7439.7 7480.4 7577.6 7171.9 7212.3 7243.3 7405.3 7463.2 6614.5 6724.6 6776.2 6781.6 6785.5 4931.2 5051.5 5088.5 5127.7 5154.7 5029.5 5048.4 5098.7 5161.0 5210.7 09:37:06 INFO - PROCESS | 25337 | 09:37:06 INFO - PROCESS | 25337 | [#4] prototype.html Cycles:180 Average:4660.77 Median:5266.74 stddev:1335.21 (25.4%) stddev-sans-first:1299.08 09:37:06 INFO - PROCESS | 25337 | Values: 345.8 350.7 355.6 357.1 361.2 5384.9 5401.8 5432.2 5440.5 5445.3 5059.5 5165.3 5196.0 5264.9 5332.9 4140.6 4174.9 4181.0 4197.0 4224.4 4203.0 4222.5 4225.8 4230.8 4253.1 4107.2 4161.4 4175.1 4201.0 4209.4 4171.4 4179.9 4195.6 4196.2 4197.8 3719.4 3723.0 3729.3 3731.7 3751.7 4995.6 5175.8 5192.3 5221.9 5250.6 4778.7 4788.5 4790.9 4807.8 4823.7 5541.5 5542.5 5568.8 5571.7 5572.8 3848.6 4046.4 4110.2 4117.8 4133.5 5710.8 5748.7 5759.6 5761.7 5767.7 4133.9 4137.3 4138.5 4142.7 4153.5 4154.5 4160.6 4219.6 4250.6 4251.8 4729.4 4741.5 4753.0 4774.9 4777.9 5567.4 5576.4 5587.6 5594.4 5596.2 1395.8 1403.7 1408.0 1409.7 1411.3 1007.8 1009.2 1035.2 1036.5 1046.3 5251.2 5252.5 5268.6 5270.3 5275.2 5488.6 5494.2 5503.7 5526.7 5535.0 5087.5 5223.2 5246.3 5273.6 5275.3 2899.6 2903.3 2912.5 2919.5 2923.9 5711.9 5721.7 5724.9 5726.7 5734.2 5334.5 5531.3 5560.4 5563.0 5575.2 5677.7 5682.4 5698.6 5701.7 5701.8 5226.7 5401.6 5419.4 5481.8 5509.8 5413.5 5432.9 5445.1 5498.4 5500.6 5617.9 5690.9 5692.2 5720.8 5728.6 3970.6 4129.2 4149.5 4154.3 4184.7 5378.9 5480.8 5557.7 5603.4 5718.5 5578.6 5584.5 5586.0 5588.8 5617.5 5345.4 5533.0 5579.9 5586.2 5587.9 5547.4 5563.2 5572.2 5573.9 5581.9 5634.8 5643.4 5649.8 5652.1 5655.1 5260.2 5508.5 5512.6 5533.5 5548.2 09:37:06 INFO - PROCESS | 25337 | 09:37:06 INFO - PROCESS | 25337 | [#5] yui.html Cycles:180 Average:18422.73 Median:48397.14 stddev:24439.25 (50.5%) stddev-sans-first:24471.86 09:37:06 INFO - PROCESS | 25337 | Values: 771.1 778.7 829.9 849.2 896.5 14660.3 14967.9 14998.3 15160.6 15174.0 14868.5 15066.5 15086.2 15513.6 15874.2 853.6 874.0 874.2 874.5 876.1 728.1 749.1 833.8 856.0 863.2 910.3 911.8 912.6 912.9 912.9 761.6 898.8 906.0 906.2 908.1 572.3 643.6 661.1 666.2 666.3 15618.3 15619.1 15648.4 15667.7 15667.8 14037.4 14330.3 14431.9 14543.9 14569.2 13267.9 13385.4 13412.9 13622.5 14111.8 4528.7 4536.6 4537.6 4548.1 4600.9 48156.5 48331.8 48462.5 48467.0 48513.8 10844.0 11161.8 11309.4 11338.8 11597.4 19038.3 19509.6 19533.0 20685.1 20687.3 8826.5 8858.7 8889.6 8917.6 9138.9 4581.9 4885.9 4901.7 4961.0 5022.5 3577.6 3644.5 3650.2 3685.8 3699.0 629.2 634.8 636.8 642.8 646.2 738.5 747.1 761.8 766.7 810.9 9464.1 10016.4 10196.9 10201.1 10205.3 757.6 773.4 779.7 785.7 813.5 4503.8 4689.9 4793.9 4922.6 4926.4 87817.6 88316.6 92763.5 93760.5 100287.0 78356.6 80392.0 84120.0 85813.1 89168.1 55172.0 72749.0 73473.6 74982.6 76734.0 9325.9 9374.2 9376.1 9377.9 9415.8 51217.7 51275.7 51783.0 52371.0 54354.0 65330.3 68565.8 69478.0 70476.6 72236.6 11433.8 11993.6 12036.9 12200.0 12206.1 13608.2 14001.8 14015.2 14131.5 14798.3 11695.9 11870.6 12526.3 12650.8 13043.0 13631.3 13695.6 13757.2 13890.2 14544.3 12730.5 13089.3 13160.8 14109.6 14149.9 10181.7 11085.2 11329.2 11421.7 11463.4 11250.7 11454.7 11499.4 11505.9 11626.5 09:37:06 INFO - PROCESS | 25337 | -------- Summary: end -------- 09:37:06 INFO - PROCESS | 25337 | 09:37:07 INFO - TEST-INFO | 25337: exit 0 09:37:07 INFO - TEST-OK | dromaeo_css | took 1114599ms 09:37:07 INFO - TEST-START | kraken 09:37:07 INFO - operating with platform_type : linux_ 09:37:07 INFO - Initialising browser for kraken test... 09:37:07 INFO - TEST-INFO | started process 25657 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiW9TQd/profile http://localhost:38217/getInfo.html) 09:37:11 INFO - PROCESS | 25657 | __metrics Screen width/height:1600/1200 09:37:11 INFO - PROCESS | 25657 | colorDepth:24 09:37:11 INFO - PROCESS | 25657 | Browser inner width/height: 1024/697 09:37:11 INFO - PROCESS | 25657 | __metrics 09:37:11 INFO - PROCESS | 25657 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:37:11 INFO - PROCESS | 25657 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:37:12 INFO - PROCESS | 25657 | console.error: PushService: 09:37:12 INFO - PROCESS | 25657 | stateChangeProcessEnqueue: Error transitioning state 09:37:12 INFO - PROCESS | 25657 | UnknownError 09:37:12 INFO - TEST-INFO | 25657: exit 0 09:37:12 INFO - Browser initialized. 09:37:12 INFO - Running cycle 1/1 for kraken test... 09:37:12 INFO - TEST-INFO | started process 25753 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiW9TQd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:37:24 INFO - PROCESS | 25753 | RSS: Main: 144441344 09:37:24 INFO - PROCESS | 25753 | 09:37:27 INFO - PROCESS | 25753 | Cycle 1(1): loaded http://localhost:38217/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38217/tests/kraken/driver.html?testName=audio-beat-detection) 09:37:27 INFO - PROCESS | 25753 | RSS: Main: 186200064 09:37:27 INFO - PROCESS | 25753 | 09:37:30 INFO - PROCESS | 25753 | Cycle 1(1): loaded http://localhost:38217/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38217/tests/kraken/driver.html?testName=audio-dft) 09:37:31 INFO - PROCESS | 25753 | RSS: Main: 175677440 09:37:31 INFO - PROCESS | 25753 | 09:37:33 INFO - PROCESS | 25753 | Cycle 1(1): loaded http://localhost:38217/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38217/tests/kraken/driver.html?testName=audio-fft) 09:37:34 INFO - PROCESS | 25753 | RSS: Main: 266342400 09:37:34 INFO - PROCESS | 25753 | 09:37:36 INFO - PROCESS | 25753 | Cycle 1(1): loaded http://localhost:38217/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38217/tests/kraken/driver.html?testName=audio-oscillator) 09:37:37 INFO - PROCESS | 25753 | RSS: Main: 173424640 09:37:37 INFO - PROCESS | 25753 | 09:37:39 INFO - PROCESS | 25753 | Cycle 1(1): loaded http://localhost:38217/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38217/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:37:39 INFO - PROCESS | 25753 | RSS: Main: 176136192 09:37:39 INFO - PROCESS | 25753 | 09:37:42 INFO - PROCESS | 25753 | Cycle 1(1): loaded http://localhost:38217/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38217/tests/kraken/driver.html?testName=imaging-darkroom) 09:37:43 INFO - PROCESS | 25753 | RSS: Main: 214396928 09:37:43 INFO - PROCESS | 25753 | 09:37:46 INFO - PROCESS | 25753 | Cycle 1(1): loaded http://localhost:38217/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38217/tests/kraken/driver.html?testName=imaging-desaturate) 09:37:47 INFO - PROCESS | 25753 | RSS: Main: 213012480 09:37:47 INFO - PROCESS | 25753 | 09:37:50 INFO - PROCESS | 25753 | Cycle 1(1): loaded http://localhost:38217/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38217/tests/kraken/driver.html?testName=json-parse-financial) 09:37:50 INFO - PROCESS | 25753 | RSS: Main: 211791872 09:37:50 INFO - PROCESS | 25753 | 09:37:52 INFO - PROCESS | 25753 | Cycle 1(1): loaded http://localhost:38217/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38217/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:37:52 INFO - PROCESS | 25753 | RSS: Main: 174297088 09:37:52 INFO - PROCESS | 25753 | 09:37:54 INFO - PROCESS | 25753 | Cycle 1(1): loaded http://localhost:38217/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38217/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:37:55 INFO - PROCESS | 25753 | RSS: Main: 181010432 09:37:55 INFO - PROCESS | 25753 | 09:37:57 INFO - PROCESS | 25753 | Cycle 1(1): loaded http://localhost:38217/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38217/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:37:57 INFO - PROCESS | 25753 | RSS: Main: 190550016 09:37:57 INFO - PROCESS | 25753 | 09:38:00 INFO - PROCESS | 25753 | Cycle 1(1): loaded http://localhost:38217/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38217/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:38:01 INFO - PROCESS | 25753 | RSS: Main: 194101248 09:38:01 INFO - PROCESS | 25753 | 09:38:03 INFO - PROCESS | 25753 | Cycle 1(1): loaded http://localhost:38217/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38217/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:38:04 INFO - PROCESS | 25753 | RSS: Main: 195567616 09:38:04 INFO - PROCESS | 25753 | 09:38:05 INFO - PROCESS | 25753 | Cycle 1(1): loaded http://localhost:38217/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38217/tests/kraken/driver.html?testName=ai-astar) 09:38:06 INFO - PROCESS | 25753 | RSS: Main: 247275520 09:38:06 INFO - PROCESS | 25753 | 09:38:06 INFO - PROCESS | 25753 | __start_tp_report 09:38:06 INFO - PROCESS | 25753 | _x_x_mozilla_page_load 09:38:06 INFO - PROCESS | 25753 | _x_x_mozilla_page_load_details 09:38:06 INFO - PROCESS | 25753 | |i|pagename|runs| 09:38:06 INFO - PROCESS | 25753 | |0;ai-astar;103;111;110;110;110;110;108;113;111;110 09:38:06 INFO - PROCESS | 25753 | |1;audio-beat-detection;151;123;120;151;131;127;126;125;157;120 09:38:06 INFO - PROCESS | 25753 | |2;audio-dft;161;159;163;160;160;160;160;160;161;160 09:38:06 INFO - PROCESS | 25753 | |3;audio-fft;75;75;76;108;77;75;76;76;99;76 09:38:06 INFO - PROCESS | 25753 | |4;audio-oscillator;81;81;123;82;82;81;98;82;82;115 09:38:06 INFO - PROCESS | 25753 | |5;imaging-gaussian-blur;117;118;117;117;118;117;117;117;117;117 09:38:06 INFO - PROCESS | 25753 | |6;imaging-darkroom;146;146;147;146;146;146;146;146;146;145 09:38:06 INFO - PROCESS | 25753 | |7;imaging-desaturate;85;84;85;85;85;85;84;85;85;84 09:38:06 INFO - PROCESS | 25753 | |8;json-parse-financial;55;50;50;49;50;50;51;50;50;50 09:38:06 INFO - PROCESS | 25753 | |9;json-stringify-tinderbox;59;59;59;61;59;59;59;59;60;60 09:38:06 INFO - PROCESS | 25753 | |10;stanford-crypto-aes;75;82;74;76;76;82;79;75;75;74 09:38:06 INFO - PROCESS | 25753 | |11;stanford-crypto-ccm;149;127;136;137;127;134;130;135;200;134 09:38:06 INFO - PROCESS | 25753 | |12;stanford-crypto-pbkdf2;160;158;156;158;157;158;155;154;161;156 09:38:06 INFO - PROCESS | 25753 | |13;stanford-crypto-sha256-iterative;60;62;62;64;66;62;62;63;62;61 09:38:06 INFO - PROCESS | 25753 | __end_tp_report 09:38:06 INFO - PROCESS | 25753 | __start_cc_report 09:38:06 INFO - PROCESS | 25753 | _x_x_mozilla_cycle_collect,1599 09:38:06 INFO - PROCESS | 25753 | __end_cc_report 09:38:06 INFO - PROCESS | 25753 | __startTimestamp1480181886185__endTimestamp 09:38:06 INFO - PROCESS | 25753 | 09:38:06 INFO - PROCESS | 25753 | ------- Summary: start ------- 09:38:06 INFO - PROCESS | 25753 | Number of tests: 14 09:38:06 INFO - PROCESS | 25753 | 09:38:06 INFO - PROCESS | 25753 | [#0] ai-astar Cycles:10 Average:109.60 Median:110.00 stddev:2.63 (2.4%) stddev-sans-first:1.32 09:38:06 INFO - PROCESS | 25753 | Values: 103.0 111.0 110.0 110.0 110.0 110.0 108.0 113.0 111.0 110.0 09:38:06 INFO - PROCESS | 25753 | 09:38:06 INFO - PROCESS | 25753 | [#1] audio-beat-detection Cycles:10 Average:133.10 Median:129.00 stddev:14.20 (11.0%) stddev-sans-first:13.50 09:38:06 INFO - PROCESS | 25753 | Values: 151.0 123.0 120.0 151.0 131.0 127.0 126.0 125.0 157.0 120.0 09:38:06 INFO - PROCESS | 25753 | 09:38:06 INFO - PROCESS | 25753 | [#2] audio-dft Cycles:10 Average:160.40 Median:160.00 stddev:1.07 (0.7%) stddev-sans-first:1.12 09:38:06 INFO - PROCESS | 25753 | Values: 161.0 159.0 163.0 160.0 160.0 160.0 160.0 160.0 161.0 160.0 09:38:06 INFO - PROCESS | 25753 | 09:38:06 INFO - PROCESS | 25753 | [#3] audio-fft Cycles:10 Average:81.30 Median:76.00 stddev:11.91 (15.7%) stddev-sans-first:12.41 09:38:06 INFO - PROCESS | 25753 | Values: 75.0 75.0 76.0 108.0 77.0 75.0 76.0 76.0 99.0 76.0 09:38:06 INFO - PROCESS | 25753 | 09:38:06 INFO - PROCESS | 25753 | [#4] audio-oscillator Cycles:10 Average:90.70 Median:82.00 stddev:15.89 (19.4%) stddev-sans-first:16.46 09:38:06 INFO - PROCESS | 25753 | Values: 81.0 81.0 123.0 82.0 82.0 81.0 98.0 82.0 82.0 115.0 09:38:06 INFO - PROCESS | 25753 | 09:38:06 INFO - PROCESS | 25753 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 09:38:06 INFO - PROCESS | 25753 | Values: 117.0 118.0 117.0 117.0 118.0 117.0 117.0 117.0 117.0 117.0 09:38:06 INFO - PROCESS | 25753 | 09:38:06 INFO - PROCESS | 25753 | [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:0.47 (0.3%) stddev-sans-first:0.50 09:38:06 INFO - PROCESS | 25753 | Values: 146.0 146.0 147.0 146.0 146.0 146.0 146.0 146.0 146.0 145.0 09:38:06 INFO - PROCESS | 25753 | 09:38:06 INFO - PROCESS | 25753 | [#7] imaging-desaturate Cycles:10 Average:84.70 Median:85.00 stddev:0.48 (0.6%) stddev-sans-first:0.50 09:38:06 INFO - PROCESS | 25753 | Values: 85.0 84.0 85.0 85.0 85.0 85.0 84.0 85.0 85.0 84.0 09:38:06 INFO - PROCESS | 25753 | 09:38:06 INFO - PROCESS | 25753 | [#8] json-parse-financial Cycles:10 Average:50.50 Median:50.00 stddev:1.65 (3.3%) stddev-sans-first:0.50 09:38:06 INFO - PROCESS | 25753 | Values: 55.0 50.0 50.0 49.0 50.0 50.0 51.0 50.0 50.0 50.0 09:38:06 INFO - PROCESS | 25753 | 09:38:06 INFO - PROCESS | 25753 | [#9] json-stringify-tinderbox Cycles:10 Average:59.40 Median:59.00 stddev:0.70 (1.2%) stddev-sans-first:0.73 09:38:06 INFO - PROCESS | 25753 | Values: 59.0 59.0 59.0 61.0 59.0 59.0 59.0 59.0 60.0 60.0 09:38:06 INFO - PROCESS | 25753 | 09:38:06 INFO - PROCESS | 25753 | [#10] stanford-crypto-aes Cycles:10 Average:76.80 Median:76.00 stddev:3.08 (4.1%) stddev-sans-first:3.20 09:38:06 INFO - PROCESS | 25753 | Values: 75.0 82.0 74.0 76.0 76.0 82.0 79.0 75.0 75.0 74.0 09:38:06 INFO - PROCESS | 25753 | 09:38:06 INFO - PROCESS | 25753 | [#11] stanford-crypto-ccm Cycles:10 Average:140.90 Median:135.50 stddev:21.69 (16.0%) stddev-sans-first:22.80 09:38:06 INFO - PROCESS | 25753 | Values: 149.0 127.0 136.0 137.0 127.0 134.0 130.0 135.0 200.0 134.0 09:38:06 INFO - PROCESS | 25753 | 09:38:06 INFO - PROCESS | 25753 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:157.30 Median:158.00 stddev:2.16 (1.4%) stddev-sans-first:2.06 09:38:06 INFO - PROCESS | 25753 | Values: 160.0 158.0 156.0 158.0 157.0 158.0 155.0 154.0 161.0 156.0 09:38:06 INFO - PROCESS | 25753 | 09:38:06 INFO - PROCESS | 25753 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.40 Median:62.00 stddev:1.65 (2.7%) stddev-sans-first:1.50 09:38:06 INFO - PROCESS | 25753 | Values: 60.0 62.0 62.0 64.0 66.0 62.0 62.0 63.0 62.0 61.0 09:38:06 INFO - PROCESS | 25753 | -------- Summary: end -------- 09:38:06 INFO - PROCESS | 25753 | 09:38:07 INFO - TEST-INFO | 25753: exit 0 09:38:07 INFO - TEST-OK | kraken | took 59832ms 09:38:07 INFO - SUITE-END | took 1174s 09:38:07 INFO - Completed test suite (00:19:34) 09:38:07 INFO - javascript benchmark 09:38:07 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3061.969380306197, 3197.5523426720256, 3209.6469388367277, 3222.081706713587, 3251.561039259699, 5474.452554744524, 5532.0, 5544.722763861801, 5549.112142057266, 5576.944230557693, 5489.972550137244, 5537.972310138453, 5546.944530554693, 5565.972170139154, 5571.554275657948, 5009.073321435528, 5024.196128619404, 5053.51991560803, 5067.543921047105, 5111.642185047048, 4987.451380348159, 4990.700557966534, 4996.7001979881325, 5064.6961182329, 5112.821051263207, 5018.673786203885, 5107.182850743881, 5124.538791508763, 5128.769205385748, 5141.0489059523925, 5127.641065125443, 5129.0, 5138.820141295074, 5142.228665700156, 5173.948260517422, 4908.754562271908, 4909.239067944474, 5033.169527028036, 5037.924431133536, 5084.949150508484, 5387.057264978652, 5403.945960540384, 5432.402435732066, 5453.100238460649, 5456.563474921997, 5819.854503637401, 5839.503642190419, 5869.383714709937, 5878.970605146989, 5897.557683173779, 5726.713664316768, 5947.821565353003, 5960.165576819206, 5968.462838344526, 5973.551983601247, 5411.18832175173, 5435.42927992563, 5488.725563721838, 5490.780368785284, 5530.944690553043, 5964.7315870785915, 5966.164736936832, 5978.4021597839865, 5981.162637230791, 6018.638881667026, 5640.125780504029, 5796.043652797325, 5797.246357973437, 5803.187553742479, 5808.854778630483, 5755.309362876482, 5845.473907348359, 5885.176075349455, 5898.2332296802, 5992.0712289595185, 5877.177195192677, 5912.940870591325, 5924.11138329254, 5930.406959304121, 5932.881342373128, 5936.762529498858, 5941.524678025748, 5946.137810017523, 5947.881042379215, 5981.252343457068, 4455.398521199661, 4473.329000649864, 4478.596926276586, 4493.865184044418, 4507.391502147234, 4062.5937406259136, 4072.8778136655947, 4075.89810254746, 4076.898077548026, 4086.9795651021554, 5547.55619550443, 5551.528120109755, 5552.000639884859, 5554.472325129106, 5558.416366281483, 5774.769009239583, 5837.29952405714, 5864.325602555676, 5869.735861886225, 5876.44173803488, 5486.369067557282, 5517.917231241535, 5544.750486228129, 5568.220449137124, 5616.831495055155, 5041.294218809369, 5097.974510127426, 5100.183970564766, 5107.0, 5117.053345131163, 6068.271807383142, 6107.480864126599, 6114.388561143939, 6115.266168059683, 6122.081687746784, 5739.397363276963, 5753.165790960371, 5807.157962095557, 5855.2095467113095, 5876.118582212703, 6155.384461553988, 6174.073888916699, 6174.25908890936, 6178.876422471615, 6181.84545386351, 5825.679587622722, 5833.679147646751, 5833.67914764692, 5834.03738383162, 5873.794417195549, 5628.549716022791, 5754.0, 5825.50483208932, 5909.881802363842, 5926.170336152856, 5690.971545142248, 5772.278465191851, 5803.100519419497, 5805.042168042226, 5823.8835223294445, 5744.310682718101, 5772.04761214395, 5775.364709881994, 5777.62445441045, 5781.595288329945, 5567.192757050124, 5570.331560212639, 5737.168110624019, 5763.452472015152, 5768.855778605401, 5702.800401985911, 5741.569382296428, 5781.82654520365, 5805.535557155502, 5829.358770535323, 5610.102383618601, 5654.293213348332, 5657.547396208376, 5660.15097735343, 5662.716864156858], "value": 5436.149249146371, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [587.9706014699267, 618.1716499890147, 653.5653790229497, 665.623922483797, 679.7994591595478, 33356.83321583392, 44078.33882491761, 44720.77639611797, 44865.0, 44943.32585011228, 46373.0, 46531.53468465315, 46864.0, 46866.531334686646, 46913.0, 8339.749807505785, 8910.287177025839, 9047.050059743731, 9078.319126065539, 9081.318901082412, 8359.038710548273, 10630.415327157003, 10863.348199108039, 10897.945510272437, 11208.943955280212, 10864.674059778179, 10947.069499092586, 10950.34297942122, 10954.561817527288, 10959.397233152173, 10823.567057317698, 10878.259478483405, 10892.128629709605, 10897.618583349546, 10900.618478353259, 10753.516091775811, 10845.240833141683, 10846.29499082557, 10849.240553161282, 10854.077403420719, 44006.0, 44119.55880441186, 44241.115177696585, 44331.0, 44402.111957760666, 3730.5896351401325, 3763.078045878777, 3835.5397352317623, 3842.7886466244345, 3868.516435445569, 33311.3337733244, 33358.83320583381, 33448.975715099856, 33966.32067358639, 34217.48673769896, 4272.29507131326, 4310.2672545667, 4311.525732169459, 4342.283523218665, 4343.413639158704, 365839.0, 366718.0, 369687.0, 371231.0, 377598.11200944096, 62981.0, 63310.20138791687, 63417.46330146835, 63553.0, 63583.0, 39910.60089399127, 40996.0, 41041.38437923433, 43065.78467107644, 65891.34108658948, 17121.14394280281, 17295.74056389155, 17316.480505584852, 17322.133893305283, 17324.740128898076, 12475.438605262603, 12696.873031269753, 13042.54351097726, 13198.934005329911, 13291.268980206181, 19988.400347989584, 20740.274090406765, 20815.8959205203, 20823.8958805205, 20931.0, 7320.755471569846, 7407.85184296311, 7415.295546923034, 7417.480776345604, 7624.941265858187, 982.6167794560128, 1042.8800687920834, 1067.204932325407, 1098.1763677242068, 1129.9491522881326, 33903.32193356168, 34069.48895766516, 35100.0, 36004.56928502657, 37117.44323835144, 1122.9494672739747, 1140.0879296562716, 1152.2049785648044, 1162.2910024884814, 1162.6802629277017, 14770.92614536942, 17778.288868445376, 18773.34293299728, 18814.153363098692, 19559.902200489192, 516683.0, 520362.0, 521271.0, 522105.0, 522245.0, 61510.69244653748, 61948.0, 61960.69019654873, 61983.0, 62019.37980620226, 1327.9004074694244, 1375.7042235919325, 1414.7382734194207, 1424.7533408267973, 1470.3383477435198, 30949.535756963214, 33964.660353396146, 34281.314373712885, 34632.13419664528, 34850.0, 52579.21131182959, 52969.0, 53208.20187697265, 53234.0, 53615.463845361046, 403310.0, 405596.0, 406092.0, 406188.0, 408188.0, 30363.392732145676, 30411.2397190072, 31144.688553114178, 31382.215444614067, 32970.0, 50394.244086339466, 50468.74765626148, 50633.0, 50852.0, 51784.74107629438, 42371.7881410591, 43280.78359608182, 43684.56315436805, 44076.77961610172, 44668.0, 42032.57967420287, 42153.78923105365, 42391.3641295387, 43351.566484336014, 43892.56107439013, 42681.57318426776, 43341.34987975246, 43488.565114349716, 43607.56392436162, 43749.78125109354, 36209.094772630895, 37896.81051594725, 38271.617283827916, 38700.2259954805, 38834.223315534095, 28569.42861142807, 28764.712352876202, 29201.269968250963, 29375.41249174962, 29454.0], "value": 21130.682176063496, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [389.01988876618043, 436.32587652077547, 439.56043956043953, 440.1417236389041, 445.41215537725833, 16635.916820415896, 19443.416697499062, 20068.69896951547, 20102.994850257484, 20283.188672453085, 19493.415197544095, 19497.707534386995, 19512.707309390335, 19533.0, 19829.801701982975, 5436.2661040759485, 5453.0, 5609.242752228458, 5702.54379649627, 5832.795852145176, 5637.210790489335, 5734.68459234744, 5738.196652468658, 5742.138679198112, 5742.339630942432, 5478.91781623276, 5692.715364231772, 5704.429557044304, 5730.742116604742, 5737.053386191274, 5692.5161361284345, 5735.11105778605, 5737.569682273846, 5744.281964754406, 5748.367679555246, 5067.771950262247, 5333.226682131108, 5381.569474442035, 5427.6472029317965, 5429.945700542983, 14188.787168192486, 14263.001589888712, 14303.785443218256, 14417.85582144186, 14437.566872993722, 2379.702537182852, 2460.667809845666, 2478.628205769131, 2521.722610512842, 2936.6769655337894, 9691.951540242253, 10061.0, 10340.741481463023, 10815.080718138968, 12882.420291086924, 1876.333901464974, 1921.932732354361, 2000.0, 2028.4523178741804, 2032.2379107834563, 84525.0, 86599.0, 89134.5543272286, 90638.0, 93156.53421732916, 9541.570629321697, 9736.902630973742, 9975.900240997642, 10052.145567626687, 11623.476943537562, 14357.712845743026, 14394.568162955127, 14406.927965360106, 14440.061396009225, 14446.349914253884, 7951.0, 8039.638216280281, 8046.0, 8111.82378555118, 8114.715984940499, 8021.7994550135545, 8107.473014254055, 8242.876356854653, 8270.338372930271, 8291.046529649047, 4344.261475549164, 4393.0, 4396.406485124531, 4431.180231657154, 4552.066826300666, 2063.31627206244, 2085.3496702353837, 2092.4141240452695, 2101.894905254762, 2179.6512557990645, 1000.6597756762735, 1014.2443879309961, 1025.646152077532, 1052.2791887556896, 1069.7379142110233, 18704.625907481775, 20540.383788486368, 20608.21756663125, 20726.58546829055, 20815.271465498634, 1006.3207335048959, 1018.8675472188717, 1046.8639076920103, 1067.0, 1068.4123731947398, 10600.522976466078, 11564.595239166758, 11647.12646551512, 11652.475638596283, 11676.0, 461107.0, 485935.0, 511603.0, 523603.0, 526613.0, 96013.0, 97036.0, 98062.0, 101199.0, 102308.0, 986.3539381704994, 1016.5679586175846, 1068.7915856407926, 1094.6168840905777, 1099.274478843959, 17420.30318787285, 17628.206730697406, 17829.821701782817, 18106.09469526492, 18200.908995454938, 45139.097218056115, 45253.0, 46242.30636540387, 46375.53624463712, 46616.7669161652, 61402.0, 62049.0, 62470.0, 62821.0, 63929.6803515998, 8492.363072769444, 8746.256568191775, 8768.167024132697, 8776.561171941505, 9358.766030849283, 12844.743105137659, 13769.242691651654, 13892.16647001183, 14140.50508232207, 14261.358238879482, 12079.51681932713, 12249.326287053942, 12276.508939642314, 12392.256464612152, 12596.685082873002, 11962.820557691815, 12214.022878169548, 12445.0, 12447.875521245034, 12719.364031798557, 11801.645950621494, 12143.089268304735, 12297.938510307391, 12335.259884406963, 12459.314737689514, 8677.088905664814, 8716.564171791511, 8887.289016878505, 8919.55402229873, 9293.442393456415, 7680.078390593165, 11966.940165299118, 12263.632091037283, 12459.314737689152, 12493.25040497573], "value": 9341.292336849185, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1324.2054767139723, 1451.470213372119, 1483.1768368555452, 1611.3232442374208, 1758.7098128808748, 7166.641667916603, 7690.846183076335, 7983.600819958993, 8033.477823941447, 8170.877436838452, 8035.799105022377, 8086.878696819553, 8089.0, 8147.348212143014, 8167.264946154844, 2383.618621020637, 2410.758924107593, 2414.0947144820693, 2415.8912848921755, 2417.033186725306, 2368.2539999900064, 2415.3720032791425, 2418.5646583614944, 2428.7449817769143, 2429.4047958250167, 2384.1655420602824, 2386.2960426674085, 2407.2176542623715, 2424.5029768897334, 2424.781769640732, 2283.862968221904, 2284.5088306014122, 2288.6338185890263, 2293.3005433342823, 2364.385259832456, 2265.127925748582, 2268.6823844661762, 2297.184499502669, 2300.1029598456616, 2303.527776805751, 7860.253275938777, 7871.291583757489, 7947.761567152995, 8053.677852885878, 8074.798130046737, 4930.3344048553345, 5120.871978200537, 5123.129068058439, 5129.794808207667, 5132.5893928486, 3348.8995330140133, 3406.2165701888703, 3458.0, 3503.9824800876086, 3538.752287339887, 1108.5344155454648, 1133.7902488039656, 1156.7802117597714, 1195.4978908858213, 1218.5308656167351, 10722.14222862177, 10794.082502987256, 10801.945990270155, 10820.891791082067, 10839.891601083968, 4161.8959526012095, 4378.715383500063, 4425.181341451842, 4443.800028998703, 4481.708688935209, 9116.544172791333, 9137.862932056025, 9145.542722863964, 9146.222571081533, 9157.0, 5121.61587880903, 5133.153029750124, 5136.30659860914, 5137.12668846297, 5141.897162056738, 4213.157368526246, 4337.956620433818, 4625.930611040837, 4728.503507131771, 4780.211265141213, 3771.07608635886, 3771.4342848572387, 3819.5416550014174, 3863.7102217333813, 3872.4384964180035, 1196.300164403816, 1198.9100817438728, 1203.278033180085, 1208.5407545132794, 1210.915235933494, 973.8052389522123, 992.8262554053011, 1011.858339832424, 1014.4927536231884, 1015.5430056474469, 5501.0, 5568.136938774496, 5587.3015873015875, 5747.798827041033, 5829.446202610745, 965.8020105878278, 970.6457143142843, 970.8058388322364, 976.472704739447, 1014.8985101489792, 3773.188764415609, 3893.7032914612614, 3979.323515002399, 3981.8009099544906, 3988.860389886398, 9428.528573571431, 9794.608215671436, 9977.850332245021, 9995.550200241007, 10012.098911098035, 9655.179309758749, 9862.161716254199, 9865.06281903218, 9866.408015519091, 9878.407295562145, 7605.23947605235, 7846.803829904184, 7860.803479912934, 7866.331361834308, 7870.331021863206, 5470.452954704498, 5586.692731899784, 5602.607817452739, 5639.295088113986, 5697.088465845445, 9063.728088157366, 9090.909090909006, 9098.545072746469, 9199.724008279762, 9250.537473126451, 9102.36283460178, 9106.408083474553, 9247.352685311964, 9421.481818500048, 9484.146426821619, 6477.935220647733, 6668.233153187251, 6893.241743408121, 7051.964740176266, 7212.8918066228, 7925.445218834857, 8186.3860210485645, 8192.631331590212, 8200.384971127309, 8202.343812495106, 7254.202037775946, 7336.7432139874845, 7439.739609113655, 7480.3641690456925, 7577.621118944141, 7171.892421613576, 7212.278772122746, 7243.311885370881, 7405.296496832792, 7463.17905030457, 6614.536982411185, 6724.630145341857, 6776.220734615582, 6781.6270105144695, 6785.457163426815, 4931.235658472942, 5051.479731410097, 5088.465711100429, 5127.66670166438, 5154.716490592903, 5029.4719054498755, 5048.3941926969, 5098.745062746922, 5160.974195129151, 5210.687358758487], "value": 4450.62682455863, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [345.7787016309562, 350.680880398837, 355.62836835506886, 357.1499830403639, 361.17291402687846, 5384.9230153969265, 5401.756920938557, 5432.2123292122615, 5440.455954404558, 5445.264889239951, 5059.494050594939, 5165.251038599401, 5196.0, 5264.92102618461, 5332.866678333044, 4140.6273435390885, 4174.874753757392, 4181.0, 4196.958030419687, 4224.387463817745, 4202.97898510507, 4222.472190976128, 4225.7887105644595, 4230.809613567397, 4253.106847562016, 4107.240160570289, 4161.3549899765585, 4175.060611362434, 4200.97899510502, 4209.410682504452, 4171.353440216772, 4179.861936682692, 4195.62239398454, 4196.181744559812, 4197.769122698235, 3719.367707489733, 3723.0320116769562, 3729.347364211252, 3731.7014638828828, 3751.681107105899, 4995.550400463976, 5175.767090480937, 5192.273081768555, 5221.895562088775, 5250.553702935255, 4778.737169455679, 4788.474891227791, 4790.856274311776, 4807.759612019385, 4823.734694591796, 5541.501264886139, 5542.501174894239, 5568.805091821807, 5571.721413929287, 5572.832815015556, 3848.5766565677754, 4046.3525835866412, 4110.219058378928, 4117.794110294473, 4133.503979522447, 5710.77156913723, 5748.655080695172, 5759.625624334447, 5761.654300741969, 5767.740451679642, 4133.8966525837095, 4137.275976704064, 4138.482689663792, 4142.71001029925, 4153.480814898137, 4154.480689913761, 4160.625543701081, 4219.620234178878, 4250.617444429954, 4251.829926802955, 4729.385179926657, 4741.478437371887, 4752.976235118802, 4774.880627984258, 4777.904441911142, 5567.387587365387, 5576.358718747315, 5587.552995760329, 5594.440555944454, 5596.160575913564, 1395.8325000999946, 1403.6841710615233, 1407.9648008799861, 1409.7039621679357, 1411.2943528235883, 1007.7833265847878, 1009.2228983682523, 1035.1873779083535, 1036.512838965685, 1046.2937517175876, 5251.2123181523075, 5252.474752524793, 5268.552173065255, 5270.288511051036, 5275.182346736262, 5488.643238189505, 5494.230807686847, 5503.734141147558, 5526.696031718214, 5534.972325138348, 5087.491250874883, 5223.216517522402, 5246.291750613618, 5273.551748101454, 5275.340582427197, 2899.5505696617056, 2903.3032072302494, 2912.461194678991, 2919.5110493647967, 2923.8830446782317, 5711.858053230038, 5721.656700597978, 5724.942750572524, 5726.656400615893, 5734.197212390269, 5334.51989320963, 5531.25328080712, 5560.443955604488, 5563.0, 5575.219469274305, 5677.716114194356, 5682.374938756733, 5698.629589076697, 5701.7434215461235, 5701.771929122871, 5226.712530810842, 5401.567874569946, 5419.4309597493275, 5481.780728770805, 5509.807156749494, 5413.53984911287, 5432.9185062223305, 5445.128779395278, 5498.367687715964, 5500.614956953135, 5617.943820561905, 5690.9430905690415, 5692.203091567101, 5720.799772007959, 5728.598998070095, 3970.563238043755, 4129.174165166918, 4149.543550209414, 4154.273002224659, 4184.7070705050355, 5378.892422151614, 5480.835574932758, 5557.666540007613, 5603.411641777718, 5718.485336319751, 5578.553715702815, 5584.525315348078, 5585.972070139624, 5588.776448941997, 5617.466340697627, 5345.358556973188, 5533.0, 5579.944200558105, 5586.245856809279, 5587.916181257203, 5547.362053363915, 5563.221149039218, 5572.247746554325, 5573.944260557342, 5581.9162712560155, 5634.830955071355, 5643.363424606982, 5649.7740090397565, 5652.095664693629, 5655.095184770417, 5260.237265596391, 5508.476694713996, 5512.586556008396, 5533.474319939599, 5548.171761484563], "value": 4244.56251357342, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [771.0939645916047, 778.7352300217925, 829.925306722395, 849.2484151525899, 896.5114012862989, 14660.340284687189, 14967.850321496782, 14998.250087495637, 15160.620984475394, 15174.0, 14868.47960321389, 15066.472673456405, 15086.170260635661, 15513.612159696013, 15874.206289685528, 853.6457370191363, 874.0167311774254, 874.2350443362059, 874.4796845876725, 876.071364353787, 728.10806761717, 749.108560812634, 833.791552111972, 856.0, 863.2058506174335, 910.2626872233479, 911.7811725185974, 912.561970254275, 912.885889263842, 912.9452232866049, 761.5697131120899, 898.7932775461647, 906.0169715858269, 906.1799071839929, 908.0601577367426, 572.2560671127518, 643.6492111799081, 661.1240106858431, 666.1539844397636, 666.3203532396928, 15618.297176627078, 15619.140947247897, 15648.374065037386, 15667.686646267011, 15667.843321566752, 14037.438502459889, 14330.283485825667, 14431.855681443156, 14543.854561454356, 14569.198694071822, 13267.867321326856, 13385.397657105355, 13412.865871341259, 13622.455101795917, 14111.78832317516, 4528.660350473728, 4536.590677370518, 4537.636989040901, 4548.135854187727, 4600.884977875547, 48156.5184348159, 48331.75834120842, 48462.5153748465, 48467.03065938661, 48513.757431212616, 10843.985692793567, 11161.83257251142, 11309.434528273554, 11338.773224535464, 11597.420128993685, 19038.33365832189, 19509.609807803765, 19533.0, 20685.069171887302, 20687.27594534184, 8826.514541700268, 8858.73423797287, 8889.644414223489, 8917.55412229386, 9138.908610913939, 4581.931271030937, 4885.877853053702, 4901.730404827768, 4961.03259864323, 5022.4977502249485, 3577.606463289036, 3644.526211592476, 3650.1969566695284, 3685.7972811495624, 3698.9630103699155, 629.2386212682705, 634.8381162803455, 636.8121404185777, 642.8039447968321, 646.2116218213772, 738.4572339330695, 747.0848210941554, 761.77146855943, 766.7431410477441, 810.9026916770025, 9464.148226659496, 10016.449095299682, 10196.898031019744, 10201.132903703268, 10205.285630005828, 757.6401209425479, 773.3697036914897, 779.6998155710093, 785.658238666182, 813.4753084260738, 4503.7973291201315, 4689.859304220879, 4793.904121917542, 4922.556969872729, 4926.359573255526, 87817.56091219503, 88316.55841720878, 92763.53618231865, 93760.53119734494, 100287.0, 78356.60821695969, 80392.0, 84120.0, 85813.14186858176, 89168.10831891728, 55172.0, 72749.0, 73473.6326318365, 74982.62508687531, 76734.0, 9325.906740932503, 9374.203192728695, 9376.109269619375, 9377.859332109887, 9415.81168376615, 51217.7439112802, 51275.743621281654, 51783.0, 52371.0, 54354.0, 65330.346696532426, 68565.77232618115, 69478.0, 70476.64761676159, 72236.63881680768, 11433.828492572451, 11993.580224692094, 12036.939815300868, 12200.0, 12206.084543659084, 13608.183508989492, 14001.789973150615, 14015.159090454605, 14131.505397311044, 14798.334074966437, 11695.941520292345, 11870.584529541424, 12526.311052892179, 12650.810237846255, 13043.0, 13631.25028123423, 13695.58166803866, 13757.210434921602, 13890.166590004632, 14544.272786360429, 12730.490780368682, 13089.345532723135, 13160.80258796138, 14109.647258818612, 14149.929250353682, 10181.694549163536, 11085.22403431752, 11329.212593326896, 11421.714457138305, 11463.369514676438, 11250.718732031764, 11454.709444659273, 11499.367534785668, 11505.94247028793, 11626.53493860236], "value": 7469.554444558782, "unit": "score"}], "name": "dromaeo_css", "value": 7300.760781613937, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 111.0, 110.0, 110.0, 110.0, 110.0, 108.0, 113.0, 111.0, 110.0], "value": 109.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 123.0, 120.0, 151.0, 131.0, 127.0, 126.0, 125.0, 157.0, 120.0], "value": 133.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 159.0, 163.0, 160.0, 160.0, 160.0, 160.0, 160.0, 161.0, 160.0], "value": 160.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 108.0, 77.0, 75.0, 76.0, 76.0, 99.0, 76.0], "value": 81.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 81.0, 123.0, 82.0, 82.0, 81.0, 98.0, 82.0, 82.0, 115.0], "value": 90.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 117.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 147.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 145.0], "value": 146.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 85.0, 85.0, 85.0, 85.0, 84.0, 85.0, 85.0, 84.0], "value": 84.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 50.0, 50.0, 49.0, 50.0, 50.0, 51.0, 50.0, 50.0, 50.0], "value": 50.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 59.0, 59.0, 61.0, 59.0, 59.0, 59.0, 59.0, 60.0, 60.0], "value": 59.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 82.0, 74.0, 76.0, 76.0, 82.0, 79.0, 75.0, 75.0, 74.0], "value": 76.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 127.0, 136.0, 137.0, 127.0, 134.0, 130.0, 135.0, 200.0, 134.0], "value": 140.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 158.0, 156.0, 158.0, 157.0, 158.0, 155.0, 154.0, 161.0, 156.0], "value": 157.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 62.0, 62.0, 64.0, 66.0, 62.0, 62.0, 63.0, 62.0, 61.0], "value": 62.4, "unit": "score"}], "name": "kraken", "value": 1470.3000000000002, "alertThreshold": 2.0}]} 09:38:07 INFO - Return code: 0 09:38:07 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:38:07 INFO - # TBPL SUCCESS # 09:38:07 INFO - Running post-action listener: _resource_record_post_action 09:38:07 INFO - [mozharness: 2016-11-26 17:38:07.980986Z] Finished run-tests step (success) 09:38:07 INFO - Running post-run listener: _resource_record_post_run 09:38:08 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 266240; Write bytes: 368214016; Read time: 20; Write time: 209504 09:38:08 INFO - TinderboxPrint: CPU usage
13.0% 09:38:08 INFO - TinderboxPrint: I/O read bytes / time
266,240 / 20 09:38:08 INFO - TinderboxPrint: I/O write bytes / time
368,214,016 / 209,504 09:38:08 INFO - TinderboxPrint: CPU idle
8,277.3 (87.0%) 09:38:08 INFO - TinderboxPrint: CPU user
1,191.8 (12.5%) 09:38:08 INFO - TinderboxPrint: Swap in / out
0 / 0 09:38:08 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 118616064; Read time: 0; Write time: 80196 09:38:08 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 266240; Write bytes: 248705024; Read time: 20; Write time: 129292 09:38:08 INFO - Running post-run listener: _upload_blobber_files 09:38:08 INFO - Blob upload gear active. 09:38:08 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:38:08 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 09:38:08 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', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:38:08 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 Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:38:09 INFO - (blobuploader) - INFO - Open directory for files ... 09:38:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:38:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:38:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:38:13 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:38:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:38:13 INFO - (blobuploader) - INFO - Done attempting. 09:38:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:38:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:38:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:38:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:38:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:38:14 INFO - (blobuploader) - INFO - Done attempting. 09:38:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:38:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:38:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:38:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:38:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:38:15 INFO - (blobuploader) - INFO - Done attempting. 09:38:15 INFO - (blobuploader) - INFO - Iteration through files over. 09:38:15 INFO - Return code: 0 09:38:15 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:38:15 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:38:15 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cf60745034ddadc5eaa89074ae312d0e73596fe4db8849cae80f86b5abdda1bb59d8d50aa3533bbd269d96e6af4eb001fa576e8d723d52fab77608846a2ce1b2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/562ddf536cd306109f68767c8663e1a7c9d9ef27d911748474ace785f84388b89a1cd857f0493b8115c0bcce4c711b3c8a3ceed80b95fe740f16a114e0694a5c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b5177d3ed00c9a66196d2debe311669489471142f1fcb451354e34e75dfa95b7028b3e74148e09a103e0d4ef7cbd60368f099ce67d6172eac68ade1b654c6e14"} 09:38:15 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:38:15 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:38:15 INFO - Contents: 09:38:15 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cf60745034ddadc5eaa89074ae312d0e73596fe4db8849cae80f86b5abdda1bb59d8d50aa3533bbd269d96e6af4eb001fa576e8d723d52fab77608846a2ce1b2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/562ddf536cd306109f68767c8663e1a7c9d9ef27d911748474ace785f84388b89a1cd857f0493b8115c0bcce4c711b3c8a3ceed80b95fe740f16a114e0694a5c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b5177d3ed00c9a66196d2debe311669489471142f1fcb451354e34e75dfa95b7028b3e74148e09a103e0d4ef7cbd60368f099ce67d6172eac68ade1b654c6e14"} 09:38:15 INFO - Running post-run listener: copy_logs_to_upload_dir 09:38:15 INFO - Copying logs to upload dir... 09:38:15 INFO - mkdir: /builds/slave/test/build/upload/logs 09:38:15 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.768896 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-11-26 09:38:14.877906) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-26 09:38:14.881022) ========= 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=3a3620fb28aea1604ab609ef000001d2-1480179242.764757-1433683382 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cf60745034ddadc5eaa89074ae312d0e73596fe4db8849cae80f86b5abdda1bb59d8d50aa3533bbd269d96e6af4eb001fa576e8d723d52fab77608846a2ce1b2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/562ddf536cd306109f68767c8663e1a7c9d9ef27d911748474ace785f84388b89a1cd857f0493b8115c0bcce4c711b3c8a3ceed80b95fe740f16a114e0694a5c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b5177d3ed00c9a66196d2debe311669489471142f1fcb451354e34e75dfa95b7028b3e74148e09a103e0d4ef7cbd60368f099ce67d6172eac68ade1b654c6e14"} build_url:https://queue.taskcluster.net/v1/task/TNeSr781SQuei-4aJv5Dfw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011636 build_url: 'https://queue.taskcluster.net/v1/task/TNeSr781SQuei-4aJv5Dfw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cf60745034ddadc5eaa89074ae312d0e73596fe4db8849cae80f86b5abdda1bb59d8d50aa3533bbd269d96e6af4eb001fa576e8d723d52fab77608846a2ce1b2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/562ddf536cd306109f68767c8663e1a7c9d9ef27d911748474ace785f84388b89a1cd857f0493b8115c0bcce4c711b3c8a3ceed80b95fe740f16a114e0694a5c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b5177d3ed00c9a66196d2debe311669489471142f1fcb451354e34e75dfa95b7028b3e74148e09a103e0d4ef7cbd60368f099ce67d6172eac68ade1b654c6e14"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-26 09:38:14.906449) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-26 09:38:14.906796) ========= 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=3a3620fb28aea1604ab609ef000001d2-1480179242.764757-1433683382 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004495 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-26 09:38:14.991375) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-26 09:38:14.991884) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-26 09:38:14.992163) ========= ========= Total master_lag: 0.15 =========