builder: autoland_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-008 starttime: 1476004799.12 results: success (0) buildid: 20161009010217 builduid: a3c9af51c2fe4417a2152b1c939018f1 revision: 35697c37c23bdd2c2c30a06a802cf16c3c9ce037 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-09 02:19:59.124499) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-09 02:19:59.125064) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-09 02:19:59.125383) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-09 02:19:59.144112) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-09 02:19:59.144380) ========= 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=32c5991c409366f7fec8a718000001d2-1476001159.273248-757679691 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-09 02:20:00-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.3M=0s 2016-10-09 02:20:00 (46.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.081252 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-09 02:19:59.241493) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-09 02:19:59.241841) ========= 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=32c5991c409366f7fec8a718000001d2-1476001159.273248-757679691 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020959 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-09 02:19:59.294532) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-09 02:19:59.294875) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 35697c37c23bdd2c2c30a06a802cf16c3c9ce037 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev 35697c37c23bdd2c2c30a06a802cf16c3c9ce037 --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=32c5991c409366f7fec8a718000001d2-1476001159.273248-757679691 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-09 02:20:00,197 truncating revision to first 12 chars 2016-10-09 02:20:00,197 Setting DEBUG logging. 2016-10-09 02:20:00,197 attempt 1/10 2016-10-09 02:20:00,197 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/35697c37c23b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-09 02:20:01,479 unpacking tar archive at: autoland-35697c37c23b/testing/mozharness/ program finished with exit code 0 elapsedTime=1.660515 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-09 02:20:00.969499) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-09 02:20:00.969806) ========= script_repo_revision: 35697c37c23bdd2c2c30a06a802cf16c3c9ce037 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-09 02:20:00.970243) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-09 02:20:00.970519) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-09 02:20:00.979452) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-10-09 02:20:00.979903) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Autoland-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=32c5991c409366f7fec8a718000001d2-1476001159.273248-757679691 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:20:01 INFO - MultiFileLogger online at 20161009 02:20:01 in /builds/slave/test 02:20:01 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO 02:20:01 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:20:01 INFO - {'append_to_log': False, 02:20:01 INFO - 'base_work_dir': '/builds/slave/test', 02:20:01 INFO - 'blob_upload_branch': 'Autoland-Non-PGO', 02:20:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:20:01 INFO - 'branch': 'Autoland-Non-PGO', 02:20:01 INFO - 'buildbot_json_path': 'buildprops.json', 02:20:01 INFO - 'config_files': ('talos/linux_config.py',), 02:20:01 INFO - 'default_actions': ('clobber', 02:20:01 INFO - 'read-buildbot-config', 02:20:01 INFO - 'download-and-extract', 02:20:01 INFO - 'populate-webroot', 02:20:01 INFO - 'create-virtualenv', 02:20:01 INFO - 'install', 02:20:01 INFO - 'run-tests'), 02:20:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:20:01 INFO - 'download_minidump_stackwalk': True, 02:20:01 INFO - 'download_symbols': 'ondemand', 02:20:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:20:01 INFO - 'tooltool.py': '/tools/tooltool.py', 02:20:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:20:01 INFO - '/tools/misc-python/virtualenv.py')}, 02:20:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:20:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:20:01 INFO - 'installer_path': 'installer.exe', 02:20:01 INFO - 'log_level': 'info', 02:20:01 INFO - 'log_name': 'talos', 02:20:01 INFO - 'log_to_console': True, 02:20:01 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:20:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:20:01 INFO - 'opt_config_files': (), 02:20:01 INFO - 'pip_index': False, 02:20:01 INFO - 'sps_profile': False, 02:20:01 INFO - 'sps_profile_interval': 0, 02:20:01 INFO - 'suite': 'dromaeojs', 02:20:01 INFO - 'system_bits': '32', 02:20:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:20:01 INFO - 'title': 'talos-linux64-ix-008', 02:20:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:20:01 INFO - 'use_talos_json': True, 02:20:01 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:20:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:20:01 INFO - 'work_dir': 'build'} 02:20:01 INFO - [mozharness: 2016-10-09 09:20:01.978106Z] Running clobber step. 02:20:01 INFO - Running pre-action listener: _resource_record_pre_action 02:20:01 INFO - Running main action method: clobber 02:20:01 INFO - rmtree: /builds/slave/test/build 02:20:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:20:02 INFO - Running post-action listener: _resource_record_post_action 02:20:02 INFO - [mozharness: 2016-10-09 09:20:02.447924Z] Finished clobber step (success) 02:20:02 INFO - [mozharness: 2016-10-09 09:20:02.448025Z] Running read-buildbot-config step. 02:20:02 INFO - Running pre-action listener: _resource_record_pre_action 02:20:02 INFO - Running main action method: read_buildbot_config 02:20:02 INFO - Using buildbot properties: 02:20:02 INFO - { 02:20:02 INFO - "project": "", 02:20:02 INFO - "product": "firefox", 02:20:02 INFO - "script_repo_revision": "production", 02:20:02 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs", 02:20:02 INFO - "repository": "", 02:20:02 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland talos dromaeojs", 02:20:02 INFO - "buildid": "20161009010217", 02:20:02 INFO - "pgo_build": "False", 02:20:02 INFO - "basedir": "/builds/slave/test", 02:20:02 INFO - "buildnumber": 685, 02:20:02 INFO - "slavename": "talos-linux64-ix-008", 02:20:02 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 02:20:02 INFO - "platform": "ubuntu64_hw", 02:20:02 INFO - "scheduler": "tests-autoland-linux64-talos", 02:20:02 INFO - "branch": "autoland", 02:20:02 INFO - "repo_path": "integration/autoland", 02:20:02 INFO - "revision": "35697c37c23bdd2c2c30a06a802cf16c3c9ce037", 02:20:02 INFO - "stage_platform": "linux64", 02:20:02 INFO - "builduid": "a3c9af51c2fe4417a2152b1c939018f1", 02:20:02 INFO - "slavebuilddir": "test" 02:20:02 INFO - } 02:20:02 INFO - Found installer url https://queue.taskcluster.net/v1/task/FzcB-hBeQxK-S8F9X-6dxQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 02:20:02 INFO - Running post-action listener: _resource_record_post_action 02:20:02 INFO - [mozharness: 2016-10-09 09:20:02.450523Z] Finished read-buildbot-config step (success) 02:20:02 INFO - [mozharness: 2016-10-09 09:20:02.450610Z] Running download-and-extract step. 02:20:02 INFO - Running pre-action listener: _resource_record_pre_action 02:20:02 INFO - Running main action method: download_and_extract 02:20:02 INFO - mkdir: /builds/slave/test/build/tests 02:20:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:20:02 INFO - trying https://queue.taskcluster.net/v1/task/FzcB-hBeQxK-S8F9X-6dxQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 02:20:02 INFO - Downloading https://queue.taskcluster.net/v1/task/FzcB-hBeQxK-S8F9X-6dxQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 02:20:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FzcB-hBeQxK-S8F9X-6dxQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 02:20:02 INFO - Downloaded 1361 bytes. 02:20:02 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 02:20:02 INFO - Using the following test package requirements: 02:20:02 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 02:20:02 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 02:20:02 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 02:20:02 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 02:20:02 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 02:20:02 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 02:20:02 INFO - u'jsshell-linux-x86_64.zip'], 02:20:02 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 02:20:02 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 02:20:02 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 02:20:02 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 02:20:02 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 02:20:03 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 02:20:03 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 02:20:03 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 02:20:03 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 02:20:03 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 02:20:03 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 02:20:03 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:20:03 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FzcB-hBeQxK-S8F9X-6dxQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 02:20:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FzcB-hBeQxK-S8F9X-6dxQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:20:03 INFO - Fetch https://queue.taskcluster.net/v1/task/FzcB-hBeQxK-S8F9X-6dxQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 02:20:03 INFO - Http code: 200 02:20:03 INFO - via: 1.1 4c2196e36fd33f377384d605b4424e95.cloudfront.net (CloudFront) 02:20:03 INFO - x-amz-cf-id: LTIdkfGMhV0HPmmKrCM0F0p8UoK7fTNLFPEB2OVYg9fMWsbH5JVilg== 02:20:03 INFO - x-amz-version-id: 6WXXCmmgRI17fM.jcccrsBKixyblUVLW 02:20:03 INFO - Expected file size: 20524766 02:20:03 INFO - Obtained file size: 20524766 02:20:07 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 02:20:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FzcB-hBeQxK-S8F9X-6dxQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 02:20:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FzcB-hBeQxK-S8F9X-6dxQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:20:07 INFO - Fetch https://queue.taskcluster.net/v1/task/FzcB-hBeQxK-S8F9X-6dxQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 02:20:08 INFO - Http code: 200 02:20:08 INFO - via: 1.1 d897b81191cbfd68a1b6fc44f98c52b0.cloudfront.net (CloudFront) 02:20:08 INFO - x-amz-cf-id: BOWaUy6-wwRR9EoswfHr9ao4zz-fEbzTy9dqz7oUvtX1LlybQZRDwQ== 02:20:08 INFO - x-amz-version-id: 6WXXCmmgRI17fM.jcccrsBKixyblUVLW 02:20:08 INFO - Expected file size: 20524766 02:20:08 INFO - Obtained file size: 20524766 02:20:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FzcB-hBeQxK-S8F9X-6dxQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 02:20:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FzcB-hBeQxK-S8F9X-6dxQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 02:20:13 INFO - Fetch https://queue.taskcluster.net/v1/task/FzcB-hBeQxK-S8F9X-6dxQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 02:20:13 INFO - Http code: 200 02:20:13 INFO - via: 1.1 37af14ee951b12568cf1cc160d08abe6.cloudfront.net (CloudFront) 02:20:13 INFO - x-amz-cf-id: n0oeG_nJXG2iXIghzi0UdplZOV9GlkY2rsZVLV_BhxJsrhYxpRGVMA== 02:20:13 INFO - x-amz-version-id: 2zS9GyCIe3fP2DwSkWgWhc8LHXfvoYfb 02:20:13 INFO - Expected file size: 14409006 02:20:13 INFO - Obtained file size: 14409006 02:20:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:20:14 INFO - trying https://queue.taskcluster.net/v1/task/FzcB-hBeQxK-S8F9X-6dxQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 02:20:14 INFO - Downloading https://queue.taskcluster.net/v1/task/FzcB-hBeQxK-S8F9X-6dxQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 02:20:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FzcB-hBeQxK-S8F9X-6dxQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 02:20:15 INFO - Downloaded 55834582 bytes. 02:20:15 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FzcB-hBeQxK-S8F9X-6dxQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 02:20:15 INFO - mkdir: /builds/slave/test/properties 02:20:15 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:20:15 INFO - Writing to file /builds/slave/test/properties/build_url 02:20:15 INFO - Contents: 02:20:15 INFO - build_url:https://queue.taskcluster.net/v1/task/FzcB-hBeQxK-S8F9X-6dxQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 02:20:16 INFO - Running post-action listener: _resource_record_post_action 02:20:16 INFO - Running post-action listener: set_extra_try_arguments 02:20:16 INFO - [mozharness: 2016-10-09 09:20:16.023039Z] Finished download-and-extract step (success) 02:20:16 INFO - [mozharness: 2016-10-09 09:20:16.023265Z] Running populate-webroot step. 02:20:16 INFO - Running pre-action listener: _resource_record_pre_action 02:20:16 INFO - Running main action method: populate_webroot 02:20:16 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:20:16 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:20:16 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:20:16 INFO - '--tppagecycles', 02:20:16 INFO - '7'], 02:20:16 INFO - 'tests': ['tsvgm']}}, 02:20:16 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:20:16 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:20:16 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:20:16 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:20:16 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:20:16 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:20:16 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:20:16 INFO - 'talos_options': ['--disable-e10s'], 02:20:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:20:16 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:20:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:20:16 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:20:16 INFO - 'talos_options': ['--disable-e10s'], 02:20:16 INFO - 'tests': ['damp', 'tps']}, 02:20:16 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:20:16 INFO - 'tests': ['damp', 'tps']}, 02:20:16 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:20:16 INFO - 'tests': ['dromaeo_dom']}, 02:20:16 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:20:16 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:20:16 INFO - 'tests': ['basic_compositor_video']}, 02:20:16 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:20:16 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:20:16 INFO - 'tests': ['a11yr', 02:20:16 INFO - 'ts_paint', 02:20:16 INFO - 'tpaint', 02:20:16 INFO - 'sessionrestore', 02:20:16 INFO - 'sessionrestore_no_auto_restore', 02:20:16 INFO - 'tabpaint']}, 02:20:16 INFO - 'other-e10s': {'tests': ['a11yr', 02:20:16 INFO - 'ts_paint', 02:20:16 INFO - 'tpaint', 02:20:16 INFO - 'sessionrestore', 02:20:16 INFO - 'sessionrestore_no_auto_restore', 02:20:16 INFO - 'tabpaint']}, 02:20:16 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:20:16 INFO - 'ts_paint', 02:20:16 INFO - 'tpaint', 02:20:16 INFO - 'sessionrestore', 02:20:16 INFO - 'sessionrestore_no_auto_restore', 02:20:16 INFO - 'tabpaint']}, 02:20:16 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:20:16 INFO - 'ts_paint', 02:20:16 INFO - 'tpaint', 02:20:16 INFO - 'sessionrestore', 02:20:16 INFO - 'sessionrestore_no_auto_restore', 02:20:16 INFO - 'tabpaint']}, 02:20:16 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:20:16 INFO - 'tests': ['a11yr', 02:20:16 INFO - 'ts_paint', 02:20:16 INFO - 'tpaint', 02:20:16 INFO - 'sessionrestore', 02:20:16 INFO - 'sessionrestore_no_auto_restore', 02:20:16 INFO - 'tabpaint']}, 02:20:16 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:20:16 INFO - 'tests': ['a11yr', 02:20:16 INFO - 'ts_paint', 02:20:16 INFO - 'tpaint', 02:20:16 INFO - 'sessionrestore', 02:20:16 INFO - 'sessionrestore_no_auto_restore', 02:20:16 INFO - 'tabpaint']}, 02:20:16 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:20:16 INFO - 'tests': ['tsvgx', 02:20:16 INFO - 'tsvgr_opacity', 02:20:16 INFO - 'tart', 02:20:16 INFO - 'tscrollx', 02:20:16 INFO - 'cart']}, 02:20:16 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:20:16 INFO - 'tsvgr_opacity', 02:20:16 INFO - 'tart', 02:20:16 INFO - 'tscrollx', 02:20:16 INFO - 'cart']}, 02:20:16 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:20:16 INFO - 'talos_options': ['--disable-e10s'], 02:20:16 INFO - 'tests': ['tp5o']}, 02:20:16 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:20:16 INFO - 'tests': ['tp5o']}, 02:20:16 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:20:16 INFO - 'talos_options': ['--disable-e10s', 02:20:16 INFO - '--xperf_path', 02:20:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:20:16 INFO - 'tests': ['tp5n']}, 02:20:16 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:20:16 INFO - 'talos_options': ['--xperf_path', 02:20:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:20:16 INFO - 'tests': ['tp5n']}}, 02:20:16 INFO - 'talos.zip': {'path': '', 02:20:16 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:20:16 INFO - Running post-action listener: _resource_record_post_action 02:20:16 INFO - [mozharness: 2016-10-09 09:20:16.045403Z] Finished populate-webroot step (success) 02:20:16 INFO - [mozharness: 2016-10-09 09:20:16.045491Z] Running create-virtualenv step. 02:20:16 INFO - Running pre-action listener: _resource_record_pre_action 02:20:16 INFO - Running main action method: create_virtualenv 02:20:16 INFO - Creating virtualenv /builds/slave/test/build/venv 02:20:16 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 02:20:16 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:20:16 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:20:16 INFO - Using real prefix '/usr' 02:20:16 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:20:16 INFO - Installing distribute.............................................................................................................................................................................................done. 02:20:18 INFO - Installing pip.................done. 02:20:18 INFO - Return code: 0 02:20:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 02:20:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 02:20:18 INFO - Reading from file tmpfile_stdout 02:20:18 INFO - Output received: 02:20:18 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 02:20:18 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:20:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:20:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:20:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:20:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:20:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f362e27cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b568a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c23ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c20f60>, '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 0x1c21d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c221d0>, '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': '32c5991c409366f7fec8a718000001d2-1476001159.273248-757679691', '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 02:20:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 02:20:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 02:20:18 INFO - Using env: {'DISPLAY': ':0', 02:20:18 INFO - 'HOME': '/home/cltbld', 02:20:18 INFO - 'LANG': 'en_US.UTF-8', 02:20:18 INFO - 'LANGUAGE': 'en_US:en', 02:20:18 INFO - 'LOGNAME': 'cltbld', 02:20:18 INFO - 'MAIL': '/var/mail/cltbld', 02:20:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:20:18 INFO - 'MOZ_NO_REMOTE': '1', 02:20:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:20:18 INFO - 'NO_EM_RESTART': '1', 02:20:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:20:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:20:18 INFO - 'PWD': '/builds/slave/test', 02:20:18 INFO - 'SHELL': '/bin/bash', 02:20:18 INFO - 'SHLVL': '1', 02:20:18 INFO - 'TERM': 'linux', 02:20:18 INFO - 'TMOUT': '86400', 02:20:18 INFO - 'USER': 'cltbld', 02:20:18 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1476001159.273248-757679691', 02:20:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:20:18 INFO - '_': '/tools/buildbot/bin/python'} 02:20:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:20:19 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 02:20:19 INFO - Cleaning up... 02:20:19 INFO - Return code: 0 02:20:19 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:20:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:20:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:20:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:20:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:20:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f362e27cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b568a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c23ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c20f60>, '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 0x1c21d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c221d0>, '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': '32c5991c409366f7fec8a718000001d2-1476001159.273248-757679691', '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 02:20:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 02:20:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 02:20:19 INFO - Using env: {'DISPLAY': ':0', 02:20:19 INFO - 'HOME': '/home/cltbld', 02:20:19 INFO - 'LANG': 'en_US.UTF-8', 02:20:19 INFO - 'LANGUAGE': 'en_US:en', 02:20:19 INFO - 'LOGNAME': 'cltbld', 02:20:19 INFO - 'MAIL': '/var/mail/cltbld', 02:20:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:20:19 INFO - 'MOZ_NO_REMOTE': '1', 02:20:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:20:19 INFO - 'NO_EM_RESTART': '1', 02:20:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:20:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:20:19 INFO - 'PWD': '/builds/slave/test', 02:20:19 INFO - 'SHELL': '/bin/bash', 02:20:19 INFO - 'SHLVL': '1', 02:20:19 INFO - 'TERM': 'linux', 02:20:19 INFO - 'TMOUT': '86400', 02:20:19 INFO - 'USER': 'cltbld', 02:20:19 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1476001159.273248-757679691', 02:20:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:20:19 INFO - '_': '/tools/buildbot/bin/python'} 02:20:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:20:19 INFO - Downloading/unpacking psutil>=3.1.1 02:20:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:20:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:20:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:20:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:20:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:20:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:20:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:20:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:20:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:20:21 INFO - Installing collected packages: psutil 02:20:21 INFO - Running setup.py install for psutil 02:20:21 INFO - building 'psutil._psutil_linux' extension 02:20:21 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 02:20:21 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 02:20:21 INFO - building 'psutil._psutil_posix' extension 02:20:21 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 02:20:21 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 02:20:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:20:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:20:21 INFO - Successfully installed psutil 02:20:21 INFO - Cleaning up... 02:20:21 INFO - Return code: 0 02:20:21 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:20:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:20:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:20:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:20:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:20:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f362e27cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b568a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c23ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c20f60>, '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 0x1c21d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c221d0>, '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': '32c5991c409366f7fec8a718000001d2-1476001159.273248-757679691', '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 02:20:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 02:20:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 02:20:21 INFO - Using env: {'DISPLAY': ':0', 02:20:21 INFO - 'HOME': '/home/cltbld', 02:20:21 INFO - 'LANG': 'en_US.UTF-8', 02:20:21 INFO - 'LANGUAGE': 'en_US:en', 02:20:21 INFO - 'LOGNAME': 'cltbld', 02:20:21 INFO - 'MAIL': '/var/mail/cltbld', 02:20:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:20:21 INFO - 'MOZ_NO_REMOTE': '1', 02:20:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:20:21 INFO - 'NO_EM_RESTART': '1', 02:20:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:20:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:20:21 INFO - 'PWD': '/builds/slave/test', 02:20:21 INFO - 'SHELL': '/bin/bash', 02:20:21 INFO - 'SHLVL': '1', 02:20:21 INFO - 'TERM': 'linux', 02:20:21 INFO - 'TMOUT': '86400', 02:20:21 INFO - 'USER': 'cltbld', 02:20:21 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1476001159.273248-757679691', 02:20:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:20:21 INFO - '_': '/tools/buildbot/bin/python'} 02:20:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:20:22 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:20:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:20:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:20:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:20:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:20:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:20:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:20:23 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:20:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:20:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:20:24 INFO - Installing collected packages: mozsystemmonitor 02:20:24 INFO - Running setup.py install for mozsystemmonitor 02:20:24 INFO - Successfully installed mozsystemmonitor 02:20:24 INFO - Cleaning up... 02:20:24 INFO - Return code: 0 02:20:24 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:20:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:20:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:20:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:20:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:20:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f362e27cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b568a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c23ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c20f60>, '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 0x1c21d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c221d0>, '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': '32c5991c409366f7fec8a718000001d2-1476001159.273248-757679691', '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 02:20:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 02:20:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 02:20:24 INFO - Using env: {'DISPLAY': ':0', 02:20:24 INFO - 'HOME': '/home/cltbld', 02:20:24 INFO - 'LANG': 'en_US.UTF-8', 02:20:24 INFO - 'LANGUAGE': 'en_US:en', 02:20:24 INFO - 'LOGNAME': 'cltbld', 02:20:24 INFO - 'MAIL': '/var/mail/cltbld', 02:20:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:20:24 INFO - 'MOZ_NO_REMOTE': '1', 02:20:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:20:24 INFO - 'NO_EM_RESTART': '1', 02:20:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:20:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:20:24 INFO - 'PWD': '/builds/slave/test', 02:20:24 INFO - 'SHELL': '/bin/bash', 02:20:24 INFO - 'SHLVL': '1', 02:20:24 INFO - 'TERM': 'linux', 02:20:24 INFO - 'TMOUT': '86400', 02:20:24 INFO - 'USER': 'cltbld', 02:20:24 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1476001159.273248-757679691', 02:20:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:20:24 INFO - '_': '/tools/buildbot/bin/python'} 02:20:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:20:24 INFO - Downloading/unpacking jsonschema==2.5.1 02:20:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:20:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:20:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:20:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:20:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:20:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:20:26 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:20:26 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:20:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:20:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:20:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:20:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:20:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:20:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:20:26 INFO - Downloading functools32-3.2.3-2.tar.gz 02:20:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:20:26 INFO - warning: no files found matching '*.txt' 02:20:26 INFO - no previously-included directories found matching 'build' 02:20:26 INFO - no previously-included directories found matching 'dist' 02:20:26 INFO - no previously-included directories found matching '.git*' 02:20:26 INFO - Installing collected packages: jsonschema, functools32 02:20:26 INFO - Running setup.py install for functools32 02:20:26 INFO - warning: no files found matching '*.txt' 02:20:26 INFO - no previously-included directories found matching 'build' 02:20:26 INFO - no previously-included directories found matching 'dist' 02:20:26 INFO - no previously-included directories found matching '.git*' 02:20:26 INFO - Successfully installed jsonschema functools32 02:20:26 INFO - Cleaning up... 02:20:26 INFO - Return code: 0 02:20:26 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:20:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:20:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:20:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:20:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:20:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f362e27cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b568a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c23ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c20f60>, '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 0x1c21d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c221d0>, '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': '32c5991c409366f7fec8a718000001d2-1476001159.273248-757679691', '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 02:20:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 02:20:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 02:20:26 INFO - Using env: {'DISPLAY': ':0', 02:20:26 INFO - 'HOME': '/home/cltbld', 02:20:26 INFO - 'LANG': 'en_US.UTF-8', 02:20:26 INFO - 'LANGUAGE': 'en_US:en', 02:20:26 INFO - 'LOGNAME': 'cltbld', 02:20:26 INFO - 'MAIL': '/var/mail/cltbld', 02:20:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:20:26 INFO - 'MOZ_NO_REMOTE': '1', 02:20:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:20:26 INFO - 'NO_EM_RESTART': '1', 02:20:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:20:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:20:26 INFO - 'PWD': '/builds/slave/test', 02:20:26 INFO - 'SHELL': '/bin/bash', 02:20:26 INFO - 'SHLVL': '1', 02:20:26 INFO - 'TERM': 'linux', 02:20:26 INFO - 'TMOUT': '86400', 02:20:26 INFO - 'USER': 'cltbld', 02:20:26 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1476001159.273248-757679691', 02:20:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:20:26 INFO - '_': '/tools/buildbot/bin/python'} 02:20:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:20:26 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:20:26 INFO - Cleaning up... 02:20:26 INFO - Return code: 0 02:20:26 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:20:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:20:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:20:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:20:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:20:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f362e27cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b568a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c23ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c20f60>, '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 0x1c21d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c221d0>, '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': '32c5991c409366f7fec8a718000001d2-1476001159.273248-757679691', '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 02:20:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:20:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 02:20:27 INFO - Using env: {'DISPLAY': ':0', 02:20:27 INFO - 'HOME': '/home/cltbld', 02:20:27 INFO - 'LANG': 'en_US.UTF-8', 02:20:27 INFO - 'LANGUAGE': 'en_US:en', 02:20:27 INFO - 'LOGNAME': 'cltbld', 02:20:27 INFO - 'MAIL': '/var/mail/cltbld', 02:20:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:20:27 INFO - 'MOZ_NO_REMOTE': '1', 02:20:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:20:27 INFO - 'NO_EM_RESTART': '1', 02:20:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:20:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:20:27 INFO - 'PWD': '/builds/slave/test', 02:20:27 INFO - 'SHELL': '/bin/bash', 02:20:27 INFO - 'SHLVL': '1', 02:20:27 INFO - 'TERM': 'linux', 02:20:27 INFO - 'TMOUT': '86400', 02:20:27 INFO - 'USER': 'cltbld', 02:20:27 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1476001159.273248-757679691', 02:20:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:20:27 INFO - '_': '/tools/buildbot/bin/python'} 02:20:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:20:27 INFO - Downloading/unpacking blobuploader==1.2.4 02:20:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:20:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:20:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:20:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:20:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:20:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:20:29 INFO - Downloading blobuploader-1.2.4.tar.gz 02:20:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:20:29 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:20:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:20:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:20:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:20:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:20:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:20:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:20:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:20:29 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:20:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:20:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:20:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:20:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:20:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:20:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:20:29 INFO - Downloading docopt-0.6.1.tar.gz 02:20:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:20:29 INFO - Installing collected packages: blobuploader, requests, docopt 02:20:29 INFO - Running setup.py install for blobuploader 02:20:29 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:20:29 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:20:29 INFO - Running setup.py install for requests 02:20:30 INFO - Running setup.py install for docopt 02:20:30 INFO - Successfully installed blobuploader requests docopt 02:20:30 INFO - Cleaning up... 02:20:30 INFO - Return code: 0 02:20:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:20:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:20:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:20:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:20:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:20:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f362e27cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b568a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c23ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c20f60>, '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 0x1c21d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c221d0>, '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': '32c5991c409366f7fec8a718000001d2-1476001159.273248-757679691', '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 02:20:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 02:20:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:20:30 INFO - Using env: {'DISPLAY': ':0', 02:20:30 INFO - 'HOME': '/home/cltbld', 02:20:30 INFO - 'LANG': 'en_US.UTF-8', 02:20:30 INFO - 'LANGUAGE': 'en_US:en', 02:20:30 INFO - 'LOGNAME': 'cltbld', 02:20:30 INFO - 'MAIL': '/var/mail/cltbld', 02:20:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:20:30 INFO - 'MOZ_NO_REMOTE': '1', 02:20:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:20:30 INFO - 'NO_EM_RESTART': '1', 02:20:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:20:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:20:30 INFO - 'PWD': '/builds/slave/test', 02:20:30 INFO - 'SHELL': '/bin/bash', 02:20:30 INFO - 'SHLVL': '1', 02:20:30 INFO - 'TERM': 'linux', 02:20:30 INFO - 'TMOUT': '86400', 02:20:30 INFO - 'USER': 'cltbld', 02:20:30 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1476001159.273248-757679691', 02:20:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:20:30 INFO - '_': '/tools/buildbot/bin/python'} 02:20:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:20:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:20:30 INFO - Running setup.py (path:/tmp/pip-uOt5QA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:20:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:20:30 INFO - Running setup.py (path:/tmp/pip-3ghyVz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:20:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:20:30 INFO - Running setup.py (path:/tmp/pip-llWREZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:20:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:20:30 INFO - Running setup.py (path:/tmp/pip-UtDk9O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:20:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:20:31 INFO - Running setup.py (path:/tmp/pip-cEPEl5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:20:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:20:31 INFO - Running setup.py (path:/tmp/pip-rpN_Os-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:20:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:20:31 INFO - Running setup.py (path:/tmp/pip-BQ5BY4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:20:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:20:31 INFO - Running setup.py (path:/tmp/pip-Z8tdfs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:20:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:20:31 INFO - Running setup.py (path:/tmp/pip-9s15Zr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:20:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:20:31 INFO - Running setup.py (path:/tmp/pip-Hwu1fg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:20:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:20:31 INFO - Running setup.py (path:/tmp/pip-nNJlkW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:20:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:20:31 INFO - Running setup.py (path:/tmp/pip-m81yuM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:20:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:20:31 INFO - Running setup.py (path:/tmp/pip-yA27Z5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:20:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:20:31 INFO - Running setup.py (path:/tmp/pip-qzHGOR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:20:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:20:31 INFO - Running setup.py (path:/tmp/pip-CvJd2e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:20:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:20:31 INFO - Running setup.py (path:/tmp/pip-848NVv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:20:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:20:31 INFO - Running setup.py (path:/tmp/pip-tBZmjm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:20:31 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:20:31 INFO - Running setup.py install for manifestparser 02:20:32 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:20:32 INFO - Running setup.py install for mozcrash 02:20:32 INFO - Running setup.py install for mozdebug 02:20:32 INFO - Running setup.py install for mozdevice 02:20:32 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:20:32 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:20:32 INFO - Running setup.py install for mozfile 02:20:32 INFO - Running setup.py install for mozhttpd 02:20:32 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:20:32 INFO - Running setup.py install for mozinfo 02:20:32 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:20:32 INFO - Running setup.py install for mozInstall 02:20:32 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:20:32 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:20:32 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:20:32 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:20:32 INFO - Running setup.py install for mozleak 02:20:32 INFO - Running setup.py install for mozlog 02:20:32 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:20:33 INFO - Running setup.py install for moznetwork 02:20:33 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:20:33 INFO - Running setup.py install for mozprocess 02:20:33 INFO - Running setup.py install for mozprofile 02:20:33 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:20:33 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:20:33 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:20:33 INFO - Running setup.py install for mozrunner 02:20:33 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:20:33 INFO - Running setup.py install for mozscreenshot 02:20:33 INFO - Running setup.py install for moztest 02:20:33 INFO - Running setup.py install for mozversion 02:20:33 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:20:33 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:20:33 INFO - Cleaning up... 02:20:33 INFO - Return code: 0 02:20:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:20:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:20:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:20:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:20:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:20:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f362e27cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b568a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c23ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c20f60>, '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 0x1c21d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c221d0>, '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': '32c5991c409366f7fec8a718000001d2-1476001159.273248-757679691', '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 02:20:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 02:20:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:20:33 INFO - Using env: {'DISPLAY': ':0', 02:20:33 INFO - 'HOME': '/home/cltbld', 02:20:33 INFO - 'LANG': 'en_US.UTF-8', 02:20:33 INFO - 'LANGUAGE': 'en_US:en', 02:20:33 INFO - 'LOGNAME': 'cltbld', 02:20:33 INFO - 'MAIL': '/var/mail/cltbld', 02:20:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:20:33 INFO - 'MOZ_NO_REMOTE': '1', 02:20:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:20:33 INFO - 'NO_EM_RESTART': '1', 02:20:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:20:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:20:33 INFO - 'PWD': '/builds/slave/test', 02:20:33 INFO - 'SHELL': '/bin/bash', 02:20:33 INFO - 'SHLVL': '1', 02:20:33 INFO - 'TERM': 'linux', 02:20:33 INFO - 'TMOUT': '86400', 02:20:33 INFO - 'USER': 'cltbld', 02:20:33 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1476001159.273248-757679691', 02:20:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:20:33 INFO - '_': '/tools/buildbot/bin/python'} 02:20:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:20:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:20:34 INFO - Running setup.py (path:/tmp/pip-4ilB0U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:20:34 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 02:20:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:20:34 INFO - Running setup.py (path:/tmp/pip-dKoOZb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:20:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:20:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:20:34 INFO - Running setup.py (path:/tmp/pip-43Ffvg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:20:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:20:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:20:34 INFO - Running setup.py (path:/tmp/pip-bPI2gC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:20:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:20:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:20:34 INFO - Running setup.py (path:/tmp/pip-QmclMb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:20:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 02:20:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:20:34 INFO - Running setup.py (path:/tmp/pip-vXzFoT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:20:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 02:20:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:20:34 INFO - Running setup.py (path:/tmp/pip-LLsqWz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:20:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 02:20:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:20:34 INFO - Running setup.py (path:/tmp/pip-jQrpfk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:20:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 02:20:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:20:34 INFO - Running setup.py (path:/tmp/pip-I02cSW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:20:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 02:20:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:20:34 INFO - Running setup.py (path:/tmp/pip-HZtdso-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:20:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:20:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:20:34 INFO - Running setup.py (path:/tmp/pip-TmtACo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:20:34 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 02:20:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:20:34 INFO - Running setup.py (path:/tmp/pip-QktC7w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:20:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 02:20:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:20:34 INFO - Running setup.py (path:/tmp/pip-BHGXPE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:20:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 02:20:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:20:34 INFO - Running setup.py (path:/tmp/pip-pbWHlZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:20:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 02:20:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:20:35 INFO - Running setup.py (path:/tmp/pip-JUlJgG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:20:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 02:20:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:20:35 INFO - Running setup.py (path:/tmp/pip-woiKAg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:20:35 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 02:20:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:20:35 INFO - Running setup.py (path:/tmp/pip-3OPFjK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:20:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 02:20:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:20:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:20:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:20:35 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:20:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:20:35 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:20:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:20:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:20:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:20:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:20:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:20:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:20:37 INFO - Downloading blessings-1.6.tar.gz 02:20:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:20:37 INFO - Installing collected packages: blessings 02:20:37 INFO - Running setup.py install for blessings 02:20:37 INFO - Successfully installed blessings 02:20:37 INFO - Cleaning up... 02:20:37 INFO - Return code: 0 02:20:37 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:20:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:20:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:20:37 INFO - Reading from file tmpfile_stdout 02:20:37 INFO - Current package versions: 02:20:37 INFO - argparse == 1.2.1 02:20:37 INFO - blessings == 1.6 02:20:37 INFO - blobuploader == 1.2.4 02:20:37 INFO - docopt == 0.6.1 02:20:37 INFO - functools32 == 3.2.3-2 02:20:37 INFO - jsonschema == 2.5.1 02:20:37 INFO - manifestparser == 1.1 02:20:37 INFO - mozInstall == 1.12 02:20:37 INFO - mozcrash == 0.17 02:20:37 INFO - mozdebug == 0.1 02:20:37 INFO - mozdevice == 0.48 02:20:37 INFO - mozfile == 1.2 02:20:37 INFO - mozhttpd == 0.7 02:20:37 INFO - mozinfo == 0.9 02:20:37 INFO - mozleak == 0.1 02:20:37 INFO - mozlog == 3.4 02:20:37 INFO - moznetwork == 0.27 02:20:37 INFO - mozprocess == 0.23 02:20:37 INFO - mozprofile == 0.28 02:20:37 INFO - mozrunner == 6.12 02:20:37 INFO - mozscreenshot == 0.1 02:20:37 INFO - mozsystemmonitor == 0.3 02:20:37 INFO - moztest == 0.7 02:20:37 INFO - mozversion == 1.4 02:20:37 INFO - psutil == 3.1.1 02:20:37 INFO - requests == 1.2.3 02:20:37 INFO - wsgiref == 0.1.2 02:20:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:20:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:20:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:20:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:20:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:20:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f362e27cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b568a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c23ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c20f60>, '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 0x1c21d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c221d0>, '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': '32c5991c409366f7fec8a718000001d2-1476001159.273248-757679691', '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 02:20:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 02:20:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:20:37 INFO - Using env: {'DISPLAY': ':0', 02:20:37 INFO - 'HOME': '/home/cltbld', 02:20:37 INFO - 'LANG': 'en_US.UTF-8', 02:20:37 INFO - 'LANGUAGE': 'en_US:en', 02:20:37 INFO - 'LOGNAME': 'cltbld', 02:20:37 INFO - 'MAIL': '/var/mail/cltbld', 02:20:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:20:37 INFO - 'MOZ_NO_REMOTE': '1', 02:20:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:20:37 INFO - 'NO_EM_RESTART': '1', 02:20:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:20:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:20:37 INFO - 'PWD': '/builds/slave/test', 02:20:37 INFO - 'SHELL': '/bin/bash', 02:20:37 INFO - 'SHLVL': '1', 02:20:37 INFO - 'TERM': 'linux', 02:20:37 INFO - 'TMOUT': '86400', 02:20:37 INFO - 'USER': 'cltbld', 02:20:37 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1476001159.273248-757679691', 02:20:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:20:37 INFO - '_': '/tools/buildbot/bin/python'} 02:20:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:20:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:20:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 02:20:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 02:20:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 02:20:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 02:20:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 02:20:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 02:20:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 02:20:37 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 02:20:37 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:20:37 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 02:20:37 INFO - Cleaning up... 02:20:37 INFO - Return code: 0 02:20:37 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:20:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:20:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:20:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:20:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:20:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f362e27cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b568a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c23ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c20f60>, '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 0x1c21d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c221d0>, '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': '32c5991c409366f7fec8a718000001d2-1476001159.273248-757679691', '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 02:20:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 02:20:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 02:20:37 INFO - Using env: {'DISPLAY': ':0', 02:20:37 INFO - 'HOME': '/home/cltbld', 02:20:37 INFO - 'LANG': 'en_US.UTF-8', 02:20:37 INFO - 'LANGUAGE': 'en_US:en', 02:20:37 INFO - 'LOGNAME': 'cltbld', 02:20:37 INFO - 'MAIL': '/var/mail/cltbld', 02:20:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:20:37 INFO - 'MOZ_NO_REMOTE': '1', 02:20:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:20:37 INFO - 'NO_EM_RESTART': '1', 02:20:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:20:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:20:37 INFO - 'PWD': '/builds/slave/test', 02:20:37 INFO - 'SHELL': '/bin/bash', 02:20:37 INFO - 'SHLVL': '1', 02:20:37 INFO - 'TERM': 'linux', 02:20:37 INFO - 'TMOUT': '86400', 02:20:37 INFO - 'USER': 'cltbld', 02:20:37 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1476001159.273248-757679691', 02:20:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:20:37 INFO - '_': '/tools/buildbot/bin/python'} 02:20:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:20:38 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:20:38 INFO - Cleaning up... 02:20:38 INFO - Return code: 0 02:20:38 INFO - Running post-action listener: _resource_record_post_action 02:20:38 INFO - Running post-action listener: _start_resource_monitoring 02:20:38 INFO - Starting resource monitoring. 02:20:38 INFO - [mozharness: 2016-10-09 09:20:38.108022Z] Finished create-virtualenv step (success) 02:20:38 INFO - [mozharness: 2016-10-09 09:20:38.108526Z] Running install step. 02:20:38 INFO - Running pre-action listener: _resource_record_pre_action 02:20:38 INFO - Running main action method: install 02:20:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:20:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:20:38 INFO - Reading from file tmpfile_stdout 02:20:38 INFO - Detecting whether we're running mozinstall >=1.0... 02:20:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:20:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:20:38 INFO - Reading from file tmpfile_stdout 02:20:38 INFO - Output received: 02:20:38 INFO - Usage: mozinstall [options] installer 02:20:38 INFO - Options: 02:20:38 INFO - -h, --help show this help message and exit 02:20:38 INFO - -d DEST, --destination=DEST 02:20:38 INFO - Directory to install application into. [default: 02:20:38 INFO - "/builds/slave/test"] 02:20:38 INFO - --app=APP Application being installed. [default: firefox] 02:20:38 INFO - mkdir: /builds/slave/test/build/application 02:20:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 02:20:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 02:20:54 INFO - Reading from file tmpfile_stdout 02:20:54 INFO - Output received: 02:20:54 INFO - /builds/slave/test/build/application/firefox/firefox 02:20:54 INFO - Running post-action listener: _resource_record_post_action 02:20:54 INFO - [mozharness: 2016-10-09 09:20:54.546120Z] Finished install step (success) 02:20:54 INFO - [mozharness: 2016-10-09 09:20:54.546364Z] Running run-tests step. 02:20:54 INFO - Running pre-action listener: _resource_record_pre_action 02:20:54 INFO - Running main action method: run_tests 02:20:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:20:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:20:54 INFO - Python 2.7.3 02:20:54 INFO - Return code: 0 02:20:54 INFO - grabbing minidump binary from tooltool 02:20:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:20:54 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c20f60>, '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 0x1c21d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c221d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:20:54 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 02:20:54 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 02:20:54 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 02:20:54 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:20:54 INFO - Return code: 0 02:20:54 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:20:54 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:20:54 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:20:54 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:20:54 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:20:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FzcB-hBeQxK-S8F9X-6dxQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--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 02:20:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/FzcB-hBeQxK-S8F9X-6dxQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-008 --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 02:20:54 INFO - Using env: {'DISPLAY': ':0', 02:20:54 INFO - 'HOME': '/home/cltbld', 02:20:54 INFO - 'LANG': 'en_US.UTF-8', 02:20:54 INFO - 'LANGUAGE': 'en_US:en', 02:20:54 INFO - 'LOGNAME': 'cltbld', 02:20:54 INFO - 'MAIL': '/var/mail/cltbld', 02:20:54 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:20:54 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:20:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:20:54 INFO - 'MOZ_NO_REMOTE': '1', 02:20:54 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:20:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:20:54 INFO - 'NO_EM_RESTART': '1', 02:20:54 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:20:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:20:54 INFO - 'PWD': '/builds/slave/test', 02:20:54 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:20:54 INFO - 'SHELL': '/bin/bash', 02:20:54 INFO - 'SHLVL': '1', 02:20:54 INFO - 'TERM': 'linux', 02:20:54 INFO - 'TMOUT': '86400', 02:20:54 INFO - 'USER': 'cltbld', 02:20:54 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1476001159.273248-757679691', 02:20:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:20:54 INFO - '_': '/tools/buildbot/bin/python'} 02:20:54 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FzcB-hBeQxK-S8F9X-6dxQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--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 02:20:54 INFO - mozversion application_buildid: 20161009010217 02:20:54 INFO - mozversion application_changeset: 35697c37c23bdd2c2c30a06a802cf16c3c9ce037 02:20:54 INFO - mozversion application_display_name: Nightly 02:20:54 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:20:54 INFO - mozversion application_name: Firefox 02:20:54 INFO - mozversion application_remotingname: firefox 02:20:54 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 02:20:54 INFO - mozversion application_vendor: Mozilla 02:20:54 INFO - mozversion application_version: 52.0a1 02:20:54 INFO - mozversion platform_buildid: 20161009010217 02:20:54 INFO - mozversion platform_changeset: 35697c37c23bdd2c2c30a06a802cf16c3c9ce037 02:20:54 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 02:20:54 INFO - mozversion platform_version: 52.0a1 02:20:54 INFO - using testdate: 1476004854 02:20:54 INFO - actual date: 1476004854 02:20:54 INFO - starting webserver on 'localhost:56544' 02:20:54 INFO - SUITE-START | Running 2 tests 02:20:54 INFO - TEST-START | dromaeo_css 02:20:54 INFO - operating with platform_type : linux_ 02:20:54 INFO - Initialising browser for dromaeo_css test... 02:20:54 INFO - TEST-INFO | started process 1476 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpr9UcYU/profile http://localhost:56544/getInfo.html) 02:20:59 INFO - PROCESS | 1476 | __metrics Screen width/height:1600/1200 02:20:59 INFO - PROCESS | 1476 | colorDepth:24 02:20:59 INFO - PROCESS | 1476 | Browser inner width/height: 1024/697 02:20:59 INFO - PROCESS | 1476 | __metrics 02:20:59 INFO - PROCESS | 1476 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 02:20:59 INFO - PROCESS | 1476 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:21:00 INFO - PROCESS | 1476 | console.error: PushService: 02:21:00 INFO - PROCESS | 1476 | stateChangeProcessEnqueue: Error transitioning state 02:21:00 INFO - PROCESS | 1476 | UnknownError 02:21:01 INFO - TEST-INFO | 1476: exit 0 02:21:01 INFO - Browser initialized. 02:21:01 INFO - Running cycle 1/1 for dromaeo_css test... 02:21:01 INFO - TEST-INFO | started process 1558 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpr9UcYU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:21:13 INFO - PROCESS | 1558 | RSS: Main: 178888704 02:21:13 INFO - PROCESS | 1558 | 02:22:04 INFO - PROCESS | 1558 | 1476004924121 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] 02:24:17 INFO - PROCESS | 1558 | Cycle 1(1): loaded http://localhost:56544/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56544/tests/dromaeo/cssquery-ext.html) 02:24:19 INFO - PROCESS | 1558 | RSS: Main: 344178688 02:24:19 INFO - PROCESS | 1558 | 02:27:22 INFO - PROCESS | 1558 | Cycle 1(1): loaded http://localhost:56544/tests/dromaeo/cssquery-ext.html (next: http://localhost:56544/tests/dromaeo/cssquery-jquery.html) 02:27:23 INFO - PROCESS | 1558 | RSS: Main: 280059904 02:27:23 INFO - PROCESS | 1558 | 02:30:25 INFO - PROCESS | 1558 | Cycle 1(1): loaded http://localhost:56544/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56544/tests/dromaeo/cssquery-mootools.html) 02:30:26 INFO - PROCESS | 1558 | RSS: Main: 220536832 02:30:26 INFO - PROCESS | 1558 | 02:33:28 INFO - PROCESS | 1558 | Cycle 1(1): loaded http://localhost:56544/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56544/tests/dromaeo/cssquery-prototype.html) 02:33:29 INFO - PROCESS | 1558 | RSS: Main: 220262400 02:33:29 INFO - PROCESS | 1558 | 02:36:32 INFO - PROCESS | 1558 | Cycle 1(1): loaded http://localhost:56544/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56544/tests/dromaeo/cssquery-yui.html) 02:36:32 INFO - PROCESS | 1558 | RSS: Main: 221937664 02:36:32 INFO - PROCESS | 1558 | 02:39:35 INFO - PROCESS | 1558 | Cycle 1(1): loaded http://localhost:56544/tests/dromaeo/cssquery-yui.html (next: http://localhost:56544/tests/dromaeo/cssquery-dojo.html) 02:39:36 INFO - PROCESS | 1558 | RSS: Main: 292896768 02:39:36 INFO - PROCESS | 1558 | 02:39:36 INFO - PROCESS | 1558 | __start_tp_report 02:39:36 INFO - PROCESS | 1558 | _x_x_mozilla_page_load 02:39:36 INFO - PROCESS | 1558 | _x_x_mozilla_page_load_details 02:39:36 INFO - PROCESS | 1558 | |i|pagename|runs| 02:39:36 INFO - PROCESS | 1558 | |0;dojo.html;2611.9477610447793;2643.8017148713825;2663.9733602663973;2681.410089780249;2693.299742067063;4669.13620980119;4721.976390118053;4735.408073990751;4847.733374664392;4918.975405122974;4750.4536978247515;4757.286407038946;4769.21307984183;4791.425028996517;4872.634552408575;4314.633256173229;4325.416068830715;4369;4414.337849322611;4414.558544145591;4140.689448291375;4443.333499974998;4461.665375096864;4499.1001799640035;4546.408966834307;4269.807858646368;4429.579189976947;4431.379606855043;4443.4445694288215;4520;4306.5262821089655;4347.174036933005;4376.452943382077;4385.407969924051;4395.956040439619;4333.1766964277;4338.262495375794;4343.435353404069;4391.802368893407;4407.294832826732;4765.666403351766;4779.761011949424;4787.712737235742;4793.544613261734;4809.470958194595;4968.354113965198;5008.048470790538;5049.823256186016;5078;5109.821156259551;5134.204198349262;5136.512031357015;5144.717040562768;5184.948150518522;5185.948140518584;4777.856664300042;4782.736949467812;4784.569388755029;4789.281607758794;4840.201366774513;5047.823326183566;5092;5107.821226257063;5226.503482169188;5311.867203319871;4934.481879402611;4959.652824302264;4984.352034235599;5042.294078828967;5113.1052065888325;5097.158968770185;5122.974385128051;5143.511366420259;5150.25290092233;5200.843974680765;4876.122297986397;5044;5064.468230835783;5087.31321271631;5087.847364579068;4818.180909245437;4955.925661115086;4964.60283177345;4965;4972.055309491185;4324.416203812508;4332.26351520236;4332.935005974913;4385.925448265196;4391.780410979438;3813.027677942107;3824.101336185994;3854.8265328060306;3857.672097871712;3924.9803750981064;4424.911501769947;4432.534583868647;4435.866923992286;4435.935375509855;4474.574915383034;4927.285543596158;4930.6795058321095;5110.97444512775;5180.404253510819;5241.344831896013;4382.408374869416;4386.7367957922625;4427.180971520279;4465.642748580106;4475.641948644101;4673.509281525391;4674.252119660906;4677.345171675968;4726.078414709167;4731;4553.430821147356;4584.88537786558;4792.544708252711;4797.136515427256;4841.661083724176;5020.523050310215;5095.388553373471;5103.795848166032;5164.922526162186;5234;4763.880902977315;4790.449098353734;4811.566958973709;4813.4945830687275;4837.080954618611;4892.363992680928;5076.390833100052;5085.466026067357;5090.414602320632;5149.948500514947;4975.577075948585;5014.674046186986;5064.898702026013;5076.670016448919;5084.8220312288895;4935.506449355179;4937.35814344133;4937.432195297587;4969;4975.0796102721115;4919.286703427912;4920.507949205194;4922.65541412112;4925.1627223372825;4928.186849169847;4826.638002149783;4843.685160464559;4880.6095512358215;4928.0390323886495;5036.8992620146655;5051.267566202807;5063.468335824686;5068.087744206078;5068.898622027613;5131.640785145004;4759.857204283877;4799.1601469743355;4951.084049450863;4965;4969.130402179677 02:39:36 INFO - PROCESS | 1558 | |1;ext.html;536.669947981991;540.624266135036;548.5227851768962;550.2873778456898;551.3659291814411;26546.20361389159;27811.58282625762;36678.633213667825;37800.24399512008;37886.43170352447;38232.617673823326;38565.80717096417;38616.22767544648;38627.420588691195;38686.419703704465;7090.326418990187;7597.658105385257;7750;7751.18612545683;7755.302022817945;7049.647517624124;9546.570404331787;9748;9766.755831104243;10133.138683211899;10090.445025523593;10151.593936242542;10155.187584993182;10160.4919754012;10161.542730577105;7114.466415018895;10015.248856335767;10077.344972576759;10088.092071713581;10089.445080520569;7057;9533.04669533048;10001.549930253155;10013.098821106063;10031.849522257173;36351.4547281791;36598.26803463916;36610;36730.26539469196;36863.81568092143;2881.683014868363;2894.9131526054252;2907.4039821836473;2930.575066615329;2937.133545604052;27106.322341941413;27430.862845685642;27650.723492765017;28302.575461368095;29232;3174.1429813950335;3286.6384697683234;3353.8826141085187;3389.1357703785625;3513.508108864761;159108;159835;160629.19685401616;160883.54256973258;160885.99999999884;52006.47993520092;52196.21705674418;52214.21678674823;52226;52254.47745522572;31748;32093.67906320907;32247;34477.310453790786;34495.82752086274;14768.704625907421;14937.775933361008;14941.327640256215;14946.850531494763;14955.775663365059;10025.799484010426;10197.18422526196;11419.257748246337;11512;11520.423978801027;15185.544433667008;15299.541013769605;15316.770248446282;17059.744103838453;17300.740488892676;6314.147590075373;6508.869822603521;6583.958972718473;6648.900266496006;6754.155730533684;798.4490701416005;822.6380392627225;851.714675583674;867.2065060469725;929.8143335671878;26093.869530652224;27869.58195627067;28155.43689126247;28331.858340708164;29776.702232977826;918.9218916392048;935.6163972771132;942.3215284994793;945.0502245243487;1011.2068793916782;13655.795163072364;14205.85794142066;14370.856291437161;14497.565073047825;14516.854831451761;330208;332259;332493;333762;580983.8557264933;40216.19567608632;46118.30822537665;47106.76446617745;47191.764041180264;51278;1139;1141.7316930521488;1164.6738913104343;1170.3153655111685;1171.420147027227;26940.865295673397;27603.585946211224;28342.149735507966;28611.284717881386;28652.85673571619;40492.595074048884;41334.37998430086;41395;41395.172096558505;41416;249105;249601;250200;250314;251946;24460.87769561141;24830.751692482845;24839.50320993606;24854.875725621256;24876.253712388658;39238.80380598193;39467.605323946394;40595.391069133395;40723.796381017906;40734.796326019365;30893.227669308446;33273;33959.83020084884;34511.65488345084;34607.30785384329;33691.3261734759;33895.32209355848;33991.320173595894;34041.48937765886;34234.82882585571;33258.667413326526;33778.662213378535;33884.830575846965;34035;34139.14652133617;29742.25644358908;30252.69747302587;30688.232794180323;30790.230244243176;31072.53391199179;23393.76606233984;23980.160694375612;24315.878420607783;24351.878240609392;24487.632685509376 02:39:36 INFO - PROCESS | 1558 | |2;jquery.html;330.8031721125929;342.29999650714285;352;352.8853122735111;376.72687301706264;12365.46507965867;15636.530904072883;15782.368705251805;16358.918205408956;16445.506634800946;15845.683086338266;16039.198040098006;16377.590560236;16741.497755067336;16904.408345707903;5023.120953833074;5134.229865520165;5214.217867319913;5257.395399529065;5258;5322.574194064485;5519.475649813261;5528.06022976095;5529.364123125852;5529.474699903502;3369.326134773043;3538.31002954424;5206.713630750307;5413.593980451462;5443.673379597237;5267.28891599633;5517.917231241535;5525.309336332958;5532.446755324436;5535.6955367454775;5191.221316802472;5214.270002199695;5224.164133738622;5224.947750522484;5226.372835259755;11644.18490705651;11654.30074195551;11687.298762074217;11760.58837940668;11825.349605771678;1816.3642725046261;1845.5847434327304;1965.6068786242665;1996.161612122912;2012.175008246612;8377;9189.632414703405;9379.108984646447;9571.617135314578;9684.370515916444;1698.9150542472828;1758.34062226665;1773.272958087191;1802.9549261268442;1814.3014939248353;65115.674421628064;69742;70904.6454767728;71546.64226678833;72589.27410725878;9722.673410332334;9889.554970026365;10054.497275136215;10246.821615514162;10273.383596984055;13930.860691392956;13938;13951.790723139162;13965.231912244924;13996.69054605999;6631.535792494479;6778.864422711518;6822.692978815965;6836.794896153124;6885.414739747077;6094.969525152346;6223.533235007392;6310.9368906311265;6323.114763933053;6356.427921486996;4128.814203360856;4262.46719160105;4300.677449191323;4376.518582955872;4388.956110438919;1796.2096677461875;1816.5640246340784;1845.6954602490707;1846.4368367647728;1849.3527265456983;797.9561124138228;846.386369881843;857.6612238166015;877.4910551879894;918.9632414703337;16438.506844794676;16592.08743519094;16734.832651673572;17101;17538.210780514906;825.7894236969535;839.3716190590235;849.9745007649781;853.2320911179987;873.0745409865563;9250.259979201783;10139.543720532594;10179.898201018043;10507.737306567396;10628.840567391495;356650;360188;361807;364846;364921;48387.51612483901;48638;48736.51263487391;60775.08837367443;78253;897.5601955042113;921.1847514949318;935.569637966543;939.2345238630494;945.7162851144767;15434.922825385802;15438.382464701735;16197.4330898418;16331.995973041405;16489.09309987962;36308.455373168894;36589.26821463609;36742.63257367392;37248.62751372452;37634.24731505409;48783.268250975554;50936;51382;52054.73972630264;52085.73957130342;7578.12851522082;7677.462577619513;7682.961585192038;7857.842843142991;7973.242541958504;9220.769480763034;11264.66206013821;11335.773284534429;11730.824037639613;11746.76506469883;10245.231607629308;10345.431001295;10355.119814815826;10364.170866330525;10480.266381353233;9989.550470229002;10260.794784104426;10406.427646479517;10483.21375896826;10486.318389304672;9905;10045.09594136502;10218.335808172445;10305.896941030795;10360.119389851947;7380.557166570023;7396;7482.1021477423055;7495.625218738932;7595.3164215220895;8917.197452229331;9994.10053095225;10229.795404092025;10451.738706532398;10465.110465610203 02:39:36 INFO - PROCESS | 1558 | |3;mootools.html;1240.2372540887357;1349.1163288046328;1373.2721657521513;1430.9427622895084;1650.8184099749026;6557.704903279352;7375.778726638203;7671.7314893978655;7728.65221065052;7952.085510166333;7786.727464538742;7822.295993360596;7827.099883513398;7852.214778522145;7859.68561257549;2083.468715477551;2097.674860396641;2105.589410065038;2111.6515774897125;2115.1433669363932;2018.2330714328534;2034.6032523657893;2044.1925439451409;2097.307888396833;2100.369889033284;2087.060822629815;2093.528955984899;2103.7054812326287;2106.926257580985;2107.2413930984835;2030.0661695620033;2041.6733322668376;2047.2732180076157;2051.128270485053;2054.3836848945407;1991.0641998260794;2000.0399808092197;2032.2785411178966;2036.5010572409853;2040.9795902040937;7694.115176754633;7786.454948153631;7793.844123117506;7827.608619568999;7832.060152781646;4046.817893194813;4276.700630955835;4276.850310239158;4304.634106100985;4307.870763877088;2796.258991367289;2900.608417863604;2960.230340111565;2975.4197931403387;2985.8656360463833;904.1410659873147;905.2531661379388;924.4037595750771;929.5770424456856;932.6176267730198;10518.474076296154;10574.312669676523;10626.203034772423;10635.840462393071;10662.78674426515;3599.9640003600152;3696.5009723687494;3743.681787048077;3846.076941534068;3875.7093218008763;8263.669453221804;8278.958605207055;8284;8306.8338633227;8317.334613230927;4363.258246098171;4366.345048242789;4368.475782906072;4369.279068953587;4381.38660587518;3517.8592856285463;3625.728070394678;4024;4090.9181816364103;4094.61101195386;3019.531972544259;3080.2299425143715;3146.197719581492;3148.3703259347762;3192.2179066128483;983.8081574093127;990.108901988202;999.1008092716468;1005.7988402319565;1012.4229189361993;708.9716411343488;825.7646570727314;827.1067247372823;847.5338563789891;866.138192498468;4976.42771081323;4976.975115124474;4995.375578052744;5118.923216151761;5226.268322434862;372.9216864458494;884.9070847561043;928.3037721708719;941.0122859919727;985.261054209343;3374.0633833360516;3515.241517125212;3531.29374125176;3621.8913432597064;3690.8523659053876;9470.668526601536;9631.566579503939;9780.804383912282;9796.216302695768;9846.852297215548;9781.657641982496;9798.216142708567;9802.803943921082;9814.165795907285;9831.852522212173;7262.709491620381;7395.85208295831;7399.297066778648;7409.999650047174;7413.703451861973;4980.178270585313;5042;5052.115879721107;5087.262346959744;5271;8511.531865747444;8614.22471977525;8620.956895215484;8656.567171641518;8657.047724750399;8515.872261915953;8766.693165739169;8792;8848.159424854628;8985.550722463982;6303.590266632654;6467.7736279231885;6468;6471.094046833541;6527.086207930988;7306.232845551353;7644.350230230492;7652.923470765444;7657.540547567164;7677.769666910001;6747.460203183831;6774.3225677431865;6873.381395674413;6989.47578931572;7097.503174777716;6397.360263973565;6728.966355168192;6808.217055038734;6822.317768223138;6907.758228461979;5955.642661440327;6009.579329446897;6012.248468941382;6015.39846015395;6021.969890150521;4296.677749168763;4394.1651086293505;4481.574250446202;4531.093781243699;4570.200214962435;4269.359596060615;4382.430284063052;4392.736435813861;4552.5447455255535;4584.793684284282 02:39:36 INFO - PROCESS | 1558 | |4;prototype.html;274.1214407822927;279.1124224964612;282.3945867741887;284.2694275711421;285.1445663010967;4742.762861856911;4879.487653796354;4933.654644174909;4938.506149385064;4957.62817788666;4693.342931989524;4854.587360074389;4869.586085182764;4870.853874383774;4878.560929516343;3557.430811070229;3685.2076803487244;3835.5780864104927;3839.6544311012003;3862.6909847212296;3717.3866312058476;3817.7136714746366;3830.3488406970882;3839.6544311012003;3839.985611295134;3795.8102094895144;3796.335641262782;3799.67702745267;3800.524934383202;3807.428885667144;3795.69634429245;3802.6007269236884;3805.4101614249557;3811.790351530665;3814.675752561022;3110.844457777102;3234.450143475615;3257.332246889382;3274.787138835968;3346.1467325832;4738.8863617049965;4747.501512341189;4753.5959443447;4754.263089221176;4762.64280178988;4055.959440405588;4278.764667943262;4296.398504209413;4297.333913243452;4311.417958575615;5101.923471147936;5106.361704786902;5125.8718532037;5132.0241706942725;5137.5633071188995;3503.1417302760733;3503.3518799022263;3518.4546395308766;3520.524729161556;3523.119220194951;5302.040455442997;5365.490278423544;5396;5400.678582671668;5406.324209473776;3539.982300088483;3624.257027309395;3624.9093772655897;3652.634736526326;3657.231981283907;3670.33933891902;3673.3755261605056;3680.705543556509;3692.3538380783257;3706.6849317808287;4249.80875860587;4260.55264197261;4267.231898258281;4277.465316835395;4294.592013758688;4866.82966096192;4887.3890763654545;4950.683042361627;5020;5143.71709555978;1220.371508673034;1245.1097465312346;1245.3747859044036;1247.8939290160438;1251.4931452761646;765.4412279036335;792.5363662257644;804.3042768005633;808.8958571549792;812.626191951697;4004.199160167978;4009.859654912064;4018.5286049079605;4021.722296328483;4054.033793610097;4596.5863072323655;4630.5226703714025;4654.627629789608;4657.417822772153;4663.673542851968;4010;4010.839566417311;4017.417474466186;4022.5518813227213;4028.879133625996;2337.2520793345966;2468.469279105001;2481.95036099277;2486.4529803443215;2493.987530062338;4393.594049904064;4402.779861006937;4411.514733379326;4412.580804823537;4415.315626077963;4766.904661906812;4811.639127065484;4832.806687732522;4843.806247750051;4849.58104536301;4330.826766929287;4348.260795664744;4581.610563102174;4970.950290497121;5027.472115427974;5338.57291416678;5347.598930080182;5348.325837081459;5352.330958630171;5384.6769193848495;5283.388566487259;5291.629585928948;5299.44355842631;5305.840824775263;5315.495027972336;4895.46149923501;4949.802007919643;4982.302477653059;4993.375828021497;5016.398032236155;3734.5891951885815;3739.9813000934823;3747.662710356081;3753.099256178443;3777.131259810314;5104.336436263262;5349.117395629678;5374.7581358839725;5385.596080293915;5398.379186393615;4908.656394052382;5094.337736094284;5123.41174235988;5134.484102789532;5147.918937023267;5180.9740951295;5181.715005674724;5186.273921650896;5186.6369354144845;5198.376194856642;4903.190973489477;5075.695458272516;5107.131787596192;5107.693538387709;5123.231515272739;5189.455107213688;5190.429052804264;5198.246254293031;5199.922001170061;5204.713740744295;5059.392872855281;5071.467495912876;5074.923876141787;5082.161443361804;5090.516400941905 02:39:36 INFO - PROCESS | 1558 | |5;yui.html;609.4185588398107;615.6736929427402;632.4876849751698;712.7327252280395;746.3544034410235;13022.674433139164;13484.932575337134;13515.932420337896;13521.59435216945;13619.79570306445;13485.39315730792;13493.797593036088;13518.324083795795;13567.05030647855;13575.117617354865;584.2638275772536;599.0983569727554;721.5418209437019;724.7789424225609;742.6917829100944;726.1685370251059;733.8458923626018;734.6914295995695;734.8603765284605;735.7535225699397;788.7949133225374;788.9566073865935;789.0728394136895;792.1444839573276;793.2820797178563;616.1897105306508;632.6773345593734;765;784.396015068397;784.5292824305428;557.5288880895637;572.7508533787816;573.5612256623687;573.5669569475061;573.6816067082767;12308.569200078044;12394.194377365442;12450.937745311216;12465.314407707572;12481.687957801038;11192.944035279854;11609.01323387513;11664.708382290426;11667.708307292385;12760.234385936781;11056.723581910435;11095.852787695672;11199.496022678999;11303.491342889507;11347.205695601311;4010.979945100285;4028.4158796974566;4122.9381559276635;4123.814428350732;4162.458880345535;62333.68833155805;63586.68206658937;63626.36373636297;65009.67495162494;65365.34634653688;9641.27690423221;10267.94866025665;10290.845637315446;10311.278210525192;10369.585216591402;16204.513864584082;17086.658266834595;17105.657886842444;17178.74231886523;17181.398651047402;6486.772962946275;6601.042848786899;6606.174228221473;6717.1267735194115;6781.898271525931;3644.599094099647;3668.6881615063016;3689.409694448875;3716.089558058293;3763.9247215055548;2711.8779654915575;2788.2332358601548;2789.609454676347;2796.398774263543;2804.270889568686;449.1488629047936;455.78350283615015;458.2644855007731;465.36245343878426;467.3247157856864;444.4089361149663;527.5911168844176;532.9520343169133;539.3446961941182;553.1923391847866;7873.212678732081;8035.397345199133;8383.496990180609;8745.387822852466;8838.337124715543;545.5771776872955;567.1181313058152;571.5798887817451;602.3223873142714;603.4177019176516;3849.4610754494392;4037.2329257440992;4253.936190957138;4273.401723758676;4316.417283666665;102304;103721;104281;105338.47330763297;105499;65063.67468162629;66120;66258;79237.60381198057;89952;41034.1793164141;71454;72551.63724181346;72845.27154728491;76772.61613692007;8586.313094952264;8710.172533609297;8807.603657835542;8860.86708699357;9095.590698418719;44506.3324050146;45057.774711126236;45177.54822451733;46015.539844601124;46145;62433.68783156055;64231.67884160549;64935.35064649293;65827.6708616473;69280;10363.533640986325;10717.732056698645;10750.139988801033;10759.13926885863;10790.244682872124;11999.16005879615;12335.951444126991;12372.90334168169;12682.809757853454;12805.74388512206;12531.590153821691;12612.621621351374;12637.304948227937;12971.286579238233;13018.544350947672;11507.482163302839;11740.712600471881;12081.939590301992;12214.450349734461;12219.26684398939;12025.579104731292;12046.457909393923;12251.632451026484;12655.177413468095;12740.108192426442;10127.594896204364;10150.949245254022;10426.270161088954;10515;10545.31455455393;10447.42539160323;10475.452841973767;11027.724306892393;11048.613298534834;11074.612388566684 02:39:36 INFO - PROCESS | 1558 | __end_tp_report 02:39:36 INFO - PROCESS | 1558 | __start_cc_report 02:39:36 INFO - PROCESS | 1558 | _x_x_mozilla_cycle_collect,1794 02:39:36 INFO - PROCESS | 1558 | __end_cc_report 02:39:36 INFO - PROCESS | 1558 | __startTimestamp1476005976125__endTimestamp 02:39:36 INFO - PROCESS | 1558 | 02:39:36 INFO - PROCESS | 1558 | ------- Summary: start ------- 02:39:36 INFO - PROCESS | 1558 | Number of tests: 6 02:39:36 INFO - PROCESS | 1558 | 02:39:36 INFO - PROCESS | 1558 | [#0] dojo.html Cycles:165 Average:4713.60 Median:4826.64 stddev:484.59 (10.0%) stddev-sans-first:457.17 02:39:36 INFO - PROCESS | 1558 | Values: 2611.9 2643.8 2664.0 2681.4 2693.3 4669.1 4722.0 4735.4 4847.7 4919.0 4750.5 4757.3 4769.2 4791.4 4872.6 4314.6 4325.4 4369.0 4414.3 4414.6 4140.7 4443.3 4461.7 4499.1 4546.4 4269.8 4429.6 4431.4 4443.4 4520.0 4306.5 4347.2 4376.5 4385.4 4396.0 4333.2 4338.3 4343.4 4391.8 4407.3 4765.7 4779.8 4787.7 4793.5 4809.5 4968.4 5008.0 5049.8 5078.0 5109.8 5134.2 5136.5 5144.7 5184.9 5185.9 4777.9 4782.7 4784.6 4789.3 4840.2 5047.8 5092.0 5107.8 5226.5 5311.9 4934.5 4959.7 4984.4 5042.3 5113.1 5097.2 5123.0 5143.5 5150.3 5200.8 4876.1 5044.0 5064.5 5087.3 5087.8 4818.2 4955.9 4964.6 4965.0 4972.1 4324.4 4332.3 4332.9 4385.9 4391.8 3813.0 3824.1 3854.8 3857.7 3925.0 4424.9 4432.5 4435.9 4435.9 4474.6 4927.3 4930.7 5111.0 5180.4 5241.3 4382.4 4386.7 4427.2 4465.6 4475.6 4673.5 4674.3 4677.3 4726.1 4731.0 4553.4 4584.9 4792.5 4797.1 4841.7 5020.5 5095.4 5103.8 5164.9 5234.0 4763.9 4790.4 4811.6 4813.5 4837.1 4892.4 5076.4 5085.5 5090.4 5149.9 4975.6 5014.7 5064.9 5076.7 5084.8 4935.5 4937.4 4937.4 4969.0 4975.1 4919.3 4920.5 4922.7 4925.2 4928.2 4826.6 4843.7 4880.6 4928.0 5036.9 5051.3 5063.5 5068.1 5068.9 5131.6 4759.9 4799.2 4951.1 4965.0 4969.1 02:39:36 INFO - PROCESS | 1558 | 02:39:36 INFO - PROCESS | 1558 | [#1] ext.html Cycles:180 Average:41577.20 Median:17766.82 stddev:75544.07 (425.2%) stddev-sans-first:75693.14 02:39:36 INFO - PROCESS | 1558 | Values: 536.7 540.6 548.5 550.3 551.4 26546.2 27811.6 36678.6 37800.2 37886.4 38232.6 38565.8 38616.2 38627.4 38686.4 7090.3 7597.7 7750.0 7751.2 7755.3 7049.6 9546.6 9748.0 9766.8 10133.1 10090.4 10151.6 10155.2 10160.5 10161.5 7114.5 10015.2 10077.3 10088.1 10089.4 7057.0 9533.0 10001.5 10013.1 10031.8 36351.5 36598.3 36610.0 36730.3 36863.8 2881.7 2894.9 2907.4 2930.6 2937.1 27106.3 27430.9 27650.7 28302.6 29232.0 3174.1 3286.6 3353.9 3389.1 3513.5 159108.0 159835.0 160629.2 160883.5 160886.0 52006.5 52196.2 52214.2 52226.0 52254.5 31748.0 32093.7 32247.0 34477.3 34495.8 14768.7 14937.8 14941.3 14946.9 14955.8 10025.8 10197.2 11419.3 11512.0 11520.4 15185.5 15299.5 15316.8 17059.7 17300.7 6314.1 6508.9 6584.0 6648.9 6754.2 798.4 822.6 851.7 867.2 929.8 26093.9 27869.6 28155.4 28331.9 29776.7 918.9 935.6 942.3 945.1 1011.2 13655.8 14205.9 14370.9 14497.6 14516.9 330208.0 332259.0 332493.0 333762.0 580983.9 40216.2 46118.3 47106.8 47191.8 51278.0 1139.0 1141.7 1164.7 1170.3 1171.4 26940.9 27603.6 28342.1 28611.3 28652.9 40492.6 41334.4 41395.0 41395.2 41416.0 249105.0 249601.0 250200.0 250314.0 251946.0 24460.9 24830.8 24839.5 24854.9 24876.3 39238.8 39467.6 40595.4 40723.8 40734.8 30893.2 33273.0 33959.8 34511.7 34607.3 33691.3 33895.3 33991.3 34041.5 34234.8 33258.7 33778.7 33884.8 34035.0 34139.1 29742.3 30252.7 30688.2 30790.2 31072.5 23393.8 23980.2 24315.9 24351.9 24487.6 02:39:36 INFO - PROCESS | 1558 | 02:39:36 INFO - PROCESS | 1558 | [#2] jquery.html Cycles:180 Average:22643.75 Median:4281.57 stddev:59606.64 (1392.2%) stddev-sans-first:59750.30 02:39:36 INFO - PROCESS | 1558 | Values: 330.8 342.3 352.0 352.9 376.7 12365.5 15636.5 15782.4 16358.9 16445.5 15845.7 16039.2 16377.6 16741.5 16904.4 5023.1 5134.2 5214.2 5257.4 5258.0 5322.6 5519.5 5528.1 5529.4 5529.5 3369.3 3538.3 5206.7 5413.6 5443.7 5267.3 5517.9 5525.3 5532.4 5535.7 5191.2 5214.3 5224.2 5224.9 5226.4 11644.2 11654.3 11687.3 11760.6 11825.3 1816.4 1845.6 1965.6 1996.2 2012.2 8377.0 9189.6 9379.1 9571.6 9684.4 1698.9 1758.3 1773.3 1803.0 1814.3 65115.7 69742.0 70904.6 71546.6 72589.3 9722.7 9889.6 10054.5 10246.8 10273.4 13930.9 13938.0 13951.8 13965.2 13996.7 6631.5 6778.9 6822.7 6836.8 6885.4 6095.0 6223.5 6310.9 6323.1 6356.4 4128.8 4262.5 4300.7 4376.5 4389.0 1796.2 1816.6 1845.7 1846.4 1849.4 798.0 846.4 857.7 877.5 919.0 16438.5 16592.1 16734.8 17101.0 17538.2 825.8 839.4 850.0 853.2 873.1 9250.3 10139.5 10179.9 10507.7 10628.8 356650.0 360188.0 361807.0 364846.0 364921.0 48387.5 48638.0 48736.5 60775.1 78253.0 897.6 921.2 935.6 939.2 945.7 15434.9 15438.4 16197.4 16332.0 16489.1 36308.5 36589.3 36742.6 37248.6 37634.2 48783.3 50936.0 51382.0 52054.7 52085.7 7578.1 7677.5 7683.0 7857.8 7973.2 9220.8 11264.7 11335.8 11730.8 11746.8 10245.2 10345.4 10355.1 10364.2 10480.3 9989.6 10260.8 10406.4 10483.2 10486.3 9905.0 10045.1 10218.3 10305.9 10360.1 7380.6 7396.0 7482.1 7495.6 7595.3 8917.2 9994.1 10229.8 10451.7 10465.1 02:39:36 INFO - PROCESS | 1558 | 02:39:36 INFO - PROCESS | 1558 | [#3] mootools.html Cycles:180 Average:5001.82 Median:5172.60 stddev:2881.45 (55.7%) stddev-sans-first:2875.67 02:39:36 INFO - PROCESS | 1558 | Values: 1240.2 1349.1 1373.3 1430.9 1650.8 6557.7 7375.8 7671.7 7728.7 7952.1 7786.7 7822.3 7827.1 7852.2 7859.7 2083.5 2097.7 2105.6 2111.7 2115.1 2018.2 2034.6 2044.2 2097.3 2100.4 2087.1 2093.5 2103.7 2106.9 2107.2 2030.1 2041.7 2047.3 2051.1 2054.4 1991.1 2000.0 2032.3 2036.5 2041.0 7694.1 7786.5 7793.8 7827.6 7832.1 4046.8 4276.7 4276.9 4304.6 4307.9 2796.3 2900.6 2960.2 2975.4 2985.9 904.1 905.3 924.4 929.6 932.6 10518.5 10574.3 10626.2 10635.8 10662.8 3600.0 3696.5 3743.7 3846.1 3875.7 8263.7 8279.0 8284.0 8306.8 8317.3 4363.3 4366.3 4368.5 4369.3 4381.4 3517.9 3625.7 4024.0 4090.9 4094.6 3019.5 3080.2 3146.2 3148.4 3192.2 983.8 990.1 999.1 1005.8 1012.4 709.0 825.8 827.1 847.5 866.1 4976.4 4977.0 4995.4 5118.9 5226.3 372.9 884.9 928.3 941.0 985.3 3374.1 3515.2 3531.3 3621.9 3690.9 9470.7 9631.6 9780.8 9796.2 9846.9 9781.7 9798.2 9802.8 9814.2 9831.9 7262.7 7395.9 7399.3 7410.0 7413.7 4980.2 5042.0 5052.1 5087.3 5271.0 8511.5 8614.2 8621.0 8656.6 8657.0 8515.9 8766.7 8792.0 8848.2 8985.6 6303.6 6467.8 6468.0 6471.1 6527.1 7306.2 7644.4 7652.9 7657.5 7677.8 6747.5 6774.3 6873.4 6989.5 7097.5 6397.4 6729.0 6808.2 6822.3 6907.8 5955.6 6009.6 6012.2 6015.4 6022.0 4296.7 4394.2 4481.6 4531.1 4570.2 4269.4 4382.4 4392.7 4552.5 4584.8 02:39:36 INFO - PROCESS | 1558 | 02:39:36 INFO - PROCESS | 1558 | [#4] prototype.html Cycles:180 Average:4147.98 Median:4656.02 stddev:1242.04 (26.7%) stddev-sans-first:1211.01 02:39:36 INFO - PROCESS | 1558 | Values: 274.1 279.1 282.4 284.3 285.1 4742.8 4879.5 4933.7 4938.5 4957.6 4693.3 4854.6 4869.6 4870.9 4878.6 3557.4 3685.2 3835.6 3839.7 3862.7 3717.4 3817.7 3830.3 3839.7 3840.0 3795.8 3796.3 3799.7 3800.5 3807.4 3795.7 3802.6 3805.4 3811.8 3814.7 3110.8 3234.5 3257.3 3274.8 3346.1 4738.9 4747.5 4753.6 4754.3 4762.6 4056.0 4278.8 4296.4 4297.3 4311.4 5101.9 5106.4 5125.9 5132.0 5137.6 3503.1 3503.4 3518.5 3520.5 3523.1 5302.0 5365.5 5396.0 5400.7 5406.3 3540.0 3624.3 3624.9 3652.6 3657.2 3670.3 3673.4 3680.7 3692.4 3706.7 4249.8 4260.6 4267.2 4277.5 4294.6 4866.8 4887.4 4950.7 5020.0 5143.7 1220.4 1245.1 1245.4 1247.9 1251.5 765.4 792.5 804.3 808.9 812.6 4004.2 4009.9 4018.5 4021.7 4054.0 4596.6 4630.5 4654.6 4657.4 4663.7 4010.0 4010.8 4017.4 4022.6 4028.9 2337.3 2468.5 2482.0 2486.5 2494.0 4393.6 4402.8 4411.5 4412.6 4415.3 4766.9 4811.6 4832.8 4843.8 4849.6 4330.8 4348.3 4581.6 4971.0 5027.5 5338.6 5347.6 5348.3 5352.3 5384.7 5283.4 5291.6 5299.4 5305.8 5315.5 4895.5 4949.8 4982.3 4993.4 5016.4 3734.6 3740.0 3747.7 3753.1 3777.1 5104.3 5349.1 5374.8 5385.6 5398.4 4908.7 5094.3 5123.4 5134.5 5147.9 5181.0 5181.7 5186.3 5186.6 5198.4 4903.2 5075.7 5107.1 5107.7 5123.2 5189.5 5190.4 5198.2 5199.9 5204.7 5059.4 5071.5 5074.9 5082.2 5090.5 02:39:36 INFO - PROCESS | 1558 | 02:39:36 INFO - PROCESS | 1558 | [#5] yui.html Cycles:180 Average:17618.23 Median:4143.14 stddev:25136.26 (606.7%) stddev-sans-first:25174.33 02:39:36 INFO - PROCESS | 1558 | Values: 609.4 615.7 632.5 712.7 746.4 13022.7 13484.9 13515.9 13521.6 13619.8 13485.4 13493.8 13518.3 13567.1 13575.1 584.3 599.1 721.5 724.8 742.7 726.2 733.8 734.7 734.9 735.8 788.8 789.0 789.1 792.1 793.3 616.2 632.7 765.0 784.4 784.5 557.5 572.8 573.6 573.6 573.7 12308.6 12394.2 12450.9 12465.3 12481.7 11192.9 11609.0 11664.7 11667.7 12760.2 11056.7 11095.9 11199.5 11303.5 11347.2 4011.0 4028.4 4122.9 4123.8 4162.5 62333.7 63586.7 63626.4 65009.7 65365.3 9641.3 10267.9 10290.8 10311.3 10369.6 16204.5 17086.7 17105.7 17178.7 17181.4 6486.8 6601.0 6606.2 6717.1 6781.9 3644.6 3668.7 3689.4 3716.1 3763.9 2711.9 2788.2 2789.6 2796.4 2804.3 449.1 455.8 458.3 465.4 467.3 444.4 527.6 533.0 539.3 553.2 7873.2 8035.4 8383.5 8745.4 8838.3 545.6 567.1 571.6 602.3 603.4 3849.5 4037.2 4253.9 4273.4 4316.4 102304.0 103721.0 104281.0 105338.5 105499.0 65063.7 66120.0 66258.0 79237.6 89952.0 41034.2 71454.0 72551.6 72845.3 76772.6 8586.3 8710.2 8807.6 8860.9 9095.6 44506.3 45057.8 45177.5 46015.5 46145.0 62433.7 64231.7 64935.4 65827.7 69280.0 10363.5 10717.7 10750.1 10759.1 10790.2 11999.2 12336.0 12372.9 12682.8 12805.7 12531.6 12612.6 12637.3 12971.3 13018.5 11507.5 11740.7 12081.9 12214.5 12219.3 12025.6 12046.5 12251.6 12655.2 12740.1 10127.6 10150.9 10426.3 10515.0 10545.3 10447.4 10475.5 11027.7 11048.6 11074.6 02:39:36 INFO - PROCESS | 1558 | -------- Summary: end -------- 02:39:36 INFO - PROCESS | 1558 | 02:39:37 INFO - TEST-INFO | 1558: exit 0 02:39:37 INFO - TEST-OK | dromaeo_css | took 1122292ms 02:39:37 INFO - TEST-START | kraken 02:39:37 INFO - operating with platform_type : linux_ 02:39:37 INFO - Initialising browser for kraken test... 02:39:37 INFO - TEST-INFO | started process 1858 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMwq0Qv/profile http://localhost:56544/getInfo.html) 02:39:41 INFO - PROCESS | 1858 | __metrics Screen width/height:1600/1200 02:39:41 INFO - PROCESS | 1858 | colorDepth:24 02:39:41 INFO - PROCESS | 1858 | Browser inner width/height: 1024/697 02:39:41 INFO - PROCESS | 1858 | __metrics 02:39:42 INFO - PROCESS | 1858 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 02:39:42 INFO - PROCESS | 1858 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:39:42 INFO - PROCESS | 1858 | console.error: PushService: 02:39:42 INFO - PROCESS | 1858 | stateChangeProcessEnqueue: Error transitioning state 02:39:42 INFO - PROCESS | 1858 | UnknownError 02:39:43 INFO - TEST-INFO | 1858: exit 0 02:39:43 INFO - Browser initialized. 02:39:43 INFO - Running cycle 1/1 for kraken test... 02:39:43 INFO - TEST-INFO | started process 1941 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMwq0Qv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:39:55 INFO - PROCESS | 1941 | RSS: Main: 174092288 02:39:55 INFO - PROCESS | 1941 | 02:39:58 INFO - PROCESS | 1941 | Cycle 1(1): loaded http://localhost:56544/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56544/tests/kraken/driver.html?testName=audio-beat-detection) 02:39:59 INFO - PROCESS | 1941 | RSS: Main: 233455616 02:39:59 INFO - PROCESS | 1941 | 02:40:02 INFO - PROCESS | 1941 | Cycle 1(1): loaded http://localhost:56544/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56544/tests/kraken/driver.html?testName=audio-dft) 02:40:02 INFO - PROCESS | 1941 | RSS: Main: 217763840 02:40:02 INFO - PROCESS | 1941 | 02:40:05 INFO - PROCESS | 1941 | Cycle 1(1): loaded http://localhost:56544/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56544/tests/kraken/driver.html?testName=audio-fft) 02:40:06 INFO - PROCESS | 1941 | RSS: Main: 300216320 02:40:06 INFO - PROCESS | 1941 | 02:40:08 INFO - PROCESS | 1941 | Cycle 1(1): loaded http://localhost:56544/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56544/tests/kraken/driver.html?testName=audio-oscillator) 02:40:09 INFO - PROCESS | 1941 | RSS: Main: 210681856 02:40:09 INFO - PROCESS | 1941 | 02:40:11 INFO - PROCESS | 1941 | Cycle 1(1): loaded http://localhost:56544/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56544/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:40:12 INFO - PROCESS | 1941 | RSS: Main: 213372928 02:40:12 INFO - PROCESS | 1941 | 02:40:15 INFO - PROCESS | 1941 | Cycle 1(1): loaded http://localhost:56544/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56544/tests/kraken/driver.html?testName=imaging-darkroom) 02:40:16 INFO - PROCESS | 1941 | RSS: Main: 250191872 02:40:16 INFO - PROCESS | 1941 | 02:40:19 INFO - PROCESS | 1941 | Cycle 1(1): loaded http://localhost:56544/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56544/tests/kraken/driver.html?testName=imaging-desaturate) 02:40:20 INFO - PROCESS | 1941 | RSS: Main: 248868864 02:40:20 INFO - PROCESS | 1941 | 02:40:22 INFO - PROCESS | 1941 | Cycle 1(1): loaded http://localhost:56544/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56544/tests/kraken/driver.html?testName=json-parse-financial) 02:40:23 INFO - PROCESS | 1941 | RSS: Main: 248872960 02:40:23 INFO - PROCESS | 1941 | 02:40:25 INFO - PROCESS | 1941 | Cycle 1(1): loaded http://localhost:56544/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56544/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:40:25 INFO - PROCESS | 1941 | RSS: Main: 211439616 02:40:25 INFO - PROCESS | 1941 | 02:40:27 INFO - PROCESS | 1941 | Cycle 1(1): loaded http://localhost:56544/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56544/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:40:28 INFO - PROCESS | 1941 | RSS: Main: 218771456 02:40:28 INFO - PROCESS | 1941 | 02:40:30 INFO - PROCESS | 1941 | Cycle 1(1): loaded http://localhost:56544/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56544/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:40:31 INFO - PROCESS | 1941 | RSS: Main: 227651584 02:40:31 INFO - PROCESS | 1941 | 02:40:34 INFO - PROCESS | 1941 | Cycle 1(1): loaded http://localhost:56544/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56544/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:40:34 INFO - PROCESS | 1941 | RSS: Main: 235593728 02:40:34 INFO - PROCESS | 1941 | 02:40:37 INFO - PROCESS | 1941 | Cycle 1(1): loaded http://localhost:56544/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56544/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:40:38 INFO - PROCESS | 1941 | RSS: Main: 232517632 02:40:38 INFO - PROCESS | 1941 | 02:40:40 INFO - PROCESS | 1941 | Cycle 1(1): loaded http://localhost:56544/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56544/tests/kraken/driver.html?testName=ai-astar) 02:40:40 INFO - PROCESS | 1941 | RSS: Main: 283185152 02:40:40 INFO - PROCESS | 1941 | 02:40:40 INFO - PROCESS | 1941 | __start_tp_report 02:40:40 INFO - PROCESS | 1941 | _x_x_mozilla_page_load 02:40:40 INFO - PROCESS | 1941 | _x_x_mozilla_page_load_details 02:40:40 INFO - PROCESS | 1941 | |i|pagename|runs| 02:40:40 INFO - PROCESS | 1941 | |0;ai-astar;113;115;113;115;113;115;113;114;114;114 02:40:40 INFO - PROCESS | 1941 | |1;audio-beat-detection;154;126;127;168;147;132;132;128;158;126 02:40:40 INFO - PROCESS | 1941 | |2;audio-dft;161;161;162;161;160;159;162;161;161;161 02:40:40 INFO - PROCESS | 1941 | |3;audio-fft;76;75;86;108;76;77;77;77;105;75 02:40:40 INFO - PROCESS | 1941 | |4;audio-oscillator;84;83;120;83;83;83;105;83;82;121 02:40:40 INFO - PROCESS | 1941 | |5;imaging-gaussian-blur;118;118;117;117;117;116;117;116;117;117 02:40:40 INFO - PROCESS | 1941 | |6;imaging-darkroom;147;147;146;146;146;146;146;146;147;146 02:40:40 INFO - PROCESS | 1941 | |7;imaging-desaturate;95;95;95;95;96;95;95;95;95;95 02:40:40 INFO - PROCESS | 1941 | |8;json-parse-financial;64;63;64;62;64;64;66;65;64;64 02:40:40 INFO - PROCESS | 1941 | |9;json-stringify-tinderbox;66;66;66;67;67;67;66;67;66;67 02:40:40 INFO - PROCESS | 1941 | |10;stanford-crypto-aes;83;82;83;83;90;83;83;86;83;84 02:40:40 INFO - PROCESS | 1941 | |11;stanford-crypto-ccm;147;140;139;139;137;139;141;145;175;142 02:40:40 INFO - PROCESS | 1941 | |12;stanford-crypto-pbkdf2;173;175;173;178;182;174;174;180;176;177 02:40:40 INFO - PROCESS | 1941 | |13;stanford-crypto-sha256-iterative;70;70;71;70;70;70;70;70;69;71 02:40:40 INFO - PROCESS | 1941 | __end_tp_report 02:40:40 INFO - PROCESS | 1941 | __start_cc_report 02:40:40 INFO - PROCESS | 1941 | _x_x_mozilla_cycle_collect,1951 02:40:40 INFO - PROCESS | 1941 | __end_cc_report 02:40:40 INFO - PROCESS | 1941 | __startTimestamp1476006040428__endTimestamp 02:40:40 INFO - PROCESS | 1941 | 02:40:40 INFO - PROCESS | 1941 | ------- Summary: start ------- 02:40:40 INFO - PROCESS | 1941 | Number of tests: 14 02:40:40 INFO - PROCESS | 1941 | 02:40:40 INFO - PROCESS | 1941 | [#0] ai-astar Cycles:10 Average:113.90 Median:114.00 stddev:0.88 (0.8%) stddev-sans-first:0.87 02:40:40 INFO - PROCESS | 1941 | Values: 113.0 115.0 113.0 115.0 113.0 115.0 113.0 114.0 114.0 114.0 02:40:40 INFO - PROCESS | 1941 | 02:40:40 INFO - PROCESS | 1941 | [#1] audio-beat-detection Cycles:10 Average:139.80 Median:139.50 stddev:15.58 (11.2%) stddev-sans-first:15.66 02:40:40 INFO - PROCESS | 1941 | Values: 154.0 126.0 127.0 168.0 147.0 132.0 132.0 128.0 158.0 126.0 02:40:40 INFO - PROCESS | 1941 | 02:40:40 INFO - PROCESS | 1941 | [#2] audio-dft Cycles:10 Average:160.90 Median:161.00 stddev:0.88 (0.5%) stddev-sans-first:0.93 02:40:40 INFO - PROCESS | 1941 | Values: 161.0 161.0 162.0 161.0 160.0 159.0 162.0 161.0 161.0 161.0 02:40:40 INFO - PROCESS | 1941 | 02:40:40 INFO - PROCESS | 1941 | [#3] audio-fft Cycles:10 Average:83.20 Median:76.50 stddev:12.70 (16.6%) stddev-sans-first:13.20 02:40:40 INFO - PROCESS | 1941 | Values: 76.0 75.0 86.0 108.0 76.0 77.0 77.0 77.0 105.0 75.0 02:40:40 INFO - PROCESS | 1941 | 02:40:40 INFO - PROCESS | 1941 | [#4] audio-oscillator Cycles:10 Average:92.70 Median:83.00 stddev:16.19 (19.5%) stddev-sans-first:16.86 02:40:40 INFO - PROCESS | 1941 | Values: 84.0 83.0 120.0 83.0 83.0 83.0 105.0 83.0 82.0 121.0 02:40:40 INFO - PROCESS | 1941 | 02:40:40 INFO - PROCESS | 1941 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.67 (0.6%) stddev-sans-first:0.60 02:40:40 INFO - PROCESS | 1941 | Values: 118.0 118.0 117.0 117.0 117.0 116.0 117.0 116.0 117.0 117.0 02:40:40 INFO - PROCESS | 1941 | 02:40:40 INFO - PROCESS | 1941 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.44 02:40:40 INFO - PROCESS | 1941 | Values: 147.0 147.0 146.0 146.0 146.0 146.0 146.0 146.0 147.0 146.0 02:40:40 INFO - PROCESS | 1941 | 02:40:40 INFO - PROCESS | 1941 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 02:40:40 INFO - PROCESS | 1941 | Values: 95.0 95.0 95.0 95.0 96.0 95.0 95.0 95.0 95.0 95.0 02:40:40 INFO - PROCESS | 1941 | 02:40:40 INFO - PROCESS | 1941 | [#8] json-parse-financial Cycles:10 Average:64.00 Median:64.00 stddev:1.05 (1.6%) stddev-sans-first:1.12 02:40:40 INFO - PROCESS | 1941 | Values: 64.0 63.0 64.0 62.0 64.0 64.0 66.0 65.0 64.0 64.0 02:40:40 INFO - PROCESS | 1941 | 02:40:40 INFO - PROCESS | 1941 | [#9] json-stringify-tinderbox Cycles:10 Average:66.50 Median:67.00 stddev:0.53 (0.8%) stddev-sans-first:0.53 02:40:40 INFO - PROCESS | 1941 | Values: 66.0 66.0 66.0 67.0 67.0 67.0 66.0 67.0 66.0 67.0 02:40:40 INFO - PROCESS | 1941 | 02:40:40 INFO - PROCESS | 1941 | [#10] stanford-crypto-aes Cycles:10 Average:84.00 Median:83.00 stddev:2.36 (2.8%) stddev-sans-first:2.47 02:40:40 INFO - PROCESS | 1941 | Values: 83.0 82.0 83.0 83.0 90.0 83.0 83.0 86.0 83.0 84.0 02:40:40 INFO - PROCESS | 1941 | 02:40:40 INFO - PROCESS | 1941 | [#11] stanford-crypto-ccm Cycles:10 Average:144.40 Median:141.50 stddev:11.17 (7.9%) stddev-sans-first:11.81 02:40:40 INFO - PROCESS | 1941 | Values: 147.0 140.0 139.0 139.0 137.0 139.0 141.0 145.0 175.0 142.0 02:40:40 INFO - PROCESS | 1941 | 02:40:40 INFO - PROCESS | 1941 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.20 Median:176.50 stddev:3.05 (1.7%) stddev-sans-first:3.00 02:40:40 INFO - PROCESS | 1941 | Values: 173.0 175.0 173.0 178.0 182.0 174.0 174.0 180.0 176.0 177.0 02:40:40 INFO - PROCESS | 1941 | 02:40:40 INFO - PROCESS | 1941 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.10 Median:70.00 stddev:0.57 (0.8%) stddev-sans-first:0.60 02:40:40 INFO - PROCESS | 1941 | Values: 70.0 70.0 71.0 70.0 70.0 70.0 70.0 70.0 69.0 71.0 02:40:40 INFO - PROCESS | 1941 | -------- Summary: end -------- 02:40:40 INFO - PROCESS | 1941 | 02:40:41 INFO - TEST-INFO | 1941: exit 0 02:40:41 INFO - TEST-OK | kraken | took 64821ms 02:40:41 INFO - SUITE-END | took 1187s 02:40:42 INFO - Completed test suite (00:19:47) 02:40:42 INFO - javascript benchmark 02:40:42 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2611.9477610447793, 2643.8017148713825, 2663.9733602663973, 2681.410089780249, 2693.299742067063, 4669.13620980119, 4721.976390118053, 4735.408073990751, 4847.733374664392, 4918.975405122974, 4750.4536978247515, 4757.286407038946, 4769.21307984183, 4791.425028996517, 4872.634552408575, 4314.633256173229, 4325.416068830715, 4369.0, 4414.337849322611, 4414.558544145591, 4140.689448291375, 4443.333499974998, 4461.665375096864, 4499.1001799640035, 4546.408966834307, 4269.807858646368, 4429.579189976947, 4431.379606855043, 4443.4445694288215, 4520.0, 4306.5262821089655, 4347.174036933005, 4376.452943382077, 4385.407969924051, 4395.956040439619, 4333.1766964277, 4338.262495375794, 4343.435353404069, 4391.802368893407, 4407.294832826732, 4765.666403351766, 4779.761011949424, 4787.712737235742, 4793.544613261734, 4809.470958194595, 4968.354113965198, 5008.048470790538, 5049.823256186016, 5078.0, 5109.821156259551, 5134.204198349262, 5136.512031357015, 5144.717040562768, 5184.948150518522, 5185.948140518584, 4777.856664300042, 4782.736949467812, 4784.569388755029, 4789.281607758794, 4840.201366774513, 5047.823326183566, 5092.0, 5107.821226257063, 5226.503482169188, 5311.867203319871, 4934.481879402611, 4959.652824302264, 4984.352034235599, 5042.294078828967, 5113.1052065888325, 5097.158968770185, 5122.974385128051, 5143.511366420259, 5150.25290092233, 5200.843974680765, 4876.122297986397, 5044.0, 5064.468230835783, 5087.31321271631, 5087.847364579068, 4818.180909245437, 4955.925661115086, 4964.60283177345, 4965.0, 4972.055309491185, 4324.416203812508, 4332.26351520236, 4332.935005974913, 4385.925448265196, 4391.780410979438, 3813.027677942107, 3824.101336185994, 3854.8265328060306, 3857.672097871712, 3924.9803750981064, 4424.911501769947, 4432.534583868647, 4435.866923992286, 4435.935375509855, 4474.574915383034, 4927.285543596158, 4930.6795058321095, 5110.97444512775, 5180.404253510819, 5241.344831896013, 4382.408374869416, 4386.7367957922625, 4427.180971520279, 4465.642748580106, 4475.641948644101, 4673.509281525391, 4674.252119660906, 4677.345171675968, 4726.078414709167, 4731.0, 4553.430821147356, 4584.88537786558, 4792.544708252711, 4797.136515427256, 4841.661083724176, 5020.523050310215, 5095.388553373471, 5103.795848166032, 5164.922526162186, 5234.0, 4763.880902977315, 4790.449098353734, 4811.566958973709, 4813.4945830687275, 4837.080954618611, 4892.363992680928, 5076.390833100052, 5085.466026067357, 5090.414602320632, 5149.948500514947, 4975.577075948585, 5014.674046186986, 5064.898702026013, 5076.670016448919, 5084.8220312288895, 4935.506449355179, 4937.35814344133, 4937.432195297587, 4969.0, 4975.0796102721115, 4919.286703427912, 4920.507949205194, 4922.65541412112, 4925.1627223372825, 4928.186849169847, 4826.638002149783, 4843.685160464559, 4880.6095512358215, 4928.0390323886495, 5036.8992620146655, 5051.267566202807, 5063.468335824686, 5068.087744206078, 5068.898622027613, 5131.640785145004, 4759.857204283877, 4799.1601469743355, 4951.084049450863, 4965.0, 4969.130402179677], "value": 4683.254868380301, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [536.669947981991, 540.624266135036, 548.5227851768962, 550.2873778456898, 551.3659291814411, 26546.20361389159, 27811.58282625762, 36678.633213667825, 37800.24399512008, 37886.43170352447, 38232.617673823326, 38565.80717096417, 38616.22767544648, 38627.420588691195, 38686.419703704465, 7090.326418990187, 7597.658105385257, 7750.0, 7751.18612545683, 7755.302022817945, 7049.647517624124, 9546.570404331787, 9748.0, 9766.755831104243, 10133.138683211899, 10090.445025523593, 10151.593936242542, 10155.187584993182, 10160.4919754012, 10161.542730577105, 7114.466415018895, 10015.248856335767, 10077.344972576759, 10088.092071713581, 10089.445080520569, 7057.0, 9533.04669533048, 10001.549930253155, 10013.098821106063, 10031.849522257173, 36351.4547281791, 36598.26803463916, 36610.0, 36730.26539469196, 36863.81568092143, 2881.683014868363, 2894.9131526054252, 2907.4039821836473, 2930.575066615329, 2937.133545604052, 27106.322341941413, 27430.862845685642, 27650.723492765017, 28302.575461368095, 29232.0, 3174.1429813950335, 3286.6384697683234, 3353.8826141085187, 3389.1357703785625, 3513.508108864761, 159108.0, 159835.0, 160629.19685401616, 160883.54256973258, 160885.99999999884, 52006.47993520092, 52196.21705674418, 52214.21678674823, 52226.0, 52254.47745522572, 31748.0, 32093.67906320907, 32247.0, 34477.310453790786, 34495.82752086274, 14768.704625907421, 14937.775933361008, 14941.327640256215, 14946.850531494763, 14955.775663365059, 10025.799484010426, 10197.18422526196, 11419.257748246337, 11512.0, 11520.423978801027, 15185.544433667008, 15299.541013769605, 15316.770248446282, 17059.744103838453, 17300.740488892676, 6314.147590075373, 6508.869822603521, 6583.958972718473, 6648.900266496006, 6754.155730533684, 798.4490701416005, 822.6380392627225, 851.714675583674, 867.2065060469725, 929.8143335671878, 26093.869530652224, 27869.58195627067, 28155.43689126247, 28331.858340708164, 29776.702232977826, 918.9218916392048, 935.6163972771132, 942.3215284994793, 945.0502245243487, 1011.2068793916782, 13655.795163072364, 14205.85794142066, 14370.856291437161, 14497.565073047825, 14516.854831451761, 330208.0, 332259.0, 332493.0, 333762.0, 580983.8557264933, 40216.19567608632, 46118.30822537665, 47106.76446617745, 47191.764041180264, 51278.0, 1139.0, 1141.7316930521488, 1164.6738913104343, 1170.3153655111685, 1171.420147027227, 26940.865295673397, 27603.585946211224, 28342.149735507966, 28611.284717881386, 28652.85673571619, 40492.595074048884, 41334.37998430086, 41395.0, 41395.172096558505, 41416.0, 249105.0, 249601.0, 250200.0, 250314.0, 251946.0, 24460.87769561141, 24830.751692482845, 24839.50320993606, 24854.875725621256, 24876.253712388658, 39238.80380598193, 39467.605323946394, 40595.391069133395, 40723.796381017906, 40734.796326019365, 30893.227669308446, 33273.0, 33959.83020084884, 34511.65488345084, 34607.30785384329, 33691.3261734759, 33895.32209355848, 33991.320173595894, 34041.48937765886, 34234.82882585571, 33258.667413326526, 33778.662213378535, 33884.830575846965, 34035.0, 34139.14652133617, 29742.25644358908, 30252.69747302587, 30688.232794180323, 30790.230244243176, 31072.53391199179, 23393.76606233984, 23980.160694375612, 24315.878420607783, 24351.878240609392, 24487.632685509376], "value": 16737.900566120054, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [330.8031721125929, 342.29999650714285, 352.0, 352.8853122735111, 376.72687301706264, 12365.46507965867, 15636.530904072883, 15782.368705251805, 16358.918205408956, 16445.506634800946, 15845.683086338266, 16039.198040098006, 16377.590560236, 16741.497755067336, 16904.408345707903, 5023.120953833074, 5134.229865520165, 5214.217867319913, 5257.395399529065, 5258.0, 5322.574194064485, 5519.475649813261, 5528.06022976095, 5529.364123125852, 5529.474699903502, 3369.326134773043, 3538.31002954424, 5206.713630750307, 5413.593980451462, 5443.673379597237, 5267.28891599633, 5517.917231241535, 5525.309336332958, 5532.446755324436, 5535.6955367454775, 5191.221316802472, 5214.270002199695, 5224.164133738622, 5224.947750522484, 5226.372835259755, 11644.18490705651, 11654.30074195551, 11687.298762074217, 11760.58837940668, 11825.349605771678, 1816.3642725046261, 1845.5847434327304, 1965.6068786242665, 1996.161612122912, 2012.175008246612, 8377.0, 9189.632414703405, 9379.108984646447, 9571.617135314578, 9684.370515916444, 1698.9150542472828, 1758.34062226665, 1773.272958087191, 1802.9549261268442, 1814.3014939248353, 65115.674421628064, 69742.0, 70904.6454767728, 71546.64226678833, 72589.27410725878, 9722.673410332334, 9889.554970026365, 10054.497275136215, 10246.821615514162, 10273.383596984055, 13930.860691392956, 13938.0, 13951.790723139162, 13965.231912244924, 13996.69054605999, 6631.535792494479, 6778.864422711518, 6822.692978815965, 6836.794896153124, 6885.414739747077, 6094.969525152346, 6223.533235007392, 6310.9368906311265, 6323.114763933053, 6356.427921486996, 4128.814203360856, 4262.46719160105, 4300.677449191323, 4376.518582955872, 4388.956110438919, 1796.2096677461875, 1816.5640246340784, 1845.6954602490707, 1846.4368367647728, 1849.3527265456983, 797.9561124138228, 846.386369881843, 857.6612238166015, 877.4910551879894, 918.9632414703337, 16438.506844794676, 16592.08743519094, 16734.832651673572, 17101.0, 17538.210780514906, 825.7894236969535, 839.3716190590235, 849.9745007649781, 853.2320911179987, 873.0745409865563, 9250.259979201783, 10139.543720532594, 10179.898201018043, 10507.737306567396, 10628.840567391495, 356650.0, 360188.0, 361807.0, 364846.0, 364921.0, 48387.51612483901, 48638.0, 48736.51263487391, 60775.08837367443, 78253.0, 897.5601955042113, 921.1847514949318, 935.569637966543, 939.2345238630494, 945.7162851144767, 15434.922825385802, 15438.382464701735, 16197.4330898418, 16331.995973041405, 16489.09309987962, 36308.455373168894, 36589.26821463609, 36742.63257367392, 37248.62751372452, 37634.24731505409, 48783.268250975554, 50936.0, 51382.0, 52054.73972630264, 52085.73957130342, 7578.12851522082, 7677.462577619513, 7682.961585192038, 7857.842843142991, 7973.242541958504, 9220.769480763034, 11264.66206013821, 11335.773284534429, 11730.824037639613, 11746.76506469883, 10245.231607629308, 10345.431001295, 10355.119814815826, 10364.170866330525, 10480.266381353233, 9989.550470229002, 10260.794784104426, 10406.427646479517, 10483.21375896826, 10486.318389304672, 9905.0, 10045.09594136502, 10218.335808172445, 10305.896941030795, 10360.119389851947, 7380.557166570023, 7396.0, 7482.1021477423055, 7495.625218738932, 7595.3164215220895, 8917.197452229331, 9994.10053095225, 10229.795404092025, 10451.738706532398, 10465.110465610203], "value": 7893.230068006139, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1240.2372540887357, 1349.1163288046328, 1373.2721657521513, 1430.9427622895084, 1650.8184099749026, 6557.704903279352, 7375.778726638203, 7671.7314893978655, 7728.65221065052, 7952.085510166333, 7786.727464538742, 7822.295993360596, 7827.099883513398, 7852.214778522145, 7859.68561257549, 2083.468715477551, 2097.674860396641, 2105.589410065038, 2111.6515774897125, 2115.1433669363932, 2018.2330714328534, 2034.6032523657893, 2044.1925439451409, 2097.307888396833, 2100.369889033284, 2087.060822629815, 2093.528955984899, 2103.7054812326287, 2106.926257580985, 2107.2413930984835, 2030.0661695620033, 2041.6733322668376, 2047.2732180076157, 2051.128270485053, 2054.3836848945407, 1991.0641998260794, 2000.0399808092197, 2032.2785411178966, 2036.5010572409853, 2040.9795902040937, 7694.115176754633, 7786.454948153631, 7793.844123117506, 7827.608619568999, 7832.060152781646, 4046.817893194813, 4276.700630955835, 4276.850310239158, 4304.634106100985, 4307.870763877088, 2796.258991367289, 2900.608417863604, 2960.230340111565, 2975.4197931403387, 2985.8656360463833, 904.1410659873147, 905.2531661379388, 924.4037595750771, 929.5770424456856, 932.6176267730198, 10518.474076296154, 10574.312669676523, 10626.203034772423, 10635.840462393071, 10662.78674426515, 3599.9640003600152, 3696.5009723687494, 3743.681787048077, 3846.076941534068, 3875.7093218008763, 8263.669453221804, 8278.958605207055, 8284.0, 8306.8338633227, 8317.334613230927, 4363.258246098171, 4366.345048242789, 4368.475782906072, 4369.279068953587, 4381.38660587518, 3517.8592856285463, 3625.728070394678, 4024.0, 4090.9181816364103, 4094.61101195386, 3019.531972544259, 3080.2299425143715, 3146.197719581492, 3148.3703259347762, 3192.2179066128483, 983.8081574093127, 990.108901988202, 999.1008092716468, 1005.7988402319565, 1012.4229189361993, 708.9716411343488, 825.7646570727314, 827.1067247372823, 847.5338563789891, 866.138192498468, 4976.42771081323, 4976.975115124474, 4995.375578052744, 5118.923216151761, 5226.268322434862, 372.9216864458494, 884.9070847561043, 928.3037721708719, 941.0122859919727, 985.261054209343, 3374.0633833360516, 3515.241517125212, 3531.29374125176, 3621.8913432597064, 3690.8523659053876, 9470.668526601536, 9631.566579503939, 9780.804383912282, 9796.216302695768, 9846.852297215548, 9781.657641982496, 9798.216142708567, 9802.803943921082, 9814.165795907285, 9831.852522212173, 7262.709491620381, 7395.85208295831, 7399.297066778648, 7409.999650047174, 7413.703451861973, 4980.178270585313, 5042.0, 5052.115879721107, 5087.262346959744, 5271.0, 8511.531865747444, 8614.22471977525, 8620.956895215484, 8656.567171641518, 8657.047724750399, 8515.872261915953, 8766.693165739169, 8792.0, 8848.159424854628, 8985.550722463982, 6303.590266632654, 6467.7736279231885, 6468.0, 6471.094046833541, 6527.086207930988, 7306.232845551353, 7644.350230230492, 7652.923470765444, 7657.540547567164, 7677.769666910001, 6747.460203183831, 6774.3225677431865, 6873.381395674413, 6989.47578931572, 7097.503174777716, 6397.360263973565, 6728.966355168192, 6808.217055038734, 6822.317768223138, 6907.758228461979, 5955.642661440327, 6009.579329446897, 6012.248468941382, 6015.39846015395, 6021.969890150521, 4296.677749168763, 4394.1651086293505, 4481.574250446202, 4531.093781243699, 4570.200214962435, 4269.359596060615, 4382.430284063052, 4392.736435813861, 4552.5447455255535, 4584.793684284282], "value": 3986.5155404461966, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [274.1214407822927, 279.1124224964612, 282.3945867741887, 284.2694275711421, 285.1445663010967, 4742.762861856911, 4879.487653796354, 4933.654644174909, 4938.506149385064, 4957.62817788666, 4693.342931989524, 4854.587360074389, 4869.586085182764, 4870.853874383774, 4878.560929516343, 3557.430811070229, 3685.2076803487244, 3835.5780864104927, 3839.6544311012003, 3862.6909847212296, 3717.3866312058476, 3817.7136714746366, 3830.3488406970882, 3839.6544311012003, 3839.985611295134, 3795.8102094895144, 3796.335641262782, 3799.67702745267, 3800.524934383202, 3807.428885667144, 3795.69634429245, 3802.6007269236884, 3805.4101614249557, 3811.790351530665, 3814.675752561022, 3110.844457777102, 3234.450143475615, 3257.332246889382, 3274.787138835968, 3346.1467325832, 4738.8863617049965, 4747.501512341189, 4753.5959443447, 4754.263089221176, 4762.64280178988, 4055.959440405588, 4278.764667943262, 4296.398504209413, 4297.333913243452, 4311.417958575615, 5101.923471147936, 5106.361704786902, 5125.8718532037, 5132.0241706942725, 5137.5633071188995, 3503.1417302760733, 3503.3518799022263, 3518.4546395308766, 3520.524729161556, 3523.119220194951, 5302.040455442997, 5365.490278423544, 5396.0, 5400.678582671668, 5406.324209473776, 3539.982300088483, 3624.257027309395, 3624.9093772655897, 3652.634736526326, 3657.231981283907, 3670.33933891902, 3673.3755261605056, 3680.705543556509, 3692.3538380783257, 3706.6849317808287, 4249.80875860587, 4260.55264197261, 4267.231898258281, 4277.465316835395, 4294.592013758688, 4866.82966096192, 4887.3890763654545, 4950.683042361627, 5020.0, 5143.71709555978, 1220.371508673034, 1245.1097465312346, 1245.3747859044036, 1247.8939290160438, 1251.4931452761646, 765.4412279036335, 792.5363662257644, 804.3042768005633, 808.8958571549792, 812.626191951697, 4004.199160167978, 4009.859654912064, 4018.5286049079605, 4021.722296328483, 4054.033793610097, 4596.5863072323655, 4630.5226703714025, 4654.627629789608, 4657.417822772153, 4663.673542851968, 4010.0, 4010.839566417311, 4017.417474466186, 4022.5518813227213, 4028.879133625996, 2337.2520793345966, 2468.469279105001, 2481.95036099277, 2486.4529803443215, 2493.987530062338, 4393.594049904064, 4402.779861006937, 4411.514733379326, 4412.580804823537, 4415.315626077963, 4766.904661906812, 4811.639127065484, 4832.806687732522, 4843.806247750051, 4849.58104536301, 4330.826766929287, 4348.260795664744, 4581.610563102174, 4970.950290497121, 5027.472115427974, 5338.57291416678, 5347.598930080182, 5348.325837081459, 5352.330958630171, 5384.6769193848495, 5283.388566487259, 5291.629585928948, 5299.44355842631, 5305.840824775263, 5315.495027972336, 4895.46149923501, 4949.802007919643, 4982.302477653059, 4993.375828021497, 5016.398032236155, 3734.5891951885815, 3739.9813000934823, 3747.662710356081, 3753.099256178443, 3777.131259810314, 5104.336436263262, 5349.117395629678, 5374.7581358839725, 5385.596080293915, 5398.379186393615, 4908.656394052382, 5094.337736094284, 5123.41174235988, 5134.484102789532, 5147.918937023267, 5180.9740951295, 5181.715005674724, 5186.273921650896, 5186.6369354144845, 5198.376194856642, 4903.190973489477, 5075.695458272516, 5107.131787596192, 5107.693538387709, 5123.231515272739, 5189.455107213688, 5190.429052804264, 5198.246254293031, 5199.922001170061, 5204.713740744295, 5059.392872855281, 5071.467495912876, 5074.923876141787, 5082.161443361804, 5090.516400941905], "value": 3745.0449213181596, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [609.4185588398107, 615.6736929427402, 632.4876849751698, 712.7327252280395, 746.3544034410235, 13022.674433139164, 13484.932575337134, 13515.932420337896, 13521.59435216945, 13619.79570306445, 13485.39315730792, 13493.797593036088, 13518.324083795795, 13567.05030647855, 13575.117617354865, 584.2638275772536, 599.0983569727554, 721.5418209437019, 724.7789424225609, 742.6917829100944, 726.1685370251059, 733.8458923626018, 734.6914295995695, 734.8603765284605, 735.7535225699397, 788.7949133225374, 788.9566073865935, 789.0728394136895, 792.1444839573276, 793.2820797178563, 616.1897105306508, 632.6773345593734, 765.0, 784.396015068397, 784.5292824305428, 557.5288880895637, 572.7508533787816, 573.5612256623687, 573.5669569475061, 573.6816067082767, 12308.569200078044, 12394.194377365442, 12450.937745311216, 12465.314407707572, 12481.687957801038, 11192.944035279854, 11609.01323387513, 11664.708382290426, 11667.708307292385, 12760.234385936781, 11056.723581910435, 11095.852787695672, 11199.496022678999, 11303.491342889507, 11347.205695601311, 4010.979945100285, 4028.4158796974566, 4122.9381559276635, 4123.814428350732, 4162.458880345535, 62333.68833155805, 63586.68206658937, 63626.36373636297, 65009.67495162494, 65365.34634653688, 9641.27690423221, 10267.94866025665, 10290.845637315446, 10311.278210525192, 10369.585216591402, 16204.513864584082, 17086.658266834595, 17105.657886842444, 17178.74231886523, 17181.398651047402, 6486.772962946275, 6601.042848786899, 6606.174228221473, 6717.1267735194115, 6781.898271525931, 3644.599094099647, 3668.6881615063016, 3689.409694448875, 3716.089558058293, 3763.9247215055548, 2711.8779654915575, 2788.2332358601548, 2789.609454676347, 2796.398774263543, 2804.270889568686, 449.1488629047936, 455.78350283615015, 458.2644855007731, 465.36245343878426, 467.3247157856864, 444.4089361149663, 527.5911168844176, 532.9520343169133, 539.3446961941182, 553.1923391847866, 7873.212678732081, 8035.397345199133, 8383.496990180609, 8745.387822852466, 8838.337124715543, 545.5771776872955, 567.1181313058152, 571.5798887817451, 602.3223873142714, 603.4177019176516, 3849.4610754494392, 4037.2329257440992, 4253.936190957138, 4273.401723758676, 4316.417283666665, 102304.0, 103721.0, 104281.0, 105338.47330763297, 105499.0, 65063.67468162629, 66120.0, 66258.0, 79237.60381198057, 89952.0, 41034.1793164141, 71454.0, 72551.63724181346, 72845.27154728491, 76772.61613692007, 8586.313094952264, 8710.172533609297, 8807.603657835542, 8860.86708699357, 9095.590698418719, 44506.3324050146, 45057.774711126236, 45177.54822451733, 46015.539844601124, 46145.0, 62433.68783156055, 64231.67884160549, 64935.35064649293, 65827.6708616473, 69280.0, 10363.533640986325, 10717.732056698645, 10750.139988801033, 10759.13926885863, 10790.244682872124, 11999.16005879615, 12335.951444126991, 12372.90334168169, 12682.809757853454, 12805.74388512206, 12531.590153821691, 12612.621621351374, 12637.304948227937, 12971.286579238233, 13018.544350947672, 11507.482163302839, 11740.712600471881, 12081.939590301992, 12214.450349734461, 12219.26684398939, 12025.579104731292, 12046.457909393923, 12251.632451026484, 12655.177413468095, 12740.108192426442, 10127.594896204364, 10150.949245254022, 10426.270161088954, 10515.0, 10545.31455455393, 10447.42539160323, 10475.452841973767, 11027.724306892393, 11048.613298534834, 11074.612388566684], "value": 6491.820176906019, "unit": "score"}], "name": "dromaeo_css", "value": 6256.453942440873, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 115.0, 113.0, 115.0, 113.0, 115.0, 113.0, 114.0, 114.0, 114.0], "value": 113.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 126.0, 127.0, 168.0, 147.0, 132.0, 132.0, 128.0, 158.0, 126.0], "value": 139.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 162.0, 161.0, 160.0, 159.0, 162.0, 161.0, 161.0, 161.0], "value": 160.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 86.0, 108.0, 76.0, 77.0, 77.0, 77.0, 105.0, 75.0], "value": 83.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 120.0, 83.0, 83.0, 83.0, 105.0, 83.0, 82.0, 121.0], "value": 92.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 117.0, 117.0, 116.0, 117.0, 116.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 147.0, 146.0], "value": 146.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 64.0, 62.0, 64.0, 64.0, 66.0, 65.0, 64.0, 64.0], "value": 64.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 66.0, 67.0, 67.0, 67.0, 66.0, 67.0, 66.0, 67.0], "value": 66.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 83.0, 83.0, 90.0, 83.0, 83.0, 86.0, 83.0, 84.0], "value": 84.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 140.0, 139.0, 139.0, 137.0, 139.0, 141.0, 145.0, 175.0, 142.0], "value": 144.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 175.0, 173.0, 178.0, 182.0, 174.0, 174.0, 180.0, 176.0, 177.0], "value": 176.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 70.0, 71.0, 70.0, 70.0, 70.0, 70.0, 70.0, 69.0, 71.0], "value": 70.1, "unit": "score"}], "name": "kraken", "value": 1554.1000000000001, "alertThreshold": 2.0}]} 02:40:42 INFO - Return code: 0 02:40:42 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:40:42 INFO - # TBPL SUCCESS # 02:40:42 INFO - Running post-action listener: _resource_record_post_action 02:40:42 INFO - [mozharness: 2016-10-09 09:40:42.236782Z] Finished run-tests step (success) 02:40:42 INFO - Running post-run listener: _resource_record_post_run 02:40:42 INFO - Total resource usage - Wall time: 1204s; CPU: 13.0%; Read bytes: 4096; Write bytes: 403697664; Read time: 8; Write time: 275148 02:40:42 INFO - TinderboxPrint: CPU usage
13.1% 02:40:42 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 02:40:42 INFO - TinderboxPrint: I/O write bytes / time
403,697,664 / 275,148 02:40:42 INFO - TinderboxPrint: CPU idle
8,348.9 (86.9%) 02:40:42 INFO - TinderboxPrint: CPU user
1,208.1 (12.6%) 02:40:42 INFO - TinderboxPrint: Swap in / out
0 / 0 02:40:42 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 110612480; Read time: 0; Write time: 61604 02:40:42 INFO - run-tests - Wall time: 1188s; CPU: 13.0%; Read bytes: 0; Write bytes: 291913728; Read time: 0; Write time: 213396 02:40:42 INFO - Running post-run listener: _upload_blobber_files 02:40:42 INFO - Blob upload gear active. 02:40:42 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:40:42 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 02:40:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Autoland-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 02:40:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Autoland-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 02:40:43 INFO - (blobuploader) - INFO - Open directory for files ... 02:40:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:40:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:40:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:40:48 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:40:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:40:48 INFO - (blobuploader) - INFO - Done attempting. 02:40:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:40:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:40:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:40:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:40:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:40:49 INFO - (blobuploader) - INFO - Done attempting. 02:40:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:40:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:40:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:40:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:40:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:40:50 INFO - (blobuploader) - INFO - Done attempting. 02:40:50 INFO - (blobuploader) - INFO - Iteration through files over. 02:40:50 INFO - Return code: 0 02:40:50 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:40:50 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:40:50 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/ce4f567f3830244f825f6fb411f5c8fee72bc0d5eca67e578fb68cbf1af173dd09e7a3dffd4f2fcf26b053ed16cca3c171644482ebe656c239d5ecd87a0b67f4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/846c13c28696f4f27cffd53ba98716e3d325a1e8eca1a8acd155528476acb6adcef99e148736fe963a4bfae89378d098b154d34d7b11b0097314b2fbe0a34ce3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/d3f2be363147e66b5582fce98ed008169e69375aecd30a98f4eb871ce8d5c8d4553995439a3beb344135dcf3859ada14a12bde59c63577947725190c6923c4b7"} 02:40:50 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:40:50 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:40:50 INFO - Contents: 02:40:50 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/ce4f567f3830244f825f6fb411f5c8fee72bc0d5eca67e578fb68cbf1af173dd09e7a3dffd4f2fcf26b053ed16cca3c171644482ebe656c239d5ecd87a0b67f4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/846c13c28696f4f27cffd53ba98716e3d325a1e8eca1a8acd155528476acb6adcef99e148736fe963a4bfae89378d098b154d34d7b11b0097314b2fbe0a34ce3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/d3f2be363147e66b5582fce98ed008169e69375aecd30a98f4eb871ce8d5c8d4553995439a3beb344135dcf3859ada14a12bde59c63577947725190c6923c4b7"} 02:40:50 INFO - Running post-run listener: copy_logs_to_upload_dir 02:40:50 INFO - Copying logs to upload dir... 02:40:50 INFO - mkdir: /builds/slave/test/build/upload/logs 02:40:50 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.864080 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-10-09 02:40:49.864975) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-09 02:40:49.868829) ========= 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=32c5991c409366f7fec8a718000001d2-1476001159.273248-757679691 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/ce4f567f3830244f825f6fb411f5c8fee72bc0d5eca67e578fb68cbf1af173dd09e7a3dffd4f2fcf26b053ed16cca3c171644482ebe656c239d5ecd87a0b67f4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/846c13c28696f4f27cffd53ba98716e3d325a1e8eca1a8acd155528476acb6adcef99e148736fe963a4bfae89378d098b154d34d7b11b0097314b2fbe0a34ce3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/d3f2be363147e66b5582fce98ed008169e69375aecd30a98f4eb871ce8d5c8d4553995439a3beb344135dcf3859ada14a12bde59c63577947725190c6923c4b7"} build_url:https://queue.taskcluster.net/v1/task/FzcB-hBeQxK-S8F9X-6dxQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011319 build_url: 'https://queue.taskcluster.net/v1/task/FzcB-hBeQxK-S8F9X-6dxQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/ce4f567f3830244f825f6fb411f5c8fee72bc0d5eca67e578fb68cbf1af173dd09e7a3dffd4f2fcf26b053ed16cca3c171644482ebe656c239d5ecd87a0b67f4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/846c13c28696f4f27cffd53ba98716e3d325a1e8eca1a8acd155528476acb6adcef99e148736fe963a4bfae89378d098b154d34d7b11b0097314b2fbe0a34ce3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/d3f2be363147e66b5582fce98ed008169e69375aecd30a98f4eb871ce8d5c8d4553995439a3beb344135dcf3859ada14a12bde59c63577947725190c6923c4b7"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-09 02:40:49.899542) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-09 02:40:49.899890) ========= 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=32c5991c409366f7fec8a718000001d2-1476001159.273248-757679691 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004522 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-09 02:40:49.982859) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-09 02:40:49.983275) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-09 02:40:49.983741) ========= ========= Total master_lag: 0.18 =========