builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-042 starttime: 1476932758.75 results: success (0) buildid: 20161019183650 builduid: 739ebd59b6614101b114137ffdde02da revision: 998ad5a74da80fe63664a8dcf30d8f269ffe4e65 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-19 20:05:58.746465) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-19 20:05:58.747187) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-19 20:05:58.747507) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-19 20:05:58.763128) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-19 20:05:58.763618) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=74d6aec007b0fa31a864ebd7000001f8-1476932732.428348-2083557137 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-19 20:05:59-- 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: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.7M=0s 2016-10-19 20:05:59 (46.7 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.174225 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-19 20:05:58.952989) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-19 20:05:58.953373) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=74d6aec007b0fa31a864ebd7000001f8-1476932732.428348-2083557137 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021069 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-19 20:05:59.004220) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-19 20:05:59.004649) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 998ad5a74da80fe63664a8dcf30d8f269ffe4e65 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 998ad5a74da80fe63664a8dcf30d8f269ffe4e65 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=74d6aec007b0fa31a864ebd7000001f8-1476932732.428348-2083557137 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-19 20:05:59,641 truncating revision to first 12 chars 2016-10-19 20:05:59,641 Setting DEBUG logging. 2016-10-19 20:05:59,641 attempt 1/10 2016-10-19 20:05:59,641 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/998ad5a74da8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-19 20:06:01,022 unpacking tar archive at: fx-team-998ad5a74da8/testing/mozharness/ program finished with exit code 0 elapsedTime=1.700686 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-19 20:06:00.719911) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-19 20:06:00.720326) ========= script_repo_revision: 998ad5a74da80fe63664a8dcf30d8f269ffe4e65 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-19 20:06:00.720816) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-19 20:06:00.721202) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-19 20:06:00.731280) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-10-19 20:06:00.731699) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-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', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=74d6aec007b0fa31a864ebd7000001f8-1476932732.428348-2083557137 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:06:01 INFO - MultiFileLogger online at 20161019 20:06:01 in /builds/slave/test 20:06:01 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 20:06:01 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:06:01 INFO - {'append_to_log': False, 20:06:01 INFO - 'base_work_dir': '/builds/slave/test', 20:06:01 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 20:06:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:06:01 INFO - 'branch': 'Fx-Team-Non-PGO', 20:06:01 INFO - 'buildbot_json_path': 'buildprops.json', 20:06:01 INFO - 'config_files': ('talos/linux_config.py',), 20:06:01 INFO - 'default_actions': ('clobber', 20:06:01 INFO - 'read-buildbot-config', 20:06:01 INFO - 'download-and-extract', 20:06:01 INFO - 'populate-webroot', 20:06:01 INFO - 'create-virtualenv', 20:06:01 INFO - 'install', 20:06:01 INFO - 'run-tests'), 20:06:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:06:01 INFO - 'download_minidump_stackwalk': True, 20:06:01 INFO - 'download_symbols': 'ondemand', 20:06:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:06:01 INFO - 'tooltool.py': '/tools/tooltool.py', 20:06:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:06:01 INFO - '/tools/misc-python/virtualenv.py')}, 20:06:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:06:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:06:01 INFO - 'installer_path': 'installer.exe', 20:06:01 INFO - 'log_level': 'info', 20:06:01 INFO - 'log_name': 'talos', 20:06:01 INFO - 'log_to_console': True, 20:06:01 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:06:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:06:01 INFO - 'opt_config_files': (), 20:06:01 INFO - 'pip_index': False, 20:06:01 INFO - 'sps_profile': False, 20:06:01 INFO - 'sps_profile_interval': 0, 20:06:01 INFO - 'suite': 'dromaeojs', 20:06:01 INFO - 'system_bits': '32', 20:06:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:06:01 INFO - 'title': 'talos-linux64-ix-042', 20:06:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:06:01 INFO - 'use_talos_json': True, 20:06:01 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:06:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:06:01 INFO - 'work_dir': 'build'} 20:06:01 INFO - [mozharness: 2016-10-20 03:06:01.469690Z] Running clobber step. 20:06:01 INFO - Running pre-action listener: _resource_record_pre_action 20:06:01 INFO - Running main action method: clobber 20:06:01 INFO - rmtree: /builds/slave/test/build 20:06:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:06:01 INFO - Running post-action listener: _resource_record_post_action 20:06:01 INFO - [mozharness: 2016-10-20 03:06:01.931676Z] Finished clobber step (success) 20:06:01 INFO - [mozharness: 2016-10-20 03:06:01.931779Z] Running read-buildbot-config step. 20:06:01 INFO - Running pre-action listener: _resource_record_pre_action 20:06:01 INFO - Running main action method: read_buildbot_config 20:06:01 INFO - Using buildbot properties: 20:06:01 INFO - { 20:06:01 INFO - "project": "", 20:06:01 INFO - "product": "firefox", 20:06:01 INFO - "script_repo_revision": "production", 20:06:01 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 20:06:01 INFO - "repository": "", 20:06:01 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 20:06:01 INFO - "buildid": "20161019183650", 20:06:01 INFO - "pgo_build": "False", 20:06:01 INFO - "basedir": "/builds/slave/test", 20:06:01 INFO - "buildnumber": 2209, 20:06:01 INFO - "slavename": "talos-linux64-ix-042", 20:06:01 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 20:06:01 INFO - "platform": "ubuntu64_hw", 20:06:01 INFO - "scheduler": "tests-fx-team-linux64-talos", 20:06:01 INFO - "branch": "fx-team", 20:06:01 INFO - "repo_path": "integration/fx-team", 20:06:01 INFO - "revision": "998ad5a74da80fe63664a8dcf30d8f269ffe4e65", 20:06:01 INFO - "stage_platform": "linux64", 20:06:01 INFO - "builduid": "739ebd59b6614101b114137ffdde02da", 20:06:01 INFO - "slavebuilddir": "test" 20:06:01 INFO - } 20:06:01 INFO - Found installer url https://queue.taskcluster.net/v1/task/INrxWV0BQ_-bDkvfwNDVgw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 20:06:01 INFO - Running post-action listener: _resource_record_post_action 20:06:01 INFO - [mozharness: 2016-10-20 03:06:01.934206Z] Finished read-buildbot-config step (success) 20:06:01 INFO - [mozharness: 2016-10-20 03:06:01.934293Z] Running download-and-extract step. 20:06:01 INFO - Running pre-action listener: _resource_record_pre_action 20:06:01 INFO - Running main action method: download_and_extract 20:06:01 INFO - mkdir: /builds/slave/test/build/tests 20:06:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:06:01 INFO - trying https://queue.taskcluster.net/v1/task/INrxWV0BQ_-bDkvfwNDVgw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 20:06:01 INFO - Downloading https://queue.taskcluster.net/v1/task/INrxWV0BQ_-bDkvfwNDVgw/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 20:06:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/INrxWV0BQ_-bDkvfwNDVgw/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 20:06:02 INFO - Downloaded 1361 bytes. 20:06:02 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 20:06:02 INFO - Using the following test package requirements: 20:06:02 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 20:06:02 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 20:06:02 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 20:06:02 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 20:06:02 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 20:06:02 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 20:06:02 INFO - u'jsshell-linux-x86_64.zip'], 20:06:02 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 20:06:02 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 20:06:02 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 20:06:02 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 20:06:02 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 20:06:02 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 20:06:02 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 20:06:02 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 20:06:02 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 20:06:02 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 20:06:02 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 20:06:02 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 20:06:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/INrxWV0BQ_-bDkvfwNDVgw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 20:06:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/INrxWV0BQ_-bDkvfwNDVgw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 20:06:02 INFO - Fetch https://queue.taskcluster.net/v1/task/INrxWV0BQ_-bDkvfwNDVgw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 20:06:03 INFO - Http code: 200 20:06:03 INFO - via: 1.1 ba26a6eef2785fa2e20e601890b882b2.cloudfront.net (CloudFront) 20:06:03 INFO - x-amz-cf-id: GjShkYfqXeZCqQLUHvHtFaBkzMPHJ0LlNQDc4YrLHSQzQqGb5R6aiQ== 20:06:03 INFO - x-amz-version-id: ve1mhs01u4k5DXWaosjQgcHfKEbrKe9a 20:06:03 INFO - Expected file size: 20546999 20:06:03 INFO - Obtained file size: 20546999 20:06: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 20:06:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/INrxWV0BQ_-bDkvfwNDVgw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 20:06:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/INrxWV0BQ_-bDkvfwNDVgw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 20:06:07 INFO - Fetch https://queue.taskcluster.net/v1/task/INrxWV0BQ_-bDkvfwNDVgw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 20:06:07 INFO - Http code: 200 20:06:07 INFO - via: 1.1 23172d761378a3865feafcda78328053.cloudfront.net (CloudFront) 20:06:07 INFO - x-amz-cf-id: hQdsSiJE-RR7hvP6C5hpd9NTkj9s7fprEBiqpsHeLUb49HztkmseoA== 20:06:07 INFO - x-amz-version-id: ve1mhs01u4k5DXWaosjQgcHfKEbrKe9a 20:06:08 INFO - Expected file size: 20546999 20:06:08 INFO - Obtained file size: 20546999 20:06:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/INrxWV0BQ_-bDkvfwNDVgw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 20:06:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/INrxWV0BQ_-bDkvfwNDVgw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 20:06:12 INFO - Fetch https://queue.taskcluster.net/v1/task/INrxWV0BQ_-bDkvfwNDVgw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 20:06:13 INFO - Http code: 200 20:06:13 INFO - via: 1.1 9baadab4e4d95afe7af7bcba342b29c6.cloudfront.net (CloudFront) 20:06:13 INFO - x-amz-cf-id: YxCUc-6DKiZYVuOxchqeMelg0-dCGZkXyx3FbNCUwHfFw64OGfebnw== 20:06:13 INFO - x-amz-version-id: b2fa4YOOpzMgJaEq1ypsXMdtLEpjawC7 20:06:13 INFO - Expected file size: 14409028 20:06:13 INFO - Obtained file size: 14409028 20:06:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:06:13 INFO - trying https://queue.taskcluster.net/v1/task/INrxWV0BQ_-bDkvfwNDVgw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 20:06:13 INFO - Downloading https://queue.taskcluster.net/v1/task/INrxWV0BQ_-bDkvfwNDVgw/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 20:06:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/INrxWV0BQ_-bDkvfwNDVgw/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 20:06:14 INFO - Downloaded 55530123 bytes. 20:06:14 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/INrxWV0BQ_-bDkvfwNDVgw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 20:06:14 INFO - mkdir: /builds/slave/test/properties 20:06:14 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:06:14 INFO - Writing to file /builds/slave/test/properties/build_url 20:06:14 INFO - Contents: 20:06:14 INFO - build_url:https://queue.taskcluster.net/v1/task/INrxWV0BQ_-bDkvfwNDVgw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 20:06:15 INFO - Running post-action listener: _resource_record_post_action 20:06:15 INFO - Running post-action listener: set_extra_try_arguments 20:06:15 INFO - [mozharness: 2016-10-20 03:06:15.513816Z] Finished download-and-extract step (success) 20:06:15 INFO - [mozharness: 2016-10-20 03:06:15.514041Z] Running populate-webroot step. 20:06:15 INFO - Running pre-action listener: _resource_record_pre_action 20:06:15 INFO - Running main action method: populate_webroot 20:06:15 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:06:15 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:06:15 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:06:15 INFO - '--tppagecycles', 20:06:15 INFO - '7'], 20:06:15 INFO - 'tests': ['tsvgm']}}, 20:06:15 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:06:15 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:06:15 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:06:15 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:06:15 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:06:15 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:06:15 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:06:15 INFO - 'talos_options': ['--disable-e10s'], 20:06:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:06:15 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:06:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:06:15 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:06:15 INFO - 'talos_options': ['--disable-e10s'], 20:06:15 INFO - 'tests': ['damp', 'tps']}, 20:06:15 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:06:15 INFO - 'tests': ['damp', 'tps']}, 20:06:15 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:06:15 INFO - 'tests': ['dromaeo_dom']}, 20:06:15 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:06:15 INFO - 'g4': {'talos_options': ['--disable-e10s'], 20:06:15 INFO - 'tests': ['basic_compositor_video']}, 20:06:15 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 20:06:15 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:06:15 INFO - 'tests': ['a11yr', 20:06:15 INFO - 'ts_paint', 20:06:15 INFO - 'tpaint', 20:06:15 INFO - 'sessionrestore', 20:06:15 INFO - 'sessionrestore_no_auto_restore', 20:06:15 INFO - 'tabpaint']}, 20:06:15 INFO - 'other-e10s': {'tests': ['a11yr', 20:06:15 INFO - 'ts_paint', 20:06:15 INFO - 'tpaint', 20:06:15 INFO - 'sessionrestore', 20:06:15 INFO - 'sessionrestore_no_auto_restore', 20:06:15 INFO - 'tabpaint']}, 20:06:15 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:06:15 INFO - 'ts_paint', 20:06:15 INFO - 'tpaint', 20:06:15 INFO - 'sessionrestore', 20:06:15 INFO - 'sessionrestore_no_auto_restore', 20:06:15 INFO - 'tabpaint']}, 20:06:15 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:06:15 INFO - 'ts_paint', 20:06:15 INFO - 'tpaint', 20:06:15 INFO - 'sessionrestore', 20:06:15 INFO - 'sessionrestore_no_auto_restore', 20:06:15 INFO - 'tabpaint']}, 20:06:15 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:06:15 INFO - 'tests': ['a11yr', 20:06:15 INFO - 'ts_paint', 20:06:15 INFO - 'tpaint', 20:06:15 INFO - 'sessionrestore', 20:06:15 INFO - 'sessionrestore_no_auto_restore', 20:06:15 INFO - 'tabpaint']}, 20:06:15 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:06:15 INFO - 'tests': ['a11yr', 20:06:15 INFO - 'ts_paint', 20:06:15 INFO - 'tpaint', 20:06:15 INFO - 'sessionrestore', 20:06:15 INFO - 'sessionrestore_no_auto_restore', 20:06:15 INFO - 'tabpaint']}, 20:06:15 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:06:15 INFO - 'tests': ['tsvgx', 20:06:15 INFO - 'tsvgr_opacity', 20:06:15 INFO - 'tart', 20:06:15 INFO - 'tscrollx', 20:06:15 INFO - 'cart']}, 20:06:15 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:06:15 INFO - 'tsvgr_opacity', 20:06:15 INFO - 'tart', 20:06:15 INFO - 'tscrollx', 20:06:15 INFO - 'cart']}, 20:06:15 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:06:15 INFO - 'talos_options': ['--disable-e10s'], 20:06:15 INFO - 'tests': ['tp5o']}, 20:06:15 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:06:15 INFO - 'tests': ['tp5o']}, 20:06:15 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:06:15 INFO - 'talos_options': ['--disable-e10s', 20:06:15 INFO - '--xperf_path', 20:06:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:06:15 INFO - 'tests': ['tp5n']}, 20:06:15 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:06:15 INFO - 'talos_options': ['--xperf_path', 20:06:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:06:15 INFO - 'tests': ['tp5n']}}, 20:06:15 INFO - 'talos.zip': {'path': '', 20:06:15 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:06:15 INFO - Running post-action listener: _resource_record_post_action 20:06:15 INFO - [mozharness: 2016-10-20 03:06:15.530204Z] Finished populate-webroot step (success) 20:06:15 INFO - [mozharness: 2016-10-20 03:06:15.530292Z] Running create-virtualenv step. 20:06:15 INFO - Running pre-action listener: _resource_record_pre_action 20:06:15 INFO - Running main action method: create_virtualenv 20:06:15 INFO - Creating virtualenv /builds/slave/test/build/venv 20:06:15 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 20:06:15 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:06:15 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:06:15 INFO - Using real prefix '/usr' 20:06:15 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:06:16 INFO - Installing distribute.............................................................................................................................................................................................done. 20:06:18 INFO - Installing pip.................done. 20:06:18 INFO - Return code: 0 20:06:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 20:06:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 20:06:18 INFO - Reading from file tmpfile_stdout 20:06:18 INFO - Output received: 20:06: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) 20:06:18 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:06: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')]} 20:06:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:06:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06: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')]} 20:06:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:06:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06: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 0x7fe63a0c4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aceca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1acbf60>, '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 0x1accd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1acd1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1476932732.428348-2083557137', '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 20:06: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 20:06: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 20:06:18 INFO - Using env: {'DISPLAY': ':0', 20:06:18 INFO - 'HOME': '/home/cltbld', 20:06:18 INFO - 'LANG': 'en_US.UTF-8', 20:06:18 INFO - 'LANGUAGE': 'en_US:en', 20:06:18 INFO - 'LOGNAME': 'cltbld', 20:06:18 INFO - 'MAIL': '/var/mail/cltbld', 20:06:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:18 INFO - 'MOZ_NO_REMOTE': '1', 20:06:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:06:18 INFO - 'NO_EM_RESTART': '1', 20:06:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:06:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:06:18 INFO - 'PWD': '/builds/slave/test', 20:06:18 INFO - 'SHELL': '/bin/bash', 20:06:18 INFO - 'SHLVL': '1', 20:06:18 INFO - 'TERM': 'linux', 20:06:18 INFO - 'TMOUT': '86400', 20:06:18 INFO - 'USER': 'cltbld', 20:06:18 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1476932732.428348-2083557137', 20:06:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:18 INFO - '_': '/tools/buildbot/bin/python'} 20:06:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:06:18 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 20:06:18 INFO - Cleaning up... 20:06:18 INFO - Return code: 0 20:06:18 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 20:06: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')]} 20:06:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:06:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06: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')]} 20:06:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:06:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe63a0c4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aceca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1acbf60>, '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 0x1accd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1acd1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1476932732.428348-2083557137', '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 20:06:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 20:06:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 20:06:18 INFO - Using env: {'DISPLAY': ':0', 20:06:18 INFO - 'HOME': '/home/cltbld', 20:06:18 INFO - 'LANG': 'en_US.UTF-8', 20:06:18 INFO - 'LANGUAGE': 'en_US:en', 20:06:18 INFO - 'LOGNAME': 'cltbld', 20:06:18 INFO - 'MAIL': '/var/mail/cltbld', 20:06:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:18 INFO - 'MOZ_NO_REMOTE': '1', 20:06:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:06:18 INFO - 'NO_EM_RESTART': '1', 20:06:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:06:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:06:18 INFO - 'PWD': '/builds/slave/test', 20:06:18 INFO - 'SHELL': '/bin/bash', 20:06:18 INFO - 'SHLVL': '1', 20:06:18 INFO - 'TERM': 'linux', 20:06:18 INFO - 'TMOUT': '86400', 20:06:18 INFO - 'USER': 'cltbld', 20:06:18 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1476932732.428348-2083557137', 20:06:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:18 INFO - '_': '/tools/buildbot/bin/python'} 20:06:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:06:18 INFO - Downloading/unpacking psutil>=3.1.1 20:06:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:06:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:06:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:06:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:06:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:06:20 INFO - Installing collected packages: psutil 20:06:20 INFO - Running setup.py install for psutil 20:06:20 INFO - building 'psutil._psutil_linux' extension 20:06:20 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 20:06: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 20:06:21 INFO - building 'psutil._psutil_posix' extension 20:06: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 20:06: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 20:06:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:06:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:06:21 INFO - Successfully installed psutil 20:06:21 INFO - Cleaning up... 20:06:21 INFO - Return code: 0 20:06:21 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 20:06: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')]} 20:06:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:06:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06: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')]} 20:06:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:06:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06: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 0x7fe63a0c4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aceca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1acbf60>, '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 0x1accd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1acd1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1476932732.428348-2083557137', '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 20:06: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 20:06: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 20:06:21 INFO - Using env: {'DISPLAY': ':0', 20:06:21 INFO - 'HOME': '/home/cltbld', 20:06:21 INFO - 'LANG': 'en_US.UTF-8', 20:06:21 INFO - 'LANGUAGE': 'en_US:en', 20:06:21 INFO - 'LOGNAME': 'cltbld', 20:06:21 INFO - 'MAIL': '/var/mail/cltbld', 20:06:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:21 INFO - 'MOZ_NO_REMOTE': '1', 20:06:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:06:21 INFO - 'NO_EM_RESTART': '1', 20:06:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:06:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:06:21 INFO - 'PWD': '/builds/slave/test', 20:06:21 INFO - 'SHELL': '/bin/bash', 20:06:21 INFO - 'SHLVL': '1', 20:06:21 INFO - 'TERM': 'linux', 20:06:21 INFO - 'TMOUT': '86400', 20:06:21 INFO - 'USER': 'cltbld', 20:06:21 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1476932732.428348-2083557137', 20:06:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:21 INFO - '_': '/tools/buildbot/bin/python'} 20:06:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:06:21 INFO - Downloading/unpacking mozsystemmonitor==0.3 20:06:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:06:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:06:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:23 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:06:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:06:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 20:06:23 INFO - Installing collected packages: mozsystemmonitor 20:06:23 INFO - Running setup.py install for mozsystemmonitor 20:06:23 INFO - Successfully installed mozsystemmonitor 20:06:23 INFO - Cleaning up... 20:06:23 INFO - Return code: 0 20:06:23 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 20:06:23 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')]} 20:06:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:06:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:23 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')]} 20:06:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:06:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:23 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 0x7fe63a0c4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aceca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1acbf60>, '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 0x1accd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1acd1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1476932732.428348-2083557137', '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 20:06:23 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 20:06:23 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 20:06:23 INFO - Using env: {'DISPLAY': ':0', 20:06:23 INFO - 'HOME': '/home/cltbld', 20:06:23 INFO - 'LANG': 'en_US.UTF-8', 20:06:23 INFO - 'LANGUAGE': 'en_US:en', 20:06:23 INFO - 'LOGNAME': 'cltbld', 20:06:23 INFO - 'MAIL': '/var/mail/cltbld', 20:06:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:23 INFO - 'MOZ_NO_REMOTE': '1', 20:06:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:06:23 INFO - 'NO_EM_RESTART': '1', 20:06:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:06:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:06:23 INFO - 'PWD': '/builds/slave/test', 20:06:23 INFO - 'SHELL': '/bin/bash', 20:06:23 INFO - 'SHLVL': '1', 20:06:23 INFO - 'TERM': 'linux', 20:06:23 INFO - 'TMOUT': '86400', 20:06:23 INFO - 'USER': 'cltbld', 20:06:23 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1476932732.428348-2083557137', 20:06:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:23 INFO - '_': '/tools/buildbot/bin/python'} 20:06:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:06:23 INFO - Downloading/unpacking jsonschema==2.5.1 20:06:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:06:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:06:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:25 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:06:25 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 20:06:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:06:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:06:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:26 INFO - Downloading functools32-3.2.3-2.tar.gz 20:06:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:06:26 INFO - warning: no files found matching '*.txt' 20:06:26 INFO - no previously-included directories found matching 'build' 20:06:26 INFO - no previously-included directories found matching 'dist' 20:06:26 INFO - no previously-included directories found matching '.git*' 20:06:26 INFO - Installing collected packages: jsonschema, functools32 20:06:26 INFO - Running setup.py install for functools32 20:06:26 INFO - warning: no files found matching '*.txt' 20:06:26 INFO - no previously-included directories found matching 'build' 20:06:26 INFO - no previously-included directories found matching 'dist' 20:06:26 INFO - no previously-included directories found matching '.git*' 20:06:26 INFO - Successfully installed jsonschema functools32 20:06:26 INFO - Cleaning up... 20:06:26 INFO - Return code: 0 20:06:26 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 20:06: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')]} 20:06:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:06:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06: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')]} 20:06:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:06:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06: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 0x7fe63a0c4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aceca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1acbf60>, '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 0x1accd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1acd1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1476932732.428348-2083557137', '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 20:06: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 20:06: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 20:06:26 INFO - Using env: {'DISPLAY': ':0', 20:06:26 INFO - 'HOME': '/home/cltbld', 20:06:26 INFO - 'LANG': 'en_US.UTF-8', 20:06:26 INFO - 'LANGUAGE': 'en_US:en', 20:06:26 INFO - 'LOGNAME': 'cltbld', 20:06:26 INFO - 'MAIL': '/var/mail/cltbld', 20:06:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:26 INFO - 'MOZ_NO_REMOTE': '1', 20:06:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:06:26 INFO - 'NO_EM_RESTART': '1', 20:06:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:06:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:06:26 INFO - 'PWD': '/builds/slave/test', 20:06:26 INFO - 'SHELL': '/bin/bash', 20:06:26 INFO - 'SHLVL': '1', 20:06:26 INFO - 'TERM': 'linux', 20:06:26 INFO - 'TMOUT': '86400', 20:06:26 INFO - 'USER': 'cltbld', 20:06:26 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1476932732.428348-2083557137', 20:06:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:26 INFO - '_': '/tools/buildbot/bin/python'} 20:06:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:06:26 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 20:06:26 INFO - Cleaning up... 20:06:26 INFO - Return code: 0 20:06:26 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:06: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')]} 20:06:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:06:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06: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')]} 20:06:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:06:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe63a0c4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aceca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1acbf60>, '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 0x1accd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1acd1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1476932732.428348-2083557137', '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 20:06:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 20:06:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 20:06:26 INFO - Using env: {'DISPLAY': ':0', 20:06:26 INFO - 'HOME': '/home/cltbld', 20:06:26 INFO - 'LANG': 'en_US.UTF-8', 20:06:26 INFO - 'LANGUAGE': 'en_US:en', 20:06:26 INFO - 'LOGNAME': 'cltbld', 20:06:26 INFO - 'MAIL': '/var/mail/cltbld', 20:06:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:26 INFO - 'MOZ_NO_REMOTE': '1', 20:06:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:06:26 INFO - 'NO_EM_RESTART': '1', 20:06:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:06:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:06:26 INFO - 'PWD': '/builds/slave/test', 20:06:26 INFO - 'SHELL': '/bin/bash', 20:06:26 INFO - 'SHLVL': '1', 20:06:26 INFO - 'TERM': 'linux', 20:06:26 INFO - 'TMOUT': '86400', 20:06:26 INFO - 'USER': 'cltbld', 20:06:26 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1476932732.428348-2083557137', 20:06:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:26 INFO - '_': '/tools/buildbot/bin/python'} 20:06:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:06:26 INFO - Downloading/unpacking blobuploader==1.2.4 20:06: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 20:06: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 20:06: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 20:06: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 20:06: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 20:06: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 20:06:28 INFO - Downloading blobuploader-1.2.4.tar.gz 20:06:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:06:28 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:06:28 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 20:06:28 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 20:06:28 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 20:06:28 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 20:06:28 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 20:06:28 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 20:06:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:06:29 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:06: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 20:06: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 20:06: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 20:06: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 20:06: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 20:06: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 20:06:29 INFO - Downloading docopt-0.6.1.tar.gz 20:06:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:06:29 INFO - Installing collected packages: blobuploader, requests, docopt 20:06:29 INFO - Running setup.py install for blobuploader 20:06:29 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:06:29 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:06:29 INFO - Running setup.py install for requests 20:06:29 INFO - Running setup.py install for docopt 20:06:30 INFO - Successfully installed blobuploader requests docopt 20:06:30 INFO - Cleaning up... 20:06:30 INFO - Return code: 0 20:06:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:06: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')]} 20:06:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:06:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06: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')]} 20:06:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:06:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06: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 0x7fe63a0c4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aceca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1acbf60>, '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 0x1accd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1acd1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1476932732.428348-2083557137', '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 20:06: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 20:06: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 20:06:30 INFO - Using env: {'DISPLAY': ':0', 20:06:30 INFO - 'HOME': '/home/cltbld', 20:06:30 INFO - 'LANG': 'en_US.UTF-8', 20:06:30 INFO - 'LANGUAGE': 'en_US:en', 20:06:30 INFO - 'LOGNAME': 'cltbld', 20:06:30 INFO - 'MAIL': '/var/mail/cltbld', 20:06:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:30 INFO - 'MOZ_NO_REMOTE': '1', 20:06:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:06:30 INFO - 'NO_EM_RESTART': '1', 20:06:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:06:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:06:30 INFO - 'PWD': '/builds/slave/test', 20:06:30 INFO - 'SHELL': '/bin/bash', 20:06:30 INFO - 'SHLVL': '1', 20:06:30 INFO - 'TERM': 'linux', 20:06:30 INFO - 'TMOUT': '86400', 20:06:30 INFO - 'USER': 'cltbld', 20:06:30 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1476932732.428348-2083557137', 20:06:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:30 INFO - '_': '/tools/buildbot/bin/python'} 20:06:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:06:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:06:30 INFO - Running setup.py (path:/tmp/pip-_bnga3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:06:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:06:30 INFO - Running setup.py (path:/tmp/pip-6AlAO5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:06:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:06:30 INFO - Running setup.py (path:/tmp/pip-yrx8kt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:06:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:06:30 INFO - Running setup.py (path:/tmp/pip-p4g5ed-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:06:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:06:30 INFO - Running setup.py (path:/tmp/pip-FNwOfV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:06:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:06:30 INFO - Running setup.py (path:/tmp/pip-L8NEPD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:06:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:06:30 INFO - Running setup.py (path:/tmp/pip-DK9z6s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:06:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:06:30 INFO - Running setup.py (path:/tmp/pip-iNTOOi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:06:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:06:30 INFO - Running setup.py (path:/tmp/pip-e8cUkd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:06:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:06:31 INFO - Running setup.py (path:/tmp/pip-7lVl4Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:06:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:06:31 INFO - Running setup.py (path:/tmp/pip-aGWMhS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:06:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:06:31 INFO - Running setup.py (path:/tmp/pip-gUzzPc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:06:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:06:31 INFO - Running setup.py (path:/tmp/pip-u3DsFe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:06:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:06:31 INFO - Running setup.py (path:/tmp/pip-U67mIU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:06:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:06:31 INFO - Running setup.py (path:/tmp/pip-qU691M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:06:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:06:31 INFO - Running setup.py (path:/tmp/pip-Q65AcT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:06:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:06:31 INFO - Running setup.py (path:/tmp/pip-UBDqfb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:06:31 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:06:31 INFO - Running setup.py install for manifestparser 20:06:31 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:06:31 INFO - Running setup.py install for mozcrash 20:06:31 INFO - Running setup.py install for mozdebug 20:06:31 INFO - Running setup.py install for mozdevice 20:06:31 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:06:31 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:06:32 INFO - Running setup.py install for mozfile 20:06:32 INFO - Running setup.py install for mozhttpd 20:06:32 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:06:32 INFO - Running setup.py install for mozinfo 20:06:32 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:06:32 INFO - Running setup.py install for mozInstall 20:06:32 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:06:32 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:06:32 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:06:32 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:06:32 INFO - Running setup.py install for mozleak 20:06:32 INFO - Running setup.py install for mozlog 20:06:32 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:06:32 INFO - Running setup.py install for moznetwork 20:06:32 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:06:32 INFO - Running setup.py install for mozprocess 20:06:32 INFO - Running setup.py install for mozprofile 20:06:32 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:06:32 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:06:32 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:06:32 INFO - Running setup.py install for mozrunner 20:06:33 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:06:33 INFO - Running setup.py install for mozscreenshot 20:06:33 INFO - Running setup.py install for moztest 20:06:33 INFO - Running setup.py install for mozversion 20:06:33 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:06:33 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:06:33 INFO - Cleaning up... 20:06:33 INFO - Return code: 0 20:06:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:06: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')]} 20:06:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:06:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06: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')]} 20:06:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:06:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06: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 0x7fe63a0c4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aceca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1acbf60>, '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 0x1accd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1acd1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1476932732.428348-2083557137', '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 20:06: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 20:06: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 20:06:33 INFO - Using env: {'DISPLAY': ':0', 20:06:33 INFO - 'HOME': '/home/cltbld', 20:06:33 INFO - 'LANG': 'en_US.UTF-8', 20:06:33 INFO - 'LANGUAGE': 'en_US:en', 20:06:33 INFO - 'LOGNAME': 'cltbld', 20:06:33 INFO - 'MAIL': '/var/mail/cltbld', 20:06:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:33 INFO - 'MOZ_NO_REMOTE': '1', 20:06:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:06:33 INFO - 'NO_EM_RESTART': '1', 20:06:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:06:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:06:33 INFO - 'PWD': '/builds/slave/test', 20:06:33 INFO - 'SHELL': '/bin/bash', 20:06:33 INFO - 'SHLVL': '1', 20:06:33 INFO - 'TERM': 'linux', 20:06:33 INFO - 'TMOUT': '86400', 20:06:33 INFO - 'USER': 'cltbld', 20:06:33 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1476932732.428348-2083557137', 20:06:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:33 INFO - '_': '/tools/buildbot/bin/python'} 20:06:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:06:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:06:33 INFO - Running setup.py (path:/tmp/pip-zADdlm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:06:33 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 20:06:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:06:33 INFO - Running setup.py (path:/tmp/pip-uS71Uk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:06:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 20:06:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:06:33 INFO - Running setup.py (path:/tmp/pip-So35yL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:06:33 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)) 20:06:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:06:33 INFO - Running setup.py (path:/tmp/pip-XIg_tf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:06:33 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)) 20:06:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:06:33 INFO - Running setup.py (path:/tmp/pip-pTSQ84-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:06:33 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)) 20:06:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:06:33 INFO - Running setup.py (path:/tmp/pip-GioT6Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:06: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)) 20:06:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:06:34 INFO - Running setup.py (path:/tmp/pip-8ig6Yj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:06: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)) 20:06:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:06:34 INFO - Running setup.py (path:/tmp/pip-qqtJgJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:06: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)) 20:06:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:06:34 INFO - Running setup.py (path:/tmp/pip-VW5q7Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:06: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)) 20:06:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:06:34 INFO - Running setup.py (path:/tmp/pip-v43rZ6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:06: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)) 20:06:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:06:34 INFO - Running setup.py (path:/tmp/pip-QGyRyI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:06: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)) 20:06:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:06:34 INFO - Running setup.py (path:/tmp/pip-nMhRIK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:06: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)) 20:06:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:06:34 INFO - Running setup.py (path:/tmp/pip-7nDtYj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:06: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)) 20:06:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:06:34 INFO - Running setup.py (path:/tmp/pip-FniLUL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:06:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 20:06:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:06:34 INFO - Running setup.py (path:/tmp/pip-olGUqu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:06:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 20:06:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:06:34 INFO - Running setup.py (path:/tmp/pip-_YdeTp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:06:34 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 20:06:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:06:34 INFO - Running setup.py (path:/tmp/pip-PcY_Mt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:06:34 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)) 20:06:34 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)) 20:06:34 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)) 20:06:34 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)) 20:06:34 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)) 20:06:34 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)) 20:06:34 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:06:34 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 20:06:34 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 20:06:34 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 20:06:34 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 20:06:34 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 20:06:34 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 20:06:36 INFO - Downloading blessings-1.6.tar.gz 20:06:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:06:36 INFO - Installing collected packages: blessings 20:06:36 INFO - Running setup.py install for blessings 20:06:36 INFO - Successfully installed blessings 20:06:36 INFO - Cleaning up... 20:06:37 INFO - Return code: 0 20:06:37 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:06:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:06:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:06:37 INFO - Reading from file tmpfile_stdout 20:06:37 INFO - Current package versions: 20:06:37 INFO - argparse == 1.2.1 20:06:37 INFO - blessings == 1.6 20:06:37 INFO - blobuploader == 1.2.4 20:06:37 INFO - docopt == 0.6.1 20:06:37 INFO - functools32 == 3.2.3-2 20:06:37 INFO - jsonschema == 2.5.1 20:06:37 INFO - manifestparser == 1.1 20:06:37 INFO - mozInstall == 1.12 20:06:37 INFO - mozcrash == 0.17 20:06:37 INFO - mozdebug == 0.1 20:06:37 INFO - mozdevice == 0.48 20:06:37 INFO - mozfile == 1.2 20:06:37 INFO - mozhttpd == 0.7 20:06:37 INFO - mozinfo == 0.9 20:06:37 INFO - mozleak == 0.1 20:06:37 INFO - mozlog == 3.4 20:06:37 INFO - moznetwork == 0.27 20:06:37 INFO - mozprocess == 0.23 20:06:37 INFO - mozprofile == 0.28 20:06:37 INFO - mozrunner == 6.12 20:06:37 INFO - mozscreenshot == 0.1 20:06:37 INFO - mozsystemmonitor == 0.3 20:06:37 INFO - moztest == 0.7 20:06:37 INFO - mozversion == 1.4 20:06:37 INFO - psutil == 3.1.1 20:06:37 INFO - requests == 1.2.3 20:06:37 INFO - wsgiref == 0.1.2 20:06:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:06: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')]} 20:06:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:06:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06: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')]} 20:06:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:06:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06: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 0x7fe63a0c4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aceca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1acbf60>, '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 0x1accd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1acd1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1476932732.428348-2083557137', '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 20:06: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 20:06: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 20:06:37 INFO - Using env: {'DISPLAY': ':0', 20:06:37 INFO - 'HOME': '/home/cltbld', 20:06:37 INFO - 'LANG': 'en_US.UTF-8', 20:06:37 INFO - 'LANGUAGE': 'en_US:en', 20:06:37 INFO - 'LOGNAME': 'cltbld', 20:06:37 INFO - 'MAIL': '/var/mail/cltbld', 20:06:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:37 INFO - 'MOZ_NO_REMOTE': '1', 20:06:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:06:37 INFO - 'NO_EM_RESTART': '1', 20:06:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:06:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:06:37 INFO - 'PWD': '/builds/slave/test', 20:06:37 INFO - 'SHELL': '/bin/bash', 20:06:37 INFO - 'SHLVL': '1', 20:06:37 INFO - 'TERM': 'linux', 20:06:37 INFO - 'TMOUT': '86400', 20:06:37 INFO - 'USER': 'cltbld', 20:06:37 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1476932732.428348-2083557137', 20:06:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:37 INFO - '_': '/tools/buildbot/bin/python'} 20:06:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:06: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)) 20:06: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)) 20:06: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)) 20:06: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)) 20:06: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)) 20:06: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)) 20:06: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)) 20:06: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)) 20:06: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)) 20:06: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)) 20:06: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)) 20:06:37 INFO - Cleaning up... 20:06:37 INFO - Return code: 0 20:06:37 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:06: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')]} 20:06:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:06:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06: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')]} 20:06:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:06:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06: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 0x7fe63a0c4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aceca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1acbf60>, '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 0x1accd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1acd1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1476932732.428348-2083557137', '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 20:06: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 20:06: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 20:06:37 INFO - Using env: {'DISPLAY': ':0', 20:06:37 INFO - 'HOME': '/home/cltbld', 20:06:37 INFO - 'LANG': 'en_US.UTF-8', 20:06:37 INFO - 'LANGUAGE': 'en_US:en', 20:06:37 INFO - 'LOGNAME': 'cltbld', 20:06:37 INFO - 'MAIL': '/var/mail/cltbld', 20:06:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:37 INFO - 'MOZ_NO_REMOTE': '1', 20:06:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:06:37 INFO - 'NO_EM_RESTART': '1', 20:06:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:06:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:06:37 INFO - 'PWD': '/builds/slave/test', 20:06:37 INFO - 'SHELL': '/bin/bash', 20:06:37 INFO - 'SHLVL': '1', 20:06:37 INFO - 'TERM': 'linux', 20:06:37 INFO - 'TMOUT': '86400', 20:06:37 INFO - 'USER': 'cltbld', 20:06:37 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1476932732.428348-2083557137', 20:06:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:37 INFO - '_': '/tools/buildbot/bin/python'} 20:06:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:06:37 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 20:06:37 INFO - Cleaning up... 20:06:37 INFO - Return code: 0 20:06:37 INFO - Running post-action listener: _resource_record_post_action 20:06:37 INFO - Running post-action listener: _start_resource_monitoring 20:06:37 INFO - Starting resource monitoring. 20:06:37 INFO - [mozharness: 2016-10-20 03:06:37.740016Z] Finished create-virtualenv step (success) 20:06:37 INFO - [mozharness: 2016-10-20 03:06:37.740516Z] Running install step. 20:06:37 INFO - Running pre-action listener: _resource_record_pre_action 20:06:37 INFO - Running main action method: install 20:06:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:06:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:06:37 INFO - Reading from file tmpfile_stdout 20:06:37 INFO - Detecting whether we're running mozinstall >=1.0... 20:06:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:06:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:06:38 INFO - Reading from file tmpfile_stdout 20:06:38 INFO - Output received: 20:06:38 INFO - Usage: mozinstall [options] installer 20:06:38 INFO - Options: 20:06:38 INFO - -h, --help show this help message and exit 20:06:38 INFO - -d DEST, --destination=DEST 20:06:38 INFO - Directory to install application into. [default: 20:06:38 INFO - "/builds/slave/test"] 20:06:38 INFO - --app=APP Application being installed. [default: firefox] 20:06:38 INFO - mkdir: /builds/slave/test/build/application 20:06: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'] 20:06: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 20:06:54 INFO - Reading from file tmpfile_stdout 20:06:54 INFO - Output received: 20:06:54 INFO - /builds/slave/test/build/application/firefox/firefox 20:06:54 INFO - Running post-action listener: _resource_record_post_action 20:06:54 INFO - [mozharness: 2016-10-20 03:06:54.117511Z] Finished install step (success) 20:06:54 INFO - [mozharness: 2016-10-20 03:06:54.117754Z] Running run-tests step. 20:06:54 INFO - Running pre-action listener: _resource_record_pre_action 20:06:54 INFO - Running main action method: run_tests 20:06:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:06:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:06:54 INFO - Python 2.7.3 20:06:54 INFO - Return code: 0 20:06:54 INFO - grabbing minidump binary from tooltool 20:06: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')]} 20:06: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 0x1acbf60>, '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 0x1accd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1acd1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:06: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 20:06: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 20:06: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 20:06:54 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:06:54 INFO - Return code: 0 20:06:54 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 20:06:54 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:06:54 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:06:54 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 20:06:54 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:06:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/INrxWV0BQ_-bDkvfwNDVgw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 20:06:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/INrxWV0BQ_-bDkvfwNDVgw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-042 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 20:06:54 INFO - Using env: {'DISPLAY': ':0', 20:06:54 INFO - 'HOME': '/home/cltbld', 20:06:54 INFO - 'LANG': 'en_US.UTF-8', 20:06:54 INFO - 'LANGUAGE': 'en_US:en', 20:06:54 INFO - 'LOGNAME': 'cltbld', 20:06:54 INFO - 'MAIL': '/var/mail/cltbld', 20:06:54 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:06:54 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 20:06:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:54 INFO - 'MOZ_NO_REMOTE': '1', 20:06:54 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:06:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:06:54 INFO - 'NO_EM_RESTART': '1', 20:06:54 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:06:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:06:54 INFO - 'PWD': '/builds/slave/test', 20:06:54 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:06:54 INFO - 'SHELL': '/bin/bash', 20:06:54 INFO - 'SHLVL': '1', 20:06:54 INFO - 'TERM': 'linux', 20:06:54 INFO - 'TMOUT': '86400', 20:06:54 INFO - 'USER': 'cltbld', 20:06:54 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1476932732.428348-2083557137', 20:06:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:54 INFO - '_': '/tools/buildbot/bin/python'} 20:06:54 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/INrxWV0BQ_-bDkvfwNDVgw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 20:06:54 INFO - mozversion application_buildid: 20161019183650 20:06:54 INFO - mozversion application_changeset: 998ad5a74da80fe63664a8dcf30d8f269ffe4e65 20:06:54 INFO - mozversion application_display_name: Nightly 20:06:54 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:06:54 INFO - mozversion application_name: Firefox 20:06:54 INFO - mozversion application_remotingname: firefox 20:06:54 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 20:06:54 INFO - mozversion application_vendor: Mozilla 20:06:54 INFO - mozversion application_version: 52.0a1 20:06:54 INFO - mozversion platform_buildid: 20161019183650 20:06:54 INFO - mozversion platform_changeset: 998ad5a74da80fe63664a8dcf30d8f269ffe4e65 20:06:54 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 20:06:54 INFO - mozversion platform_version: 52.0a1 20:06:54 INFO - using testdate: 1476932814 20:06:54 INFO - actual date: 1476932814 20:06:54 INFO - starting webserver on 'localhost:43740' 20:06:54 INFO - SUITE-START | Running 2 tests 20:06:54 INFO - TEST-START | dromaeo_css 20:06:54 INFO - operating with platform_type : linux_ 20:06:54 INFO - Initialising browser for dromaeo_css test... 20:06:54 INFO - TEST-INFO | started process 27576 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRwws4J/profile http://localhost:43740/getInfo.html) 20:06:58 INFO - PROCESS | 27576 | __metrics Screen width/height:1600/1200 20:06:58 INFO - PROCESS | 27576 | colorDepth:24 20:06:58 INFO - PROCESS | 27576 | Browser inner width/height: 1024/697 20:06:58 INFO - PROCESS | 27576 | __metrics 20:06:59 INFO - PROCESS | 27576 | 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" 20:06:59 INFO - PROCESS | 27576 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:06:59 INFO - PROCESS | 27576 | console.error: PushService: 20:06:59 INFO - PROCESS | 27576 | stateChangeProcessEnqueue: Error transitioning state 20:06:59 INFO - PROCESS | 27576 | UnknownError 20:07:00 INFO - TEST-INFO | 27576: exit 0 20:07:00 INFO - Browser initialized. 20:07:00 INFO - Running cycle 1/1 for dromaeo_css test... 20:07:00 INFO - TEST-INFO | started process 27659 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRwws4J/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:07:12 INFO - PROCESS | 27659 | RSS: Main: 172896256 20:07:12 INFO - PROCESS | 27659 | 20:08:04 INFO - PROCESS | 27659 | 1476932884374 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] 20:10:16 INFO - PROCESS | 27659 | Cycle 1(1): loaded http://localhost:43740/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43740/tests/dromaeo/cssquery-ext.html) 20:10:18 INFO - PROCESS | 27659 | RSS: Main: 404291584 20:10:18 INFO - PROCESS | 27659 | 20:13:21 INFO - PROCESS | 27659 | Cycle 1(1): loaded http://localhost:43740/tests/dromaeo/cssquery-ext.html (next: http://localhost:43740/tests/dromaeo/cssquery-jquery.html) 20:13:22 INFO - PROCESS | 27659 | RSS: Main: 277426176 20:13:22 INFO - PROCESS | 27659 | 20:16:24 INFO - PROCESS | 27659 | Cycle 1(1): loaded http://localhost:43740/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43740/tests/dromaeo/cssquery-mootools.html) 20:16:24 INFO - PROCESS | 27659 | RSS: Main: 217645056 20:16:24 INFO - PROCESS | 27659 | 20:19:27 INFO - PROCESS | 27659 | Cycle 1(1): loaded http://localhost:43740/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43740/tests/dromaeo/cssquery-prototype.html) 20:19:27 INFO - PROCESS | 27659 | RSS: Main: 217608192 20:19:27 INFO - PROCESS | 27659 | 20:22:31 INFO - PROCESS | 27659 | Cycle 1(1): loaded http://localhost:43740/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43740/tests/dromaeo/cssquery-yui.html) 20:22:31 INFO - PROCESS | 27659 | RSS: Main: 217776128 20:22:31 INFO - PROCESS | 27659 | 20:25:34 INFO - PROCESS | 27659 | Cycle 1(1): loaded http://localhost:43740/tests/dromaeo/cssquery-yui.html (next: http://localhost:43740/tests/dromaeo/cssquery-dojo.html) 20:25:34 INFO - PROCESS | 27659 | RSS: Main: 310091776 20:25:34 INFO - PROCESS | 27659 | 20:25:34 INFO - PROCESS | 27659 | __start_tp_report 20:25:34 INFO - PROCESS | 27659 | _x_x_mozilla_page_load 20:25:34 INFO - PROCESS | 27659 | _x_x_mozilla_page_load_details 20:25:34 INFO - PROCESS | 27659 | |i|pagename|runs| 20:25:34 INFO - PROCESS | 27659 | |0;dojo.html;2581.7547333003363;2585.5216784894806;2616.476704659068;2627.6978147513028;2638.617400476931;4500.774961251941;4566.292224705176;4589.793459294331;4596.126735920173;4600.516945720701;4605.516420775821;4617.8152873885;4665.3235280884255;4689.554492323233;4715.056988602276;4232.259354612946;4244.766537840433;4290.334998075287;4293.892652683677;4306.440162778835;4315.870523884289;4322.589354011379;4351.108022855307;4359.411479450266;4405.537418571052;4312.547182545819;4341.45731783527;4361.520232774392;4368.126374725068;4397.164538737629;4168;4201.411802347674;4210.1579684063;4233;4267.637250833683;4240.342746874239;4257;4299.699021068526;4316.395704601358;4316.870493885189;4596.839110631146;4602.677812553123;4618.030213655136;4659.580637742585;4699.389079419688;4761.523847615245;4814.494478079786;4821.517848215186;4888.144574699413;4904.877378065541;4907.558319751204;4916.729579873106;4975.527324904128;4977.751112444364;5032.345795046657;4634.351190833286;4645.187092258841;4648.302754586772;4648.558386953234;4690.53094690535;4893.853184404474;5054.241863720398;5068.062408454448;5072.416672082684;5141.2288156776785;4752.7861246244;4813.302071199656;4827.806887724522;4840.443349014838;4845.685030473008;4920.606351491872;4920.803167873317;4924.409070911442;4928.975355123273;4966.453690094087;4867.634927380461;4871.634627402959;4891.461939186758;4893.437254715682;4929.359183306147;4711.128441238382;4720.433547974265;4768.332433459318;4805.519448055236;4837.516248375135;4063.6489483633904;4067.044244602516;4069.104796944667;4114.485689288839;4122.505299364036;3604.2611264690677;3607.2424790793702;3636.4363523653874;3651.050726811048;3653.7990410527677;4229.386738922901;4250.957490425118;4317.84887528935;4318.201132790444;4326.697131200849;4864.416270047617;4885.7312847793;4909.558139767367;4925.088858561177;4971.875703107451;4287.464066991626;4292.82828686849;4295.742255464682;4298.4841818981295;4352.194843953878;4328.026194106364;4336.804843782037;4338.848140315074;4386.407834942306;4390.648748100144;4538.841140559998;4575.222212223996;4579.5878370946775;4623.722576645412;4627.953720462887;4815.6147508199965;4850.369451971221;4858.611311095033;4861.829835955725;4864.73243971585;4607.6313894889;4619.907601848012;4645.419322584677;4688.742119183341;4693;4809.78355973975;4811.975940120277;4815.903681926272;4855.077535268288;4873;4837.733924634179;4869.293952376956;4881.926771098508;4887.60899128076;4950.77721502526;4619.838305659286;4671.229247174178;4674.906501870011;4679.789409476513;4726.6455015874635;4714.9292760609305;4724.551167639069;4725.5510726480925;4726.243800991825;4727.196376615915;4661.021185551072;4671.042436300618;4688.812447502061;4695.741734204652;4700.130475861976;4746.145693775154;4769.403824521934;4794.400699912511;4795.736234506996;4796.424429068534;4689.695169813951;4729.621630269639;4766.404199475066;4776.23580227162;4834.8791280218275 20:25:34 INFO - PROCESS | 27659 | |1;ext.html;572.5190839694657;587.3832475900305;595.3540408656613;604.7460066771955;605.6971514242879;27891.30271743205;39010.609893901084;40495.797521012355;40606;44855.775721121434;41423.58576414242;41916;41933.79033104838;41978;41988.160236795244;7642.197569255218;7795.376369890395;7796.454248202628;7797.961010194941;7801.648925798353;7659.617019149048;7755.224477552228;7755.302022817945;7758.650860711282;7761.3402860756905;7729.61351932404;7790.649420776051;7794.259545343183;7797.181295963927;7801.843963120734;7747.767566973;7786.688532458695;7789.844203115906;7791.532508049535;7795.610219489003;7658.272464115956;7731.884021739678;7741.7677469676;7743.186965368612;7751.573663448508;38253.42619860704;38529;38574.44234480145;38630;38631.42052869209;2903.651561812596;2905.6513218413716;2915.7958942874006;3000.489916714142;3200.3279311344645;27920.16239512818;28102.43795124086;28461.857690711415;28478.572821407695;29236.269093272625;3260;3349.6482869298616;3351.463765797485;3380.983095084509;3426.0920855973186;246195;247759;248009;248391.9999999982;248947;50372.244416333786;50464.49535504671;50476.74761626168;50576;50616.49383506118;32022;32979.505307420404;33071.3385732284;53609.1958620621;53692;12681.746365072831;12776.744465110645;12794.552190673281;12800.61598152057;12801.61595152147;8673.869891951626;8691.130886911258;8722.040575536686;8741.475511469333;8768.254698350584;17978.190981405867;18016.549586260448;18050.729239061424;18086.90956545209;18196.363127290748;6708.42978346846;6869.656517174121;6929.648718499844;7047.189573199045;7082.802547770701;780.7384526183679;903.4940433357341;913.5340976102103;967.9691128947649;1022.5091955861228;26018.178727488896;27085.729142708715;28187.295317616812;29464.852675736915;29967;752.236479972828;914.6844338703137;917.5824999625155;932.6689025396022;981.5533932060895;13681.179129252077;14394.568162955127;14478.203698796668;14582.708345833023;14663.413463461342;385204;386283;386314;386602;386956;48678.51321486811;49056.509434905194;49079.75460122676;49148;49163;1025.933314334566;1093.8468614393992;1133.9149563782585;1167.6905620010705;1193.2482536002262;25586.360340991625;28915.7108428913;29757.472424231295;29796.85101574478;29915.252118697208;41293.58706412897;46369.76815115903;48244;48273.75863120662;53399.46600533945;336685;339927;340314;341121;341611;24269.878650606635;24854.254372368858;25025.624615630415;26316.605250921635;37668.81165594154;40487.392689109096;40779.59220407758;40792.796036020816;40933.38599921063;41765.58234417617;35099.64900351066;35473.82263088668;35923.46114808228;35962.4605630921;36181.81909090438;35722.464163038094;35956.46065309075;35977.280454391286;36479.27041459209;36697.81651091728;35055;35236.647633524364;35678.10804729902;36022.63977360193;36426.63573364339;30884.536731949487;32991.87601549806;33042.33915321632;33290.334193316485;33322.333553329285;24768;24923;25124.874375628006;25372;25619.359516011504 20:25:34 INFO - PROCESS | 27659 | |2;jquery.html;338.6089067127469;361.1675088920038;364.30054295752154;365.63253929800544;378.91063193319206;12972.610821675353;13017.958563314936;13038.21770693759;13385.933070334635;17477.47567572972;13798.172109673427;14271.857281427183;15333;15778.605534861634;15867.603309917258;4887.413510378742;4894.730789806559;5018.422881368635;5058.418281897573;5118.59051275897;5024.698518088908;5113.233015047754;5115.590752739772;5116.283720279164;5116.820911268106;3712.777233365993;3909.3940439231965;5620.747066382002;5919.023361145428;5955.553333499983;5835.270591176103;5929.229200203989;6031.095335699636;6034.758609655609;6036.577439579231;5269.657472264291;5278.894422111574;5285.68285902847;5289.233061206103;5290.9735451322495;20465.18139274442;20745.377638670863;20816.375508734764;20957;21125.366239012856;1714.8027976782705;1798.3885478937093;1852.3979706595276;1956.3544030469911;2079.6464601017865;12818.935905320506;12954.740905181938;12960.092793504458;13099.607011789662;13577;1661.941832035873;1682.5877659973385;1708.453294945618;1749.8337657922477;1756.4906177208595;67542.9868551977;67928.32071679269;68144.6592767038;69322.65338673325;69473.65263173703;8998.730038098736;9091.954540227256;9308.813823723487;9514.096160864707;9649.276304277208;13029.47882084706;13061.281629510278;13066.673333166556;13078.476860925646;13080.803787943189;6224.654417425509;6555.2133743951035;6599.8020059398295;6641.900371494335;6761.121054262914;6181.320054793969;6182.783602573888;6307.022411526221;6326.652034138075;6338.58799178052;5926.703664816742;6011.789587364421;6027.011086341497;6029.336772954972;6072.392760723892;1709.3504468301965;1709.3931654262806;1711.4437807712543;1736.8957862528289;1752.7195648696147;828.5691440450931;829;854.5940678177816;917.0737555069295;967.5452537307455;16704.24605416438;16911;17237.655246894992;17521.474355769347;17836.46490605284;839.693511868176;853.9231469167805;870.616928551448;874.9693760718344;897.8159477307137;7698.538087714755;9404.764880878032;9957.157925783753;9972.551235194434;10117.494125293706;349507;351085;352371;352530;352985;45772.3134152988;48175.759121204166;67885;82784.58607707043;85330.57334713287;886.5301390263171;903.8915330160423;932.9953350233205;935.1910597333393;938.2400255792829;15362.846371536141;15433.382664693736;15839;16231;16439.589010274838;34327.485087724206;34977;36187.27625447529;38421.6157838418;39649.2070158601;47674.76162619165;50527.74736126443;51335.22997154971;51573.7421312906;52493.7375313121;6584.868302633825;6667.2666006738245;6726.6636668167375;6823.624700641512;6865.176178858569;8761.780955476164;10870.782584348111;11723.472443739882;11847;12142.817857731965;9612.903870961201;9818.45998470091;10171.186305095427;10556.577736890438;10795.676129716121;10178.13485853681;10340.224483163642;10625.574977000833;10702.304350217211;10898.618548350769;9677.49998750195;10048.748781280527;10117.645882394081;10336.431496267476;10337.608609843997;6988.301169882971;7023.648817558999;7031.929680703128;7180.964095179491;7237.782866514013;8599.742007739778;9929;10056.396616203052;10148.188144948239;10167.949160254448 20:25:34 INFO - PROCESS | 27659 | |3;mootools.html;1242.9751404971896;1370.9657258568534;1407.486267512358;1498.8950773445863;1702.0893821805337;6869.587824730514;7588;7796.571188584626;7828.256315650018;8005.759827205178;7880.093789214242;7970.481918675297;7973.481723687971;7975.641096150673;7978.92021079789;2160.6975023496684;2185.2024011235944;2191.079746506463;2193.901274442654;2193.9451513712124;1993.9401817945413;2046.2735728816278;2047.0072015072678;2047.9897600511977;2050.2004218354778;2103.5372218112066;2120.872747635147;2127.5000374911883;2132.9786702133015;2171.337741988693;1987.9801201987939;1990.263602467082;1992.4122383896786;1999.3701983875033;1999.8200161985346;2121.7559980602273;2125.6598944169014;2153.7738537453656;2159.362987918568;2163.8485306028583;7660.080790305199;7776.261255180749;7779.7666070017995;7867.331276841475;7868.095169055575;4322.654187664979;4469.039156581318;4489.483709373431;4495.617872480843;4497.370368148429;2791.9022834200705;2880.2367372646268;2944.7202515761182;2955.9113226603235;2957.423302456022;935.6444551070549;944.1361154543584;961.3462845265217;968.4431451915107;975.1175186456197;10559.788804223872;10770.838437423445;10809.405482698448;10809.891901081046;10820.02619764225;4123.2165888481095;4137.193247316744;4233.936490952638;4240.512341080754;4311.353297005474;9279.257659387233;9284.814303714023;9297.442153470813;9305.860412093823;9314.627414903329;4431.313146462304;4455.242608756519;4479.776011199427;4489.618382437464;4493.865184044484;3514.279572687593;3527.9294414111573;3620.149264922741;4167.187398457272;4173.770442625624;3197.5683282756995;3644.0889777555612;3645.453182022665;3667.1198912260866;3678.9080272993388;1129.5425352732157;1157.1090260499536;1170.1984140863535;1171.1509155861932;1191.2614179208772;683.5864302097259;820.1634332980327;827.5034979012544;833.9499630022218;836.4019725896013;4989.600831933437;5024.32171656829;5048.823291184791;5132.021195307425;5203.843884683465;370.19667321911516;381.28699332248874;382.61929380266815;394.65664871561927;397.83489851711215;3571.7321200910037;3603.621619729943;3665.523481947383;3684.8526058957877;3733.216024634857;9302.25581953442;9686.031396860399;9692.46691431978;9701;9706.854397184048;9349.252059835197;9587.712368628952;9612.423254604606;9622;9634.614615415445;7061.646917654097;7241.167265764399;7246.492745507764;7248.130224373003;7253.347198752138;5116.769745361393;5121.539061484485;5138.100832354248;5286.524212820865;5388.649737767033;8775.648974040967;8838.072002439909;8863.689770857989;8866.468011919305;8868.64525418976;8136.837263254583;8675.262602678591;8912.108789121035;9112.635494580143;9128.5435728212;6195.597286176384;6652;6804.285550017375;6835.692393842389;6932.376086152271;7384.261573842573;7468.253174682488;7528.209537998431;7538.057742782153;7540.811479713051;6562.901556476561;6567.573107747981;6712.563683360566;6754.5947243165565;6835.248122706399;6649.867002660017;6762.49281303914;6867.656617169221;6874.621895795779;6884.51808373409;5951.196588460502;6124.908126378197;6188.9690551546955;6279.591826531261;6280.780172693934;4583.770811459347;4592.563706447882;4630.490646029001;4658.883527911829;4756.215224488059;4516.728996260234;4629.768511574341;4641.3734145889875;4659.673822832369;4767.212295389229 20:25:34 INFO - PROCESS | 27659 | |4;prototype.html;287.307588711206;289.5974595312516;294.65525335357637;298.98355590442515;301.37765514213163;4747.382840230769;4775.976120119403;4777.259524773657;4798.4001999750035;4803.447603525591;4720.858374248769;4725.3384526166365;4726.385569875912;4729.739864307462;4736.360591320171;3529.400001999666;3562.430011198209;3641.0715267606724;3642.417213245868;3708.1656627258785;3681.5641899659154;3705.94441083384;3711.164987877733;3727.310447567209;3728.7576307540057;3658.5975542690417;3674.228412033476;3686.373316536182;3690.132818787583;3696.2607478504274;3511.911307494672;3568.4825700273573;3622.2755448910325;3680.656560355451;3704.1479260369815;3274.950875736866;3278.7049165575213;3279.9172525446274;3289.73682105431;3291.8518666660057;4589.898424378159;4598.885027874297;4600.42494688164;4605.516420775837;4620.745858977755;3941.5467221269346;4147.585241475858;4222.218889505451;4228.471441069866;4237.703360764748;4905.607551395879;4915.041566894457;4920.704757714549;4920.778564964585;4931.80272789088;3498.265364273506;3502.2820321833965;3503.5970863350785;3503.6321186275327;3504;4999.75001249936;5134.563562097189;5154.819581314636;5159.509846564571;5160;3547.7161827053774;3559.661832125944;3568.6252943441086;3570.9285814283567;3588.102974256436;3609.5848977367414;3617.3127105849803;3622.221222437136;3628.3650361186687;3634.400323946572;4148.149629325981;4148.170365926827;4148.419221309019;4152.854650087233;4158.896027599334;4749.287606858929;4892.143874821892;4902.8774280643265;4918.311436398907;4928.334674818925;1237.7807859258623;1248.8563815161192;1252.4551819958347;1252.542821870029;1254.8055051467038;764.289211033744;788.5805550010074;794.7734895554739;803.8553060449175;813.2071230550166;4291.270484017725;4296.935545966813;4474.306482495218;4474.366856097501;4478.48497422794;5066.594672426197;5074.3657042869645;5083.872903177376;5092.567131793765;5103.413107492612;4436;4449.688521803443;4452.1763473757455;4453.64163929998;4457.064016556559;2548.2610043087666;2685.8925642974064;2695.905643302475;2706.7157948415525;2708.2010806812036;4833.226683730586;4836.443808961944;4836.968473241247;4849.830255941025;4854.368932038883;4961.826336078292;5191.6884986900905;5199.090159222196;5201.540975251415;5203.401608814959;4799.9760001199775;4818.590419814285;4822.614190864792;4839.903201935871;4842.927356089662;5037.924431133462;5069.264956581202;5079.441261461162;5093.307352169647;5117.385913690381;4712.717236965793;4962.875928101682;4970.304157418037;4983.626228032839;4984.152694041949;4855.6601037927;4861.683990540603;4873.707577545359;4887.780049897692;4897.873489097598;3581.051021479362;3587.766795158306;3603.657652523006;3608.394264552249;3614.4578313252173;4965.244289419407;5107.642465027412;5109.642325037212;5125.2568377585785;5137.460566640449;4896.92654610174;4902.926456103232;4916.311716359784;4926.926096108489;4966.602671786321;4953.331300274417;4960.379952505937;4965.577925876341;4977.751112444435;4993.725345105909;4763.642726795435;4911.4106307243355;4911.803527858846;4913.729744864067;4926.359573255454;4724.173269677862;4829.179039563212;4866.1727506323305;4900.730459824601;5005.299258103942;4804.759762011816;4805;4849.878753031061;4858.246971719389;4867.318575399518 20:25:34 INFO - PROCESS | 27659 | |5;yui.html;590.610197269802;608.9512838972882;623.305014908377;650.5056157320435;671.5299290496652;12813.359332033397;12850.678733031678;13779.724405511884;13786.24175670339;13797.448102075918;13047.934760326185;13072.21566705996;13182.934085329583;13258.93370533146;13272.734545309087;761.8019314978104;785.3834739729314;787.3819052044147;787.8660627693278;788.1291173253559;627.7677259414023;645.4320198225555;650.5608714117975;651.7490766055079;801.8516574433719;671.2180309938915;810.785141937387;839.3117643532306;843.1652663862762;846.9237768600825;831.8710599857031;835.2357592802579;835.6323217784217;836.7071524966213;837.0165056059107;605.5760967322892;605.8848818724429;606.2724730323629;606.5693357716027;606.7118118893491;10386.948065259701;10841.945790271076;12606.180598261084;13164.341782910817;13190.67023324415;12633.620991370273;13639.454421823115;13729.519466818714;13748.862511374959;13800.516981905686;9699.563519641633;9820.705378838575;10000.79998400028;10129.949350253275;10248.948755256177;3283.40898638245;3326.850291736878;3358.3283343331186;3385.5260263563123;3457.2048428861253;63462.365376346104;63648;64230;64794.676026620036;65488.672556637386;10267.383956962607;10399;10480.109190718875;10540.156787456985;10798.298110622783;19444.902775486316;19564.413067607995;19565.315213967442;19569.902150489157;19572.412827615193;6448.3229260927865;6462.192225971754;6593;6693.899591506131;6719.0593316935665;3462.79223246606;3547.8758243461357;3588.085038315213;3642.453631955228;3748.756330838487;3000.1749518882484;3061.877524898979;3091.2580980564953;3093.90718278452;3098.9380212395627;493.8123513065012;496.473737837893;508.63378367575285;518.3675915383227;519.5168493301267;488.8606747077137;599.2102665350444;615.9568830181934;617.4227097663698;620.8758248350348;7757.456978011485;7959.920400795918;8023.6790528378215;8180.46826956246;8361.372897032747;490.5217413022275;531.0918329656254;566.8469513231404;581.517340607295;604.0998911621652;3675.632436756303;3721.7394782364972;3761.7931013794505;3837;3837.6737977271687;55807.44192558023;75884;78984.60507697424;79320.60339698264;87975;76251.61874190594;78541.28752274881;80464;80795;80916.19083809204;44280.3357949631;46854.08032156574;66195.66902165554;73995.63002184955;74048.62975685195;8009.479383840032;8433.325333973145;8719.956400217958;8734.475931444134;8734.781630459289;44332.77833610812;46161.53838461573;46324;46786.76606616945;47220;64223.678881605294;65238.34761652323;66054;66423.66788166028;67315;11001.119910407308;11015.669529914116;11191.160662950475;11255.099592032453;11271.041961433042;11148.219624626197;11373.374464404536;11533.365664888512;11567.190296679151;11732.002779763816;11721.531138754355;11780.234284771463;12165.270083795001;12565.685857853627;12580.30808305552;11696.941515292368;11719.648410547697;11760.235584686969;11961.760764784482;12364.505419783467;11028.5037173329;11035.117190624891;11102.500387482743;11402.144839137263;12421.130520863453;9651.179649729851;9760.804783904141;9978.151857091938;9981.700548983543;10393;9640.614375424904;10165.898341016791;10232.48837558134;10233.692989210336;10484.475776211006 20:25:34 INFO - PROCESS | 27659 | __end_tp_report 20:25:34 INFO - PROCESS | 27659 | __start_cc_report 20:25:34 INFO - PROCESS | 27659 | _x_x_mozilla_cycle_collect,2595 20:25:34 INFO - PROCESS | 27659 | __end_cc_report 20:25:34 INFO - PROCESS | 27659 | __startTimestamp1476933934915__endTimestamp 20:25:34 INFO - PROCESS | 27659 | 20:25:34 INFO - PROCESS | 27659 | ------- Summary: start ------- 20:25:34 INFO - PROCESS | 27659 | Number of tests: 6 20:25:34 INFO - PROCESS | 27659 | 20:25:34 INFO - PROCESS | 27659 | [#0] dojo.html Cycles:165 Average:4541.63 Median:4671.23 stddev:457.21 (9.8%) stddev-sans-first:431.99 20:25:34 INFO - PROCESS | 27659 | Values: 2581.8 2585.5 2616.5 2627.7 2638.6 4500.8 4566.3 4589.8 4596.1 4600.5 4605.5 4617.8 4665.3 4689.6 4715.1 4232.3 4244.8 4290.3 4293.9 4306.4 4315.9 4322.6 4351.1 4359.4 4405.5 4312.5 4341.5 4361.5 4368.1 4397.2 4168.0 4201.4 4210.2 4233.0 4267.6 4240.3 4257.0 4299.7 4316.4 4316.9 4596.8 4602.7 4618.0 4659.6 4699.4 4761.5 4814.5 4821.5 4888.1 4904.9 4907.6 4916.7 4975.5 4977.8 5032.3 4634.4 4645.2 4648.3 4648.6 4690.5 4893.9 5054.2 5068.1 5072.4 5141.2 4752.8 4813.3 4827.8 4840.4 4845.7 4920.6 4920.8 4924.4 4929.0 4966.5 4867.6 4871.6 4891.5 4893.4 4929.4 4711.1 4720.4 4768.3 4805.5 4837.5 4063.6 4067.0 4069.1 4114.5 4122.5 3604.3 3607.2 3636.4 3651.1 3653.8 4229.4 4251.0 4317.8 4318.2 4326.7 4864.4 4885.7 4909.6 4925.1 4971.9 4287.5 4292.8 4295.7 4298.5 4352.2 4328.0 4336.8 4338.8 4386.4 4390.6 4538.8 4575.2 4579.6 4623.7 4628.0 4815.6 4850.4 4858.6 4861.8 4864.7 4607.6 4619.9 4645.4 4688.7 4693.0 4809.8 4812.0 4815.9 4855.1 4873.0 4837.7 4869.3 4881.9 4887.6 4950.8 4619.8 4671.2 4674.9 4679.8 4726.6 4714.9 4724.6 4725.6 4726.2 4727.2 4661.0 4671.0 4688.8 4695.7 4700.1 4746.1 4769.4 4794.4 4795.7 4796.4 4689.7 4729.6 4766.4 4776.2 4834.9 20:25:34 INFO - PROCESS | 27659 | 20:25:34 INFO - PROCESS | 27659 | [#1] ext.html Cycles:180 Average:47501.10 Median:211728.71 stddev:86900.75 (41.0%) stddev-sans-first:87073.10 20:25:34 INFO - PROCESS | 27659 | Values: 572.5 587.4 595.4 604.7 605.7 27891.3 39010.6 40495.8 40606.0 44855.8 41423.6 41916.0 41933.8 41978.0 41988.2 7642.2 7795.4 7796.5 7798.0 7801.6 7659.6 7755.2 7755.3 7758.7 7761.3 7729.6 7790.6 7794.3 7797.2 7801.8 7747.8 7786.7 7789.8 7791.5 7795.6 7658.3 7731.9 7741.8 7743.2 7751.6 38253.4 38529.0 38574.4 38630.0 38631.4 2903.7 2905.7 2915.8 3000.5 3200.3 27920.2 28102.4 28461.9 28478.6 29236.3 3260.0 3349.6 3351.5 3381.0 3426.1 246195.0 247759.0 248009.0 248392.0 248947.0 50372.2 50464.5 50476.7 50576.0 50616.5 32022.0 32979.5 33071.3 53609.2 53692.0 12681.7 12776.7 12794.6 12800.6 12801.6 8673.9 8691.1 8722.0 8741.5 8768.3 17978.2 18016.5 18050.7 18086.9 18196.4 6708.4 6869.7 6929.6 7047.2 7082.8 780.7 903.5 913.5 968.0 1022.5 26018.2 27085.7 28187.3 29464.9 29967.0 752.2 914.7 917.6 932.7 981.6 13681.2 14394.6 14478.2 14582.7 14663.4 385204.0 386283.0 386314.0 386602.0 386956.0 48678.5 49056.5 49079.8 49148.0 49163.0 1025.9 1093.8 1133.9 1167.7 1193.2 25586.4 28915.7 29757.5 29796.9 29915.3 41293.6 46369.8 48244.0 48273.8 53399.5 336685.0 339927.0 340314.0 341121.0 341611.0 24269.9 24854.3 25025.6 26316.6 37668.8 40487.4 40779.6 40792.8 40933.4 41765.6 35099.6 35473.8 35923.5 35962.5 36181.8 35722.5 35956.5 35977.3 36479.3 36697.8 35055.0 35236.6 35678.1 36022.6 36426.6 30884.5 32991.9 33042.3 33290.3 33322.3 24768.0 24923.0 25124.9 25372.0 25619.4 20:25:34 INFO - PROCESS | 27659 | 20:25:34 INFO - PROCESS | 27659 | [#2] jquery.html Cycles:180 Average:22790.99 Median:4891.07 stddev:58153.99 (1189.0%) stddev-sans-first:58292.69 20:25:34 INFO - PROCESS | 27659 | Values: 338.6 361.2 364.3 365.6 378.9 12972.6 13018.0 13038.2 13385.9 17477.5 13798.2 14271.9 15333.0 15778.6 15867.6 4887.4 4894.7 5018.4 5058.4 5118.6 5024.7 5113.2 5115.6 5116.3 5116.8 3712.8 3909.4 5620.7 5919.0 5955.6 5835.3 5929.2 6031.1 6034.8 6036.6 5269.7 5278.9 5285.7 5289.2 5291.0 20465.2 20745.4 20816.4 20957.0 21125.4 1714.8 1798.4 1852.4 1956.4 2079.6 12818.9 12954.7 12960.1 13099.6 13577.0 1661.9 1682.6 1708.5 1749.8 1756.5 67543.0 67928.3 68144.7 69322.7 69473.7 8998.7 9092.0 9308.8 9514.1 9649.3 13029.5 13061.3 13066.7 13078.5 13080.8 6224.7 6555.2 6599.8 6641.9 6761.1 6181.3 6182.8 6307.0 6326.7 6338.6 5926.7 6011.8 6027.0 6029.3 6072.4 1709.4 1709.4 1711.4 1736.9 1752.7 828.6 829.0 854.6 917.1 967.5 16704.2 16911.0 17237.7 17521.5 17836.5 839.7 853.9 870.6 875.0 897.8 7698.5 9404.8 9957.2 9972.6 10117.5 349507.0 351085.0 352371.0 352530.0 352985.0 45772.3 48175.8 67885.0 82784.6 85330.6 886.5 903.9 933.0 935.2 938.2 15362.8 15433.4 15839.0 16231.0 16439.6 34327.5 34977.0 36187.3 38421.6 39649.2 47674.8 50527.7 51335.2 51573.7 52493.7 6584.9 6667.3 6726.7 6823.6 6865.2 8761.8 10870.8 11723.5 11847.0 12142.8 9612.9 9818.5 10171.2 10556.6 10795.7 10178.1 10340.2 10625.6 10702.3 10898.6 9677.5 10048.7 10117.6 10336.4 10337.6 6988.3 7023.6 7031.9 7181.0 7237.8 8599.7 9929.0 10056.4 10148.2 10167.9 20:25:34 INFO - PROCESS | 27659 | 20:25:34 INFO - PROCESS | 27659 | [#3] mootools.html Cycles:180 Average:5087.60 Median:5006.96 stddev:2913.88 (58.2%) stddev-sans-first:2907.73 20:25:34 INFO - PROCESS | 27659 | Values: 1243.0 1371.0 1407.5 1498.9 1702.1 6869.6 7588.0 7796.6 7828.3 8005.8 7880.1 7970.5 7973.5 7975.6 7978.9 2160.7 2185.2 2191.1 2193.9 2193.9 1993.9 2046.3 2047.0 2048.0 2050.2 2103.5 2120.9 2127.5 2133.0 2171.3 1988.0 1990.3 1992.4 1999.4 1999.8 2121.8 2125.7 2153.8 2159.4 2163.8 7660.1 7776.3 7779.8 7867.3 7868.1 4322.7 4469.0 4489.5 4495.6 4497.4 2791.9 2880.2 2944.7 2955.9 2957.4 935.6 944.1 961.3 968.4 975.1 10559.8 10770.8 10809.4 10809.9 10820.0 4123.2 4137.2 4233.9 4240.5 4311.4 9279.3 9284.8 9297.4 9305.9 9314.6 4431.3 4455.2 4479.8 4489.6 4493.9 3514.3 3527.9 3620.1 4167.2 4173.8 3197.6 3644.1 3645.5 3667.1 3678.9 1129.5 1157.1 1170.2 1171.2 1191.3 683.6 820.2 827.5 833.9 836.4 4989.6 5024.3 5048.8 5132.0 5203.8 370.2 381.3 382.6 394.7 397.8 3571.7 3603.6 3665.5 3684.9 3733.2 9302.3 9686.0 9692.5 9701.0 9706.9 9349.3 9587.7 9612.4 9622.0 9634.6 7061.6 7241.2 7246.5 7248.1 7253.3 5116.8 5121.5 5138.1 5286.5 5388.6 8775.6 8838.1 8863.7 8866.5 8868.6 8136.8 8675.3 8912.1 9112.6 9128.5 6195.6 6652.0 6804.3 6835.7 6932.4 7384.3 7468.3 7528.2 7538.1 7540.8 6562.9 6567.6 6712.6 6754.6 6835.2 6649.9 6762.5 6867.7 6874.6 6884.5 5951.2 6124.9 6189.0 6279.6 6280.8 4583.8 4592.6 4630.5 4658.9 4756.2 4516.7 4629.8 4641.4 4659.7 4767.2 20:25:34 INFO - PROCESS | 27659 | 20:25:34 INFO - PROCESS | 27659 | [#4] prototype.html Cycles:180 Average:4104.01 Median:4733.05 stddev:1198.82 (25.3%) stddev-sans-first:1167.45 20:25:34 INFO - PROCESS | 27659 | Values: 287.3 289.6 294.7 299.0 301.4 4747.4 4776.0 4777.3 4798.4 4803.4 4720.9 4725.3 4726.4 4729.7 4736.4 3529.4 3562.4 3641.1 3642.4 3708.2 3681.6 3705.9 3711.2 3727.3 3728.8 3658.6 3674.2 3686.4 3690.1 3696.3 3511.9 3568.5 3622.3 3680.7 3704.1 3275.0 3278.7 3279.9 3289.7 3291.9 4589.9 4598.9 4600.4 4605.5 4620.7 3941.5 4147.6 4222.2 4228.5 4237.7 4905.6 4915.0 4920.7 4920.8 4931.8 3498.3 3502.3 3503.6 3503.6 3504.0 4999.8 5134.6 5154.8 5159.5 5160.0 3547.7 3559.7 3568.6 3570.9 3588.1 3609.6 3617.3 3622.2 3628.4 3634.4 4148.1 4148.2 4148.4 4152.9 4158.9 4749.3 4892.1 4902.9 4918.3 4928.3 1237.8 1248.9 1252.5 1252.5 1254.8 764.3 788.6 794.8 803.9 813.2 4291.3 4296.9 4474.3 4474.4 4478.5 5066.6 5074.4 5083.9 5092.6 5103.4 4436.0 4449.7 4452.2 4453.6 4457.1 2548.3 2685.9 2695.9 2706.7 2708.2 4833.2 4836.4 4837.0 4849.8 4854.4 4961.8 5191.7 5199.1 5201.5 5203.4 4800.0 4818.6 4822.6 4839.9 4842.9 5037.9 5069.3 5079.4 5093.3 5117.4 4712.7 4962.9 4970.3 4983.6 4984.2 4855.7 4861.7 4873.7 4887.8 4897.9 3581.1 3587.8 3603.7 3608.4 3614.5 4965.2 5107.6 5109.6 5125.3 5137.5 4896.9 4902.9 4916.3 4926.9 4966.6 4953.3 4960.4 4965.6 4977.8 4993.7 4763.6 4911.4 4911.8 4913.7 4926.4 4724.2 4829.2 4866.2 4900.7 5005.3 4804.8 4805.0 4849.9 4858.2 4867.3 20:25:34 INFO - PROCESS | 27659 | 20:25:34 INFO - PROCESS | 27659 | [#5] yui.html Cycles:180 Average:16824.21 Median:489.69 stddev:22938.85 (4684.4%) stddev-sans-first:22970.81 20:25:34 INFO - PROCESS | 27659 | Values: 590.6 609.0 623.3 650.5 671.5 12813.4 12850.7 13779.7 13786.2 13797.4 13047.9 13072.2 13182.9 13258.9 13272.7 761.8 785.4 787.4 787.9 788.1 627.8 645.4 650.6 651.7 801.9 671.2 810.8 839.3 843.2 846.9 831.9 835.2 835.6 836.7 837.0 605.6 605.9 606.3 606.6 606.7 10386.9 10841.9 12606.2 13164.3 13190.7 12633.6 13639.5 13729.5 13748.9 13800.5 9699.6 9820.7 10000.8 10129.9 10248.9 3283.4 3326.9 3358.3 3385.5 3457.2 63462.4 63648.0 64230.0 64794.7 65488.7 10267.4 10399.0 10480.1 10540.2 10798.3 19444.9 19564.4 19565.3 19569.9 19572.4 6448.3 6462.2 6593.0 6693.9 6719.1 3462.8 3547.9 3588.1 3642.5 3748.8 3000.2 3061.9 3091.3 3093.9 3098.9 493.8 496.5 508.6 518.4 519.5 488.9 599.2 616.0 617.4 620.9 7757.5 7959.9 8023.7 8180.5 8361.4 490.5 531.1 566.8 581.5 604.1 3675.6 3721.7 3761.8 3837.0 3837.7 55807.4 75884.0 78984.6 79320.6 87975.0 76251.6 78541.3 80464.0 80795.0 80916.2 44280.3 46854.1 66195.7 73995.6 74048.6 8009.5 8433.3 8720.0 8734.5 8734.8 44332.8 46161.5 46324.0 46786.8 47220.0 64223.7 65238.3 66054.0 66423.7 67315.0 11001.1 11015.7 11191.2 11255.1 11271.0 11148.2 11373.4 11533.4 11567.2 11732.0 11721.5 11780.2 12165.3 12565.7 12580.3 11696.9 11719.6 11760.2 11961.8 12364.5 11028.5 11035.1 11102.5 11402.1 12421.1 9651.2 9760.8 9978.2 9981.7 10393.0 9640.6 10165.9 10232.5 10233.7 10484.5 20:25:34 INFO - PROCESS | 27659 | -------- Summary: end -------- 20:25:34 INFO - PROCESS | 27659 | 20:25:35 INFO - TEST-INFO | 27659: exit 0 20:25:35 INFO - TEST-OK | dromaeo_css | took 1121523ms 20:25:35 INFO - TEST-START | kraken 20:25:35 INFO - operating with platform_type : linux_ 20:25:35 INFO - Initialising browser for kraken test... 20:25:35 INFO - TEST-INFO | started process 27970 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTK0I23/profile http://localhost:43740/getInfo.html) 20:25:40 INFO - PROCESS | 27970 | __metrics Screen width/height:1600/1200 20:25:40 INFO - PROCESS | 27970 | colorDepth:24 20:25:40 INFO - PROCESS | 27970 | Browser inner width/height: 1024/697 20:25:40 INFO - PROCESS | 27970 | __metrics 20:25:40 INFO - PROCESS | 27970 | 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" 20:25:40 INFO - PROCESS | 27970 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:25:41 INFO - PROCESS | 27970 | console.error: PushService: 20:25:41 INFO - PROCESS | 27970 | stateChangeProcessEnqueue: Error transitioning state 20:25:41 INFO - PROCESS | 27970 | UnknownError 20:25:41 INFO - TEST-INFO | 27970: exit 0 20:25:41 INFO - Browser initialized. 20:25:41 INFO - Running cycle 1/1 for kraken test... 20:25:41 INFO - TEST-INFO | started process 28052 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTK0I23/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:25:54 INFO - PROCESS | 28052 | RSS: Main: 173309952 20:25:54 INFO - PROCESS | 28052 | 20:25:56 INFO - PROCESS | 28052 | Cycle 1(1): loaded http://localhost:43740/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43740/tests/kraken/driver.html?testName=audio-beat-detection) 20:25:57 INFO - PROCESS | 28052 | RSS: Main: 230170624 20:25:57 INFO - PROCESS | 28052 | 20:26:00 INFO - PROCESS | 28052 | Cycle 1(1): loaded http://localhost:43740/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43740/tests/kraken/driver.html?testName=audio-dft) 20:26:01 INFO - PROCESS | 28052 | RSS: Main: 216735744 20:26:01 INFO - PROCESS | 28052 | 20:26:04 INFO - PROCESS | 28052 | Cycle 1(1): loaded http://localhost:43740/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43740/tests/kraken/driver.html?testName=audio-fft) 20:26:05 INFO - PROCESS | 28052 | RSS: Main: 299134976 20:26:05 INFO - PROCESS | 28052 | 20:26:07 INFO - PROCESS | 28052 | Cycle 1(1): loaded http://localhost:43740/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43740/tests/kraken/driver.html?testName=audio-oscillator) 20:26:07 INFO - PROCESS | 28052 | RSS: Main: 209620992 20:26:07 INFO - PROCESS | 28052 | 20:26:10 INFO - PROCESS | 28052 | Cycle 1(1): loaded http://localhost:43740/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43740/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:26:10 INFO - PROCESS | 28052 | RSS: Main: 212484096 20:26:10 INFO - PROCESS | 28052 | 20:26:13 INFO - PROCESS | 28052 | Cycle 1(1): loaded http://localhost:43740/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43740/tests/kraken/driver.html?testName=imaging-darkroom) 20:26:14 INFO - PROCESS | 28052 | RSS: Main: 248479744 20:26:14 INFO - PROCESS | 28052 | 20:26:17 INFO - PROCESS | 28052 | Cycle 1(1): loaded http://localhost:43740/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43740/tests/kraken/driver.html?testName=imaging-desaturate) 20:26:18 INFO - PROCESS | 28052 | RSS: Main: 247779328 20:26:18 INFO - PROCESS | 28052 | 20:26:21 INFO - PROCESS | 28052 | Cycle 1(1): loaded http://localhost:43740/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43740/tests/kraken/driver.html?testName=json-parse-financial) 20:26:21 INFO - PROCESS | 28052 | RSS: Main: 247259136 20:26:21 INFO - PROCESS | 28052 | 20:26:23 INFO - PROCESS | 28052 | Cycle 1(1): loaded http://localhost:43740/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43740/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:26:24 INFO - PROCESS | 28052 | RSS: Main: 209764352 20:26:24 INFO - PROCESS | 28052 | 20:26:25 INFO - PROCESS | 28052 | Cycle 1(1): loaded http://localhost:43740/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43740/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:26:26 INFO - PROCESS | 28052 | RSS: Main: 217694208 20:26:26 INFO - PROCESS | 28052 | 20:26:28 INFO - PROCESS | 28052 | Cycle 1(1): loaded http://localhost:43740/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43740/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:26:29 INFO - PROCESS | 28052 | RSS: Main: 226119680 20:26:29 INFO - PROCESS | 28052 | 20:26:32 INFO - PROCESS | 28052 | Cycle 1(1): loaded http://localhost:43740/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43740/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:26:33 INFO - PROCESS | 28052 | RSS: Main: 235266048 20:26:33 INFO - PROCESS | 28052 | 20:26:35 INFO - PROCESS | 28052 | Cycle 1(1): loaded http://localhost:43740/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43740/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:26:36 INFO - PROCESS | 28052 | RSS: Main: 231313408 20:26:36 INFO - PROCESS | 28052 | 20:26:38 INFO - PROCESS | 28052 | Cycle 1(1): loaded http://localhost:43740/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43740/tests/kraken/driver.html?testName=ai-astar) 20:26:38 INFO - PROCESS | 28052 | RSS: Main: 281239552 20:26:38 INFO - PROCESS | 28052 | 20:26:38 INFO - PROCESS | 28052 | __start_tp_report 20:26:38 INFO - PROCESS | 28052 | _x_x_mozilla_page_load 20:26:38 INFO - PROCESS | 28052 | _x_x_mozilla_page_load_details 20:26:38 INFO - PROCESS | 28052 | |i|pagename|runs| 20:26:38 INFO - PROCESS | 28052 | |0;ai-astar;108;116;117;115;115;118;114;115;115;114 20:26:38 INFO - PROCESS | 28052 | |1;audio-beat-detection;154;129;137;169;128;130;130;128;168;126 20:26:38 INFO - PROCESS | 28052 | |2;audio-dft;162;161;162;162;162;162;163;162;163;161 20:26:38 INFO - PROCESS | 28052 | |3;audio-fft;75;77;77;114;76;77;76;76;99;77 20:26:38 INFO - PROCESS | 28052 | |4;audio-oscillator;83;84;115;84;83;84;112;84;83;116 20:26:38 INFO - PROCESS | 28052 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;117;116 20:26:38 INFO - PROCESS | 28052 | |6;imaging-darkroom;146;147;146;145;146;147;146;146;146;147 20:26:38 INFO - PROCESS | 28052 | |7;imaging-desaturate;84;86;85;85;85;85;85;85;85;85 20:26:38 INFO - PROCESS | 28052 | |8;json-parse-financial;65;62;64;63;65;67;65;65;65;65 20:26:38 INFO - PROCESS | 28052 | |9;json-stringify-tinderbox;68;68;67;67;67;67;67;66;67;68 20:26:38 INFO - PROCESS | 28052 | |10;stanford-crypto-aes;84;84;83;83;94;83;92;84;91;82 20:26:38 INFO - PROCESS | 28052 | |11;stanford-crypto-ccm;143;150;141;139;139;140;140;139;180;143 20:26:38 INFO - PROCESS | 28052 | |12;stanford-crypto-pbkdf2;179;178;177;179;173;172;174;181;180;174 20:26:38 INFO - PROCESS | 28052 | |13;stanford-crypto-sha256-iterative;71;70;70;69;71;71;69;69;68;68 20:26:38 INFO - PROCESS | 28052 | __end_tp_report 20:26:38 INFO - PROCESS | 28052 | __start_cc_report 20:26:38 INFO - PROCESS | 28052 | _x_x_mozilla_cycle_collect,1958 20:26:38 INFO - PROCESS | 28052 | __end_cc_report 20:26:38 INFO - PROCESS | 28052 | __startTimestamp1476933998642__endTimestamp 20:26:38 INFO - PROCESS | 28052 | 20:26:38 INFO - PROCESS | 28052 | ------- Summary: start ------- 20:26:38 INFO - PROCESS | 28052 | Number of tests: 14 20:26:38 INFO - PROCESS | 28052 | 20:26:38 INFO - PROCESS | 28052 | [#0] ai-astar Cycles:10 Average:114.70 Median:115.00 stddev:2.67 (2.3%) stddev-sans-first:1.33 20:26:38 INFO - PROCESS | 28052 | Values: 108.0 116.0 117.0 115.0 115.0 118.0 114.0 115.0 115.0 114.0 20:26:38 INFO - PROCESS | 28052 | 20:26:38 INFO - PROCESS | 28052 | [#1] audio-beat-detection Cycles:10 Average:139.90 Median:133.50 stddev:17.11 (12.8%) stddev-sans-first:17.37 20:26:38 INFO - PROCESS | 28052 | Values: 154.0 129.0 137.0 169.0 128.0 130.0 130.0 128.0 168.0 126.0 20:26:38 INFO - PROCESS | 28052 | 20:26:38 INFO - PROCESS | 28052 | [#2] audio-dft Cycles:10 Average:162.00 Median:162.00 stddev:0.67 (0.4%) stddev-sans-first:0.71 20:26:38 INFO - PROCESS | 28052 | Values: 162.0 161.0 162.0 162.0 162.0 162.0 163.0 162.0 163.0 161.0 20:26:38 INFO - PROCESS | 28052 | 20:26:38 INFO - PROCESS | 28052 | [#3] audio-fft Cycles:10 Average:82.40 Median:77.00 stddev:13.20 (17.1%) stddev-sans-first:13.73 20:26:38 INFO - PROCESS | 28052 | Values: 75.0 77.0 77.0 114.0 76.0 77.0 76.0 76.0 99.0 77.0 20:26:38 INFO - PROCESS | 28052 | 20:26:38 INFO - PROCESS | 28052 | [#4] audio-oscillator Cycles:10 Average:92.80 Median:83.50 stddev:14.90 (17.8%) stddev-sans-first:15.37 20:26:38 INFO - PROCESS | 28052 | Values: 83.0 84.0 115.0 84.0 83.0 84.0 112.0 84.0 83.0 116.0 20:26:38 INFO - PROCESS | 28052 | 20:26:38 INFO - PROCESS | 28052 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 20:26:38 INFO - PROCESS | 28052 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 116.0 20:26:38 INFO - PROCESS | 28052 | 20:26:38 INFO - PROCESS | 28052 | [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 20:26:38 INFO - PROCESS | 28052 | Values: 146.0 147.0 146.0 145.0 146.0 147.0 146.0 146.0 146.0 147.0 20:26:38 INFO - PROCESS | 28052 | 20:26:38 INFO - PROCESS | 28052 | [#7] imaging-desaturate Cycles:10 Average:85.00 Median:85.00 stddev:0.47 (0.6%) stddev-sans-first:0.33 20:26:38 INFO - PROCESS | 28052 | Values: 84.0 86.0 85.0 85.0 85.0 85.0 85.0 85.0 85.0 85.0 20:26:38 INFO - PROCESS | 28052 | 20:26:38 INFO - PROCESS | 28052 | [#8] json-parse-financial Cycles:10 Average:64.60 Median:65.00 stddev:1.35 (2.1%) stddev-sans-first:1.42 20:26:38 INFO - PROCESS | 28052 | Values: 65.0 62.0 64.0 63.0 65.0 67.0 65.0 65.0 65.0 65.0 20:26:38 INFO - PROCESS | 28052 | 20:26:38 INFO - PROCESS | 28052 | [#9] json-stringify-tinderbox Cycles:10 Average:67.20 Median:67.00 stddev:0.63 (0.9%) stddev-sans-first:0.60 20:26:38 INFO - PROCESS | 28052 | Values: 68.0 68.0 67.0 67.0 67.0 67.0 67.0 66.0 67.0 68.0 20:26:38 INFO - PROCESS | 28052 | 20:26:38 INFO - PROCESS | 28052 | [#10] stanford-crypto-aes Cycles:10 Average:86.00 Median:84.00 stddev:4.47 (5.3%) stddev-sans-first:4.68 20:26:38 INFO - PROCESS | 28052 | Values: 84.0 84.0 83.0 83.0 94.0 83.0 92.0 84.0 91.0 82.0 20:26:38 INFO - PROCESS | 28052 | 20:26:38 INFO - PROCESS | 28052 | [#11] stanford-crypto-ccm Cycles:10 Average:145.40 Median:142.00 stddev:12.61 (8.9%) stddev-sans-first:13.34 20:26:38 INFO - PROCESS | 28052 | Values: 143.0 150.0 141.0 139.0 139.0 140.0 140.0 139.0 180.0 143.0 20:26:38 INFO - PROCESS | 28052 | 20:26:38 INFO - PROCESS | 28052 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.70 Median:178.50 stddev:3.20 (1.8%) stddev-sans-first:3.28 20:26:38 INFO - PROCESS | 28052 | Values: 179.0 178.0 177.0 179.0 173.0 172.0 174.0 181.0 180.0 174.0 20:26:38 INFO - PROCESS | 28052 | 20:26:38 INFO - PROCESS | 28052 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.60 Median:70.00 stddev:1.17 (1.7%) stddev-sans-first:1.13 20:26:38 INFO - PROCESS | 28052 | Values: 71.0 70.0 70.0 69.0 71.0 71.0 69.0 69.0 68.0 68.0 20:26:38 INFO - PROCESS | 28052 | -------- Summary: end -------- 20:26:38 INFO - PROCESS | 28052 | 20:26:39 INFO - TEST-INFO | 28052: exit 0 20:26:39 INFO - TEST-OK | kraken | took 64033ms 20:26:39 INFO - SUITE-END | took 1185s 20:26:40 INFO - Completed test suite (00:19:45) 20:26:40 INFO - javascript benchmark 20:26:40 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2581.7547333003363, 2585.5216784894806, 2616.476704659068, 2627.6978147513028, 2638.617400476931, 4500.774961251941, 4566.292224705176, 4589.793459294331, 4596.126735920173, 4600.516945720701, 4605.516420775821, 4617.8152873885, 4665.3235280884255, 4689.554492323233, 4715.056988602276, 4232.259354612946, 4244.766537840433, 4290.334998075287, 4293.892652683677, 4306.440162778835, 4315.870523884289, 4322.589354011379, 4351.108022855307, 4359.411479450266, 4405.537418571052, 4312.547182545819, 4341.45731783527, 4361.520232774392, 4368.126374725068, 4397.164538737629, 4168.0, 4201.411802347674, 4210.1579684063, 4233.0, 4267.637250833683, 4240.342746874239, 4257.0, 4299.699021068526, 4316.395704601358, 4316.870493885189, 4596.839110631146, 4602.677812553123, 4618.030213655136, 4659.580637742585, 4699.389079419688, 4761.523847615245, 4814.494478079786, 4821.517848215186, 4888.144574699413, 4904.877378065541, 4907.558319751204, 4916.729579873106, 4975.527324904128, 4977.751112444364, 5032.345795046657, 4634.351190833286, 4645.187092258841, 4648.302754586772, 4648.558386953234, 4690.53094690535, 4893.853184404474, 5054.241863720398, 5068.062408454448, 5072.416672082684, 5141.2288156776785, 4752.7861246244, 4813.302071199656, 4827.806887724522, 4840.443349014838, 4845.685030473008, 4920.606351491872, 4920.803167873317, 4924.409070911442, 4928.975355123273, 4966.453690094087, 4867.634927380461, 4871.634627402959, 4891.461939186758, 4893.437254715682, 4929.359183306147, 4711.128441238382, 4720.433547974265, 4768.332433459318, 4805.519448055236, 4837.516248375135, 4063.6489483633904, 4067.044244602516, 4069.104796944667, 4114.485689288839, 4122.505299364036, 3604.2611264690677, 3607.2424790793702, 3636.4363523653874, 3651.050726811048, 3653.7990410527677, 4229.386738922901, 4250.957490425118, 4317.84887528935, 4318.201132790444, 4326.697131200849, 4864.416270047617, 4885.7312847793, 4909.558139767367, 4925.088858561177, 4971.875703107451, 4287.464066991626, 4292.82828686849, 4295.742255464682, 4298.4841818981295, 4352.194843953878, 4328.026194106364, 4336.804843782037, 4338.848140315074, 4386.407834942306, 4390.648748100144, 4538.841140559998, 4575.222212223996, 4579.5878370946775, 4623.722576645412, 4627.953720462887, 4815.6147508199965, 4850.369451971221, 4858.611311095033, 4861.829835955725, 4864.73243971585, 4607.6313894889, 4619.907601848012, 4645.419322584677, 4688.742119183341, 4693.0, 4809.78355973975, 4811.975940120277, 4815.903681926272, 4855.077535268288, 4873.0, 4837.733924634179, 4869.293952376956, 4881.926771098508, 4887.60899128076, 4950.77721502526, 4619.838305659286, 4671.229247174178, 4674.906501870011, 4679.789409476513, 4726.6455015874635, 4714.9292760609305, 4724.551167639069, 4725.5510726480925, 4726.243800991825, 4727.196376615915, 4661.021185551072, 4671.042436300618, 4688.812447502061, 4695.741734204652, 4700.130475861976, 4746.145693775154, 4769.403824521934, 4794.400699912511, 4795.736234506996, 4796.424429068534, 4689.695169813951, 4729.621630269639, 4766.404199475066, 4776.23580227162, 4834.8791280218275], "value": 4513.440674263247, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [572.5190839694657, 587.3832475900305, 595.3540408656613, 604.7460066771955, 605.6971514242879, 27891.30271743205, 39010.609893901084, 40495.797521012355, 40606.0, 44855.775721121434, 41423.58576414242, 41916.0, 41933.79033104838, 41978.0, 41988.160236795244, 7642.197569255218, 7795.376369890395, 7796.454248202628, 7797.961010194941, 7801.648925798353, 7659.617019149048, 7755.224477552228, 7755.302022817945, 7758.650860711282, 7761.3402860756905, 7729.61351932404, 7790.649420776051, 7794.259545343183, 7797.181295963927, 7801.843963120734, 7747.767566973, 7786.688532458695, 7789.844203115906, 7791.532508049535, 7795.610219489003, 7658.272464115956, 7731.884021739678, 7741.7677469676, 7743.186965368612, 7751.573663448508, 38253.42619860704, 38529.0, 38574.44234480145, 38630.0, 38631.42052869209, 2903.651561812596, 2905.6513218413716, 2915.7958942874006, 3000.489916714142, 3200.3279311344645, 27920.16239512818, 28102.43795124086, 28461.857690711415, 28478.572821407695, 29236.269093272625, 3260.0, 3349.6482869298616, 3351.463765797485, 3380.983095084509, 3426.0920855973186, 246195.0, 247759.0, 248009.0, 248391.9999999982, 248947.0, 50372.244416333786, 50464.49535504671, 50476.74761626168, 50576.0, 50616.49383506118, 32022.0, 32979.505307420404, 33071.3385732284, 53609.1958620621, 53692.0, 12681.746365072831, 12776.744465110645, 12794.552190673281, 12800.61598152057, 12801.61595152147, 8673.869891951626, 8691.130886911258, 8722.040575536686, 8741.475511469333, 8768.254698350584, 17978.190981405867, 18016.549586260448, 18050.729239061424, 18086.90956545209, 18196.363127290748, 6708.42978346846, 6869.656517174121, 6929.648718499844, 7047.189573199045, 7082.802547770701, 780.7384526183679, 903.4940433357341, 913.5340976102103, 967.9691128947649, 1022.5091955861228, 26018.178727488896, 27085.729142708715, 28187.295317616812, 29464.852675736915, 29967.0, 752.236479972828, 914.6844338703137, 917.5824999625155, 932.6689025396022, 981.5533932060895, 13681.179129252077, 14394.568162955127, 14478.203698796668, 14582.708345833023, 14663.413463461342, 385204.0, 386283.0, 386314.0, 386602.0, 386956.0, 48678.51321486811, 49056.509434905194, 49079.75460122676, 49148.0, 49163.0, 1025.933314334566, 1093.8468614393992, 1133.9149563782585, 1167.6905620010705, 1193.2482536002262, 25586.360340991625, 28915.7108428913, 29757.472424231295, 29796.85101574478, 29915.252118697208, 41293.58706412897, 46369.76815115903, 48244.0, 48273.75863120662, 53399.46600533945, 336685.0, 339927.0, 340314.0, 341121.0, 341611.0, 24269.878650606635, 24854.254372368858, 25025.624615630415, 26316.605250921635, 37668.81165594154, 40487.392689109096, 40779.59220407758, 40792.796036020816, 40933.38599921063, 41765.58234417617, 35099.64900351066, 35473.82263088668, 35923.46114808228, 35962.4605630921, 36181.81909090438, 35722.464163038094, 35956.46065309075, 35977.280454391286, 36479.27041459209, 36697.81651091728, 35055.0, 35236.647633524364, 35678.10804729902, 36022.63977360193, 36426.63573364339, 30884.536731949487, 32991.87601549806, 33042.33915321632, 33290.334193316485, 33322.333553329285, 24768.0, 24923.0, 25124.874375628006, 25372.0, 25619.359516011504], "value": 17199.91402042985, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [338.6089067127469, 361.1675088920038, 364.30054295752154, 365.63253929800544, 378.91063193319206, 12972.610821675353, 13017.958563314936, 13038.21770693759, 13385.933070334635, 17477.47567572972, 13798.172109673427, 14271.857281427183, 15333.0, 15778.605534861634, 15867.603309917258, 4887.413510378742, 4894.730789806559, 5018.422881368635, 5058.418281897573, 5118.59051275897, 5024.698518088908, 5113.233015047754, 5115.590752739772, 5116.283720279164, 5116.820911268106, 3712.777233365993, 3909.3940439231965, 5620.747066382002, 5919.023361145428, 5955.553333499983, 5835.270591176103, 5929.229200203989, 6031.095335699636, 6034.758609655609, 6036.577439579231, 5269.657472264291, 5278.894422111574, 5285.68285902847, 5289.233061206103, 5290.9735451322495, 20465.18139274442, 20745.377638670863, 20816.375508734764, 20957.0, 21125.366239012856, 1714.8027976782705, 1798.3885478937093, 1852.3979706595276, 1956.3544030469911, 2079.6464601017865, 12818.935905320506, 12954.740905181938, 12960.092793504458, 13099.607011789662, 13577.0, 1661.941832035873, 1682.5877659973385, 1708.453294945618, 1749.8337657922477, 1756.4906177208595, 67542.9868551977, 67928.32071679269, 68144.6592767038, 69322.65338673325, 69473.65263173703, 8998.730038098736, 9091.954540227256, 9308.813823723487, 9514.096160864707, 9649.276304277208, 13029.47882084706, 13061.281629510278, 13066.673333166556, 13078.476860925646, 13080.803787943189, 6224.654417425509, 6555.2133743951035, 6599.8020059398295, 6641.900371494335, 6761.121054262914, 6181.320054793969, 6182.783602573888, 6307.022411526221, 6326.652034138075, 6338.58799178052, 5926.703664816742, 6011.789587364421, 6027.011086341497, 6029.336772954972, 6072.392760723892, 1709.3504468301965, 1709.3931654262806, 1711.4437807712543, 1736.8957862528289, 1752.7195648696147, 828.5691440450931, 829.0, 854.5940678177816, 917.0737555069295, 967.5452537307455, 16704.24605416438, 16911.0, 17237.655246894992, 17521.474355769347, 17836.46490605284, 839.693511868176, 853.9231469167805, 870.616928551448, 874.9693760718344, 897.8159477307137, 7698.538087714755, 9404.764880878032, 9957.157925783753, 9972.551235194434, 10117.494125293706, 349507.0, 351085.0, 352371.0, 352530.0, 352985.0, 45772.3134152988, 48175.759121204166, 67885.0, 82784.58607707043, 85330.57334713287, 886.5301390263171, 903.8915330160423, 932.9953350233205, 935.1910597333393, 938.2400255792829, 15362.846371536141, 15433.382664693736, 15839.0, 16231.0, 16439.589010274838, 34327.485087724206, 34977.0, 36187.27625447529, 38421.6157838418, 39649.2070158601, 47674.76162619165, 50527.74736126443, 51335.22997154971, 51573.7421312906, 52493.7375313121, 6584.868302633825, 6667.2666006738245, 6726.6636668167375, 6823.624700641512, 6865.176178858569, 8761.780955476164, 10870.782584348111, 11723.472443739882, 11847.0, 12142.817857731965, 9612.903870961201, 9818.45998470091, 10171.186305095427, 10556.577736890438, 10795.676129716121, 10178.13485853681, 10340.224483163642, 10625.574977000833, 10702.304350217211, 10898.618548350769, 9677.49998750195, 10048.748781280527, 10117.645882394081, 10336.431496267476, 10337.608609843997, 6988.301169882971, 7023.648817558999, 7031.929680703128, 7180.964095179491, 7237.782866514013, 8599.742007739778, 9929.0, 10056.396616203052, 10148.188144948239, 10167.949160254448], "value": 8058.090203148432, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1242.9751404971896, 1370.9657258568534, 1407.486267512358, 1498.8950773445863, 1702.0893821805337, 6869.587824730514, 7588.0, 7796.571188584626, 7828.256315650018, 8005.759827205178, 7880.093789214242, 7970.481918675297, 7973.481723687971, 7975.641096150673, 7978.92021079789, 2160.6975023496684, 2185.2024011235944, 2191.079746506463, 2193.901274442654, 2193.9451513712124, 1993.9401817945413, 2046.2735728816278, 2047.0072015072678, 2047.9897600511977, 2050.2004218354778, 2103.5372218112066, 2120.872747635147, 2127.5000374911883, 2132.9786702133015, 2171.337741988693, 1987.9801201987939, 1990.263602467082, 1992.4122383896786, 1999.3701983875033, 1999.8200161985346, 2121.7559980602273, 2125.6598944169014, 2153.7738537453656, 2159.362987918568, 2163.8485306028583, 7660.080790305199, 7776.261255180749, 7779.7666070017995, 7867.331276841475, 7868.095169055575, 4322.654187664979, 4469.039156581318, 4489.483709373431, 4495.617872480843, 4497.370368148429, 2791.9022834200705, 2880.2367372646268, 2944.7202515761182, 2955.9113226603235, 2957.423302456022, 935.6444551070549, 944.1361154543584, 961.3462845265217, 968.4431451915107, 975.1175186456197, 10559.788804223872, 10770.838437423445, 10809.405482698448, 10809.891901081046, 10820.02619764225, 4123.2165888481095, 4137.193247316744, 4233.936490952638, 4240.512341080754, 4311.353297005474, 9279.257659387233, 9284.814303714023, 9297.442153470813, 9305.860412093823, 9314.627414903329, 4431.313146462304, 4455.242608756519, 4479.776011199427, 4489.618382437464, 4493.865184044484, 3514.279572687593, 3527.9294414111573, 3620.149264922741, 4167.187398457272, 4173.770442625624, 3197.5683282756995, 3644.0889777555612, 3645.453182022665, 3667.1198912260866, 3678.9080272993388, 1129.5425352732157, 1157.1090260499536, 1170.1984140863535, 1171.1509155861932, 1191.2614179208772, 683.5864302097259, 820.1634332980327, 827.5034979012544, 833.9499630022218, 836.4019725896013, 4989.600831933437, 5024.32171656829, 5048.823291184791, 5132.021195307425, 5203.843884683465, 370.19667321911516, 381.28699332248874, 382.61929380266815, 394.65664871561927, 397.83489851711215, 3571.7321200910037, 3603.621619729943, 3665.523481947383, 3684.8526058957877, 3733.216024634857, 9302.25581953442, 9686.031396860399, 9692.46691431978, 9701.0, 9706.854397184048, 9349.252059835197, 9587.712368628952, 9612.423254604606, 9622.0, 9634.614615415445, 7061.646917654097, 7241.167265764399, 7246.492745507764, 7248.130224373003, 7253.347198752138, 5116.769745361393, 5121.539061484485, 5138.100832354248, 5286.524212820865, 5388.649737767033, 8775.648974040967, 8838.072002439909, 8863.689770857989, 8866.468011919305, 8868.64525418976, 8136.837263254583, 8675.262602678591, 8912.108789121035, 9112.635494580143, 9128.5435728212, 6195.597286176384, 6652.0, 6804.285550017375, 6835.692393842389, 6932.376086152271, 7384.261573842573, 7468.253174682488, 7528.209537998431, 7538.057742782153, 7540.811479713051, 6562.901556476561, 6567.573107747981, 6712.563683360566, 6754.5947243165565, 6835.248122706399, 6649.867002660017, 6762.49281303914, 6867.656617169221, 6874.621895795779, 6884.51808373409, 5951.196588460502, 6124.908126378197, 6188.9690551546955, 6279.591826531261, 6280.780172693934, 4583.770811459347, 4592.563706447882, 4630.490646029001, 4658.883527911829, 4756.215224488059, 4516.728996260234, 4629.768511574341, 4641.3734145889875, 4659.673822832369, 4767.212295389229], "value": 4000.8160169511048, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [287.307588711206, 289.5974595312516, 294.65525335357637, 298.98355590442515, 301.37765514213163, 4747.382840230769, 4775.976120119403, 4777.259524773657, 4798.4001999750035, 4803.447603525591, 4720.858374248769, 4725.3384526166365, 4726.385569875912, 4729.739864307462, 4736.360591320171, 3529.400001999666, 3562.430011198209, 3641.0715267606724, 3642.417213245868, 3708.1656627258785, 3681.5641899659154, 3705.94441083384, 3711.164987877733, 3727.310447567209, 3728.7576307540057, 3658.5975542690417, 3674.228412033476, 3686.373316536182, 3690.132818787583, 3696.2607478504274, 3511.911307494672, 3568.4825700273573, 3622.2755448910325, 3680.656560355451, 3704.1479260369815, 3274.950875736866, 3278.7049165575213, 3279.9172525446274, 3289.73682105431, 3291.8518666660057, 4589.898424378159, 4598.885027874297, 4600.42494688164, 4605.516420775837, 4620.745858977755, 3941.5467221269346, 4147.585241475858, 4222.218889505451, 4228.471441069866, 4237.703360764748, 4905.607551395879, 4915.041566894457, 4920.704757714549, 4920.778564964585, 4931.80272789088, 3498.265364273506, 3502.2820321833965, 3503.5970863350785, 3503.6321186275327, 3504.0, 4999.75001249936, 5134.563562097189, 5154.819581314636, 5159.509846564571, 5160.0, 3547.7161827053774, 3559.661832125944, 3568.6252943441086, 3570.9285814283567, 3588.102974256436, 3609.5848977367414, 3617.3127105849803, 3622.221222437136, 3628.3650361186687, 3634.400323946572, 4148.149629325981, 4148.170365926827, 4148.419221309019, 4152.854650087233, 4158.896027599334, 4749.287606858929, 4892.143874821892, 4902.8774280643265, 4918.311436398907, 4928.334674818925, 1237.7807859258623, 1248.8563815161192, 1252.4551819958347, 1252.542821870029, 1254.8055051467038, 764.289211033744, 788.5805550010074, 794.7734895554739, 803.8553060449175, 813.2071230550166, 4291.270484017725, 4296.935545966813, 4474.306482495218, 4474.366856097501, 4478.48497422794, 5066.594672426197, 5074.3657042869645, 5083.872903177376, 5092.567131793765, 5103.413107492612, 4436.0, 4449.688521803443, 4452.1763473757455, 4453.64163929998, 4457.064016556559, 2548.2610043087666, 2685.8925642974064, 2695.905643302475, 2706.7157948415525, 2708.2010806812036, 4833.226683730586, 4836.443808961944, 4836.968473241247, 4849.830255941025, 4854.368932038883, 4961.826336078292, 5191.6884986900905, 5199.090159222196, 5201.540975251415, 5203.401608814959, 4799.9760001199775, 4818.590419814285, 4822.614190864792, 4839.903201935871, 4842.927356089662, 5037.924431133462, 5069.264956581202, 5079.441261461162, 5093.307352169647, 5117.385913690381, 4712.717236965793, 4962.875928101682, 4970.304157418037, 4983.626228032839, 4984.152694041949, 4855.6601037927, 4861.683990540603, 4873.707577545359, 4887.780049897692, 4897.873489097598, 3581.051021479362, 3587.766795158306, 3603.657652523006, 3608.394264552249, 3614.4578313252173, 4965.244289419407, 5107.642465027412, 5109.642325037212, 5125.2568377585785, 5137.460566640449, 4896.92654610174, 4902.926456103232, 4916.311716359784, 4926.926096108489, 4966.602671786321, 4953.331300274417, 4960.379952505937, 4965.577925876341, 4977.751112444435, 4993.725345105909, 4763.642726795435, 4911.4106307243355, 4911.803527858846, 4913.729744864067, 4926.359573255454, 4724.173269677862, 4829.179039563212, 4866.1727506323305, 4900.730459824601, 5005.299258103942, 4804.759762011816, 4805.0, 4849.878753031061, 4858.246971719389, 4867.318575399518], "value": 3719.3947310526332, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [590.610197269802, 608.9512838972882, 623.305014908377, 650.5056157320435, 671.5299290496652, 12813.359332033397, 12850.678733031678, 13779.724405511884, 13786.24175670339, 13797.448102075918, 13047.934760326185, 13072.21566705996, 13182.934085329583, 13258.93370533146, 13272.734545309087, 761.8019314978104, 785.3834739729314, 787.3819052044147, 787.8660627693278, 788.1291173253559, 627.7677259414023, 645.4320198225555, 650.5608714117975, 651.7490766055079, 801.8516574433719, 671.2180309938915, 810.785141937387, 839.3117643532306, 843.1652663862762, 846.9237768600825, 831.8710599857031, 835.2357592802579, 835.6323217784217, 836.7071524966213, 837.0165056059107, 605.5760967322892, 605.8848818724429, 606.2724730323629, 606.5693357716027, 606.7118118893491, 10386.948065259701, 10841.945790271076, 12606.180598261084, 13164.341782910817, 13190.67023324415, 12633.620991370273, 13639.454421823115, 13729.519466818714, 13748.862511374959, 13800.516981905686, 9699.563519641633, 9820.705378838575, 10000.79998400028, 10129.949350253275, 10248.948755256177, 3283.40898638245, 3326.850291736878, 3358.3283343331186, 3385.5260263563123, 3457.2048428861253, 63462.365376346104, 63648.0, 64230.0, 64794.676026620036, 65488.672556637386, 10267.383956962607, 10399.0, 10480.109190718875, 10540.156787456985, 10798.298110622783, 19444.902775486316, 19564.413067607995, 19565.315213967442, 19569.902150489157, 19572.412827615193, 6448.3229260927865, 6462.192225971754, 6593.0, 6693.899591506131, 6719.0593316935665, 3462.79223246606, 3547.8758243461357, 3588.085038315213, 3642.453631955228, 3748.756330838487, 3000.1749518882484, 3061.877524898979, 3091.2580980564953, 3093.90718278452, 3098.9380212395627, 493.8123513065012, 496.473737837893, 508.63378367575285, 518.3675915383227, 519.5168493301267, 488.8606747077137, 599.2102665350444, 615.9568830181934, 617.4227097663698, 620.8758248350348, 7757.456978011485, 7959.920400795918, 8023.6790528378215, 8180.46826956246, 8361.372897032747, 490.5217413022275, 531.0918329656254, 566.8469513231404, 581.517340607295, 604.0998911621652, 3675.632436756303, 3721.7394782364972, 3761.7931013794505, 3837.0, 3837.6737977271687, 55807.44192558023, 75884.0, 78984.60507697424, 79320.60339698264, 87975.0, 76251.61874190594, 78541.28752274881, 80464.0, 80795.0, 80916.19083809204, 44280.3357949631, 46854.08032156574, 66195.66902165554, 73995.63002184955, 74048.62975685195, 8009.479383840032, 8433.325333973145, 8719.956400217958, 8734.475931444134, 8734.781630459289, 44332.77833610812, 46161.53838461573, 46324.0, 46786.76606616945, 47220.0, 64223.678881605294, 65238.34761652323, 66054.0, 66423.66788166028, 67315.0, 11001.119910407308, 11015.669529914116, 11191.160662950475, 11255.099592032453, 11271.041961433042, 11148.219624626197, 11373.374464404536, 11533.365664888512, 11567.190296679151, 11732.002779763816, 11721.531138754355, 11780.234284771463, 12165.270083795001, 12565.685857853627, 12580.30808305552, 11696.941515292368, 11719.648410547697, 11760.235584686969, 11961.760764784482, 12364.505419783467, 11028.5037173329, 11035.117190624891, 11102.500387482743, 11402.144839137263, 12421.130520863453, 9651.179649729851, 9760.804783904141, 9978.151857091938, 9981.700548983543, 10393.0, 9640.614375424904, 10165.898341016791, 10232.48837558134, 10233.692989210336, 10484.475776211006], "value": 6435.349786340769, "unit": "score"}], "name": "dromaeo_css", "value": 6255.352519751798, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 116.0, 117.0, 115.0, 115.0, 118.0, 114.0, 115.0, 115.0, 114.0], "value": 114.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 129.0, 137.0, 169.0, 128.0, 130.0, 130.0, 128.0, 168.0, 126.0], "value": 139.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 162.0, 162.0, 162.0, 162.0, 163.0, 162.0, 163.0, 161.0], "value": 162.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 77.0, 114.0, 76.0, 77.0, 76.0, 76.0, 99.0, 77.0], "value": 82.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 115.0, 84.0, 83.0, 84.0, 112.0, 84.0, 83.0, 116.0], "value": 92.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 146.0, 145.0, 146.0, 147.0, 146.0, 146.0, 146.0, 147.0], "value": 146.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 86.0, 85.0, 85.0, 85.0, 85.0, 85.0, 85.0, 85.0, 85.0], "value": 85.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 62.0, 64.0, 63.0, 65.0, 67.0, 65.0, 65.0, 65.0, 65.0], "value": 64.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 67.0, 67.0, 67.0, 67.0, 67.0, 66.0, 67.0, 68.0], "value": 67.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 83.0, 83.0, 94.0, 83.0, 92.0, 84.0, 91.0, 82.0], "value": 86.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 150.0, 141.0, 139.0, 139.0, 140.0, 140.0, 139.0, 180.0, 143.0], "value": 145.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [179.0, 178.0, 177.0, 179.0, 173.0, 172.0, 174.0, 181.0, 180.0, 174.0], "value": 176.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 70.0, 70.0, 69.0, 71.0, 71.0, 69.0, 69.0, 68.0, 68.0], "value": 69.6, "unit": "score"}], "name": "kraken", "value": 1549.3999999999999, "alertThreshold": 2.0}]} 20:26:40 INFO - Return code: 0 20:26:40 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 20:26:40 INFO - # TBPL SUCCESS # 20:26:40 INFO - Running post-action listener: _resource_record_post_action 20:26:40 INFO - [mozharness: 2016-10-20 03:26:40.448819Z] Finished run-tests step (success) 20:26:40 INFO - Running post-run listener: _resource_record_post_run 20:26:40 INFO - Total resource usage - Wall time: 1202s; CPU: 13.0%; Read bytes: 4096; Write bytes: 400101376; Read time: 12; Write time: 243740 20:26:40 INFO - TinderboxPrint: CPU usage
13.0% 20:26:40 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 20:26:40 INFO - TinderboxPrint: I/O write bytes / time
400,101,376 / 243,740 20:26:40 INFO - TinderboxPrint: CPU idle
8,341.9 (87.0%) 20:26:40 INFO - TinderboxPrint: CPU user
1,199.8 (12.5%) 20:26:40 INFO - TinderboxPrint: Swap in / out
0 / 0 20:26:40 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 107872256; Read time: 0; Write time: 61144 20:26:40 INFO - run-tests - Wall time: 1186s; CPU: 13.0%; Read bytes: 0; Write bytes: 292229120; Read time: 0; Write time: 182596 20:26:41 INFO - Running post-run listener: _upload_blobber_files 20:26:41 INFO - Blob upload gear active. 20:26:41 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:26:41 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 20:26:41 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', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 20:26:41 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 Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 20:26:41 INFO - (blobuploader) - INFO - Open directory for files ... 20:26:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 20:26:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:26:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:26:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 20:26:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:26:42 INFO - (blobuploader) - INFO - Done attempting. 20:26:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 20:26:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:26:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:26:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 20:26:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:26:42 INFO - (blobuploader) - INFO - Done attempting. 20:26:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:26:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:26:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:26:47 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:26:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:26:47 INFO - (blobuploader) - INFO - Done attempting. 20:26:47 INFO - (blobuploader) - INFO - Iteration through files over. 20:26:47 INFO - Return code: 0 20:26:47 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:26:47 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:26:47 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/74c30ca7ee9b5d5a53558d0953aee93afc9ed7e6afebdd914c3955d551b130d4a51f09d34366fc17e7df44c6cdbe6d3f24786d4d8a9942641bb09ba33c004194", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f7786a4cdf2eb6ba57ba07b51779bd5f197f9d92c7148509fdb7c4d8bff866e25d97971f0bb079593de80097944cc8e17cda00fbd2dae7baa72b951ad2b107f3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/45b55e18b3ba281f6b7c342b21c87ab7f9df719c2c6eafff7ef699bc4d6a2c5c7ad8a35ad776657014523b3f9c481b2b62fa4561c2e127c8f326abadd591f67a"} 20:26:47 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:26:47 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:26:47 INFO - Contents: 20:26:47 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/74c30ca7ee9b5d5a53558d0953aee93afc9ed7e6afebdd914c3955d551b130d4a51f09d34366fc17e7df44c6cdbe6d3f24786d4d8a9942641bb09ba33c004194", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f7786a4cdf2eb6ba57ba07b51779bd5f197f9d92c7148509fdb7c4d8bff866e25d97971f0bb079593de80097944cc8e17cda00fbd2dae7baa72b951ad2b107f3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/45b55e18b3ba281f6b7c342b21c87ab7f9df719c2c6eafff7ef699bc4d6a2c5c7ad8a35ad776657014523b3f9c481b2b62fa4561c2e127c8f326abadd591f67a"} 20:26:47 INFO - Running post-run listener: copy_logs_to_upload_dir 20:26:47 INFO - Copying logs to upload dir... 20:26:47 INFO - mkdir: /builds/slave/test/build/upload/logs 20:26:47 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1246.149477 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-10-19 20:26:46.895205) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-19 20:26:46.898678) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=74d6aec007b0fa31a864ebd7000001f8-1476932732.428348-2083557137 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/74c30ca7ee9b5d5a53558d0953aee93afc9ed7e6afebdd914c3955d551b130d4a51f09d34366fc17e7df44c6cdbe6d3f24786d4d8a9942641bb09ba33c004194", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f7786a4cdf2eb6ba57ba07b51779bd5f197f9d92c7148509fdb7c4d8bff866e25d97971f0bb079593de80097944cc8e17cda00fbd2dae7baa72b951ad2b107f3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/45b55e18b3ba281f6b7c342b21c87ab7f9df719c2c6eafff7ef699bc4d6a2c5c7ad8a35ad776657014523b3f9c481b2b62fa4561c2e127c8f326abadd591f67a"} build_url:https://queue.taskcluster.net/v1/task/INrxWV0BQ_-bDkvfwNDVgw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011405 build_url: 'https://queue.taskcluster.net/v1/task/INrxWV0BQ_-bDkvfwNDVgw/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/Fx-Team-Non-PGO/sha512/74c30ca7ee9b5d5a53558d0953aee93afc9ed7e6afebdd914c3955d551b130d4a51f09d34366fc17e7df44c6cdbe6d3f24786d4d8a9942641bb09ba33c004194", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f7786a4cdf2eb6ba57ba07b51779bd5f197f9d92c7148509fdb7c4d8bff866e25d97971f0bb079593de80097944cc8e17cda00fbd2dae7baa72b951ad2b107f3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/45b55e18b3ba281f6b7c342b21c87ab7f9df719c2c6eafff7ef699bc4d6a2c5c7ad8a35ad776657014523b3f9c481b2b62fa4561c2e127c8f326abadd591f67a"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-19 20:26:46.929360) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-19 20:26:46.929705) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=74d6aec007b0fa31a864ebd7000001f8-1476932732.428348-2083557137 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004508 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-19 20:26:47.012823) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-19 20:26:47.013670) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-19 20:26:47.014440) ========= ========= Total master_lag: 0.17 =========