builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-028 starttime: 1477462934.93 results: success (0) buildid: 20161025220526 builduid: de2c6007ba4a4f1b838428b27b94ca09 revision: f9f3cc95d7282f1fd83f66dd74acbcdbfe821915 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-25 23:22:14.928066) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-25 23:22:14.928772) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-25 23:22:14.929065) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-25 23:22:14.954243) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-25 23:22:14.954524) ========= 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=836cfdc75598d54cb747368e000001a9-1477460099.992012-1484926707 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-25 23:22:15-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 88.9M=0s 2016-10-25 23:22:15 (88.9 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.099877 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-25 23:22:15.067954) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-25 23:22:15.068236) ========= 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=836cfdc75598d54cb747368e000001a9-1477460099.992012-1484926707 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021660 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-25 23:22:15.117965) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-25 23:22:15.118336) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev f9f3cc95d7282f1fd83f66dd74acbcdbfe821915 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev f9f3cc95d7282f1fd83f66dd74acbcdbfe821915 --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=836cfdc75598d54cb747368e000001a9-1477460099.992012-1484926707 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-25 23:22:15,262 truncating revision to first 12 chars 2016-10-25 23:22:15,262 Setting DEBUG logging. 2016-10-25 23:22:15,262 attempt 1/10 2016-10-25 23:22:15,262 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/f9f3cc95d728?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-25 23:22:15,568 unpacking tar archive at: mozilla-central-f9f3cc95d728/testing/mozharness/ program finished with exit code 0 elapsedTime=0.619430 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-25 23:22:15.751046) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-25 23:22:15.751340) ========= script_repo_revision: f9f3cc95d7282f1fd83f66dd74acbcdbfe821915 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-25 23:22:15.751769) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-25 23:22:15.752067) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-25 23:22:15.764093) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-10-25 23:22:15.764394) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=836cfdc75598d54cb747368e000001a9-1477460099.992012-1484926707 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 23:22:15 INFO - MultiFileLogger online at 20161025 23:22:15 in /builds/slave/test 23:22:15 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 23:22:15 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 23:22:16 INFO - {'append_to_log': False, 23:22:16 INFO - 'base_work_dir': '/builds/slave/test', 23:22:16 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 23:22:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 23:22:16 INFO - 'branch': 'Firefox-Non-PGO', 23:22:16 INFO - 'buildbot_json_path': 'buildprops.json', 23:22:16 INFO - 'config_files': ('talos/linux_config.py',), 23:22:16 INFO - 'default_actions': ('clobber', 23:22:16 INFO - 'read-buildbot-config', 23:22:16 INFO - 'download-and-extract', 23:22:16 INFO - 'populate-webroot', 23:22:16 INFO - 'create-virtualenv', 23:22:16 INFO - 'install', 23:22:16 INFO - 'run-tests'), 23:22:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 23:22:16 INFO - 'download_minidump_stackwalk': True, 23:22:16 INFO - 'download_symbols': 'ondemand', 23:22:16 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 23:22:16 INFO - 'tooltool.py': '/tools/tooltool.py', 23:22:16 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 23:22:16 INFO - '/tools/misc-python/virtualenv.py')}, 23:22:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 23:22:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 23:22:16 INFO - 'installer_path': 'installer.exe', 23:22:16 INFO - 'log_level': 'info', 23:22:16 INFO - 'log_name': 'talos', 23:22:16 INFO - 'log_to_console': True, 23:22:16 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 23:22:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 23:22:16 INFO - 'opt_config_files': (), 23:22:16 INFO - 'pip_index': False, 23:22:16 INFO - 'sps_profile': False, 23:22:16 INFO - 'sps_profile_interval': 0, 23:22:16 INFO - 'suite': 'dromaeojs-e10s', 23:22:16 INFO - 'system_bits': '32', 23:22:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:22:16 INFO - 'title': 'talos-linux64-ix-028', 23:22:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 23:22:16 INFO - 'use_talos_json': True, 23:22:16 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 23:22:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:22:16 INFO - 'work_dir': 'build'} 23:22:16 INFO - [mozharness: 2016-10-26 06:22:16.006741Z] Running clobber step. 23:22:16 INFO - Running pre-action listener: _resource_record_pre_action 23:22:16 INFO - Running main action method: clobber 23:22:16 INFO - rmtree: /builds/slave/test/build 23:22:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 23:22:16 INFO - Running post-action listener: _resource_record_post_action 23:22:16 INFO - [mozharness: 2016-10-26 06:22:16.457493Z] Finished clobber step (success) 23:22:16 INFO - [mozharness: 2016-10-26 06:22:16.457594Z] Running read-buildbot-config step. 23:22:16 INFO - Running pre-action listener: _resource_record_pre_action 23:22:16 INFO - Running main action method: read_buildbot_config 23:22:16 INFO - Using buildbot properties: 23:22:16 INFO - { 23:22:16 INFO - "project": "", 23:22:16 INFO - "product": "firefox", 23:22:16 INFO - "script_repo_revision": "production", 23:22:16 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 23:22:16 INFO - "repository": "", 23:22:16 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 23:22:16 INFO - "buildid": "20161025220526", 23:22:16 INFO - "pgo_build": "False", 23:22:16 INFO - "basedir": "/builds/slave/test", 23:22:16 INFO - "buildnumber": 257, 23:22:16 INFO - "slavename": "talos-linux64-ix-028", 23:22:16 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 23:22:16 INFO - "platform": "ubuntu64_hw", 23:22:16 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 23:22:16 INFO - "branch": "mozilla-central", 23:22:16 INFO - "repo_path": "mozilla-central", 23:22:16 INFO - "revision": "f9f3cc95d7282f1fd83f66dd74acbcdbfe821915", 23:22:16 INFO - "stage_platform": "linux64", 23:22:16 INFO - "builduid": "de2c6007ba4a4f1b838428b27b94ca09", 23:22:16 INFO - "slavebuilddir": "test" 23:22:16 INFO - } 23:22:16 INFO - Found installer url https://queue.taskcluster.net/v1/task/CbSo9_5vT7SKBqDvdnI4oA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 23:22:16 INFO - Running post-action listener: _resource_record_post_action 23:22:16 INFO - [mozharness: 2016-10-26 06:22:16.460024Z] Finished read-buildbot-config step (success) 23:22:16 INFO - [mozharness: 2016-10-26 06:22:16.460115Z] Running download-and-extract step. 23:22:16 INFO - Running pre-action listener: _resource_record_pre_action 23:22:16 INFO - Running main action method: download_and_extract 23:22:16 INFO - mkdir: /builds/slave/test/build/tests 23:22:16 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')]} 23:22:16 INFO - trying https://queue.taskcluster.net/v1/task/CbSo9_5vT7SKBqDvdnI4oA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 23:22:16 INFO - Downloading https://queue.taskcluster.net/v1/task/CbSo9_5vT7SKBqDvdnI4oA/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 23:22:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CbSo9_5vT7SKBqDvdnI4oA/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 23:22:17 INFO - Downloaded 1361 bytes. 23:22:17 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 23:22:17 INFO - Using the following test package requirements: 23:22:17 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 23:22:17 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 23:22:17 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 23:22:17 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 23:22:17 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 23:22:17 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 23:22:17 INFO - u'jsshell-linux-x86_64.zip'], 23:22:17 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 23:22:17 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 23:22:17 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 23:22:17 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 23:22:17 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 23:22:17 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 23:22:17 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 23:22:17 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 23:22:17 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 23:22:17 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 23:22:17 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 23:22:17 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 23:22:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CbSo9_5vT7SKBqDvdnI4oA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 23:22:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CbSo9_5vT7SKBqDvdnI4oA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 23:22:17 INFO - Fetch https://queue.taskcluster.net/v1/task/CbSo9_5vT7SKBqDvdnI4oA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 23:22:17 INFO - Http code: 200 23:22:17 INFO - via: 1.1 032d42677fbf05c24a4bb71369581429.cloudfront.net (CloudFront) 23:22:17 INFO - x-amz-cf-id: -gUjL6QRufedcF4-aARV6WNi09ZWGCfNloZDralCxWH6YdqJZ4rQJQ== 23:22:17 INFO - x-amz-version-id: Nep2bSQweufxgVaUwm0JZkhXQ_ejxljv 23:22:17 INFO - Expected file size: 20482734 23:22:17 INFO - Obtained file size: 20482734 23:22:21 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 23:22:21 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CbSo9_5vT7SKBqDvdnI4oA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 23:22:21 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CbSo9_5vT7SKBqDvdnI4oA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 23:22:21 INFO - Fetch https://queue.taskcluster.net/v1/task/CbSo9_5vT7SKBqDvdnI4oA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 23:22:22 INFO - Http code: 200 23:22:22 INFO - via: 1.1 d897b81191cbfd68a1b6fc44f98c52b0.cloudfront.net (CloudFront) 23:22:22 INFO - x-amz-cf-id: bHy8-LY31zCnqW50JgaJK-ozyEaUjDM7-NOZJj5tffaLgrshX1W_MQ== 23:22:22 INFO - x-amz-version-id: Nep2bSQweufxgVaUwm0JZkhXQ_ejxljv 23:22:22 INFO - Expected file size: 20482734 23:22:22 INFO - Obtained file size: 20482734 23:22:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CbSo9_5vT7SKBqDvdnI4oA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 23:22:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CbSo9_5vT7SKBqDvdnI4oA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 23:22:27 INFO - Fetch https://queue.taskcluster.net/v1/task/CbSo9_5vT7SKBqDvdnI4oA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 23:22:27 INFO - Http code: 200 23:22:27 INFO - via: 1.1 11dd60d1f68e8258294f92935b53a91f.cloudfront.net (CloudFront) 23:22:27 INFO - x-amz-cf-id: 63ydmMAHjuG53i0wQOX6xa1viNFKVG0nY3ePL_2pNwPH6nRM0Kg81Q== 23:22:27 INFO - x-amz-version-id: ne0Ayec31wUg4qmqJifzVWsE7HDKKQ9G 23:22:28 INFO - Expected file size: 14409028 23:22:28 INFO - Obtained file size: 14409028 23:22:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:22:28 INFO - trying https://queue.taskcluster.net/v1/task/CbSo9_5vT7SKBqDvdnI4oA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 23:22:28 INFO - Downloading https://queue.taskcluster.net/v1/task/CbSo9_5vT7SKBqDvdnI4oA/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 23:22:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CbSo9_5vT7SKBqDvdnI4oA/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 23:22:29 INFO - Downloaded 55735885 bytes. 23:22:29 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/CbSo9_5vT7SKBqDvdnI4oA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 23:22:29 INFO - mkdir: /builds/slave/test/properties 23:22:29 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 23:22:29 INFO - Writing to file /builds/slave/test/properties/build_url 23:22:29 INFO - Contents: 23:22:29 INFO - build_url:https://queue.taskcluster.net/v1/task/CbSo9_5vT7SKBqDvdnI4oA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 23:22:30 INFO - Running post-action listener: _resource_record_post_action 23:22:30 INFO - Running post-action listener: set_extra_try_arguments 23:22:30 INFO - [mozharness: 2016-10-26 06:22:30.223215Z] Finished download-and-extract step (success) 23:22:30 INFO - [mozharness: 2016-10-26 06:22:30.223513Z] Running populate-webroot step. 23:22:30 INFO - Running pre-action listener: _resource_record_pre_action 23:22:30 INFO - Running main action method: populate_webroot 23:22:30 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 23:22:30 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 23:22:30 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 23:22:30 INFO - '--tppagecycles', 23:22:30 INFO - '7'], 23:22:30 INFO - 'tests': ['tsvgm']}}, 23:22:30 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 23:22:30 INFO - 'tests': ['tresize', 'tcanvasmark']}, 23:22:30 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 23:22:30 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 23:22:30 INFO - 'tests': ['dromaeo_css', 'kraken']}, 23:22:30 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 23:22:30 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:22:30 INFO - 'talos_options': ['--disable-e10s'], 23:22:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:22:30 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:22:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:22:30 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:22:30 INFO - 'talos_options': ['--disable-e10s'], 23:22:30 INFO - 'tests': ['damp', 'tps']}, 23:22:30 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:22:30 INFO - 'tests': ['damp', 'tps']}, 23:22:30 INFO - 'g3': {'talos_options': ['--disable-e10s'], 23:22:30 INFO - 'tests': ['dromaeo_dom']}, 23:22:30 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 23:22:30 INFO - 'g4': {'talos_options': ['--disable-e10s'], 23:22:30 INFO - 'tests': ['basic_compositor_video']}, 23:22:30 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 23:22:30 INFO - 'other': {'talos_options': ['--disable-e10s'], 23:22:30 INFO - 'tests': ['a11yr', 23:22:30 INFO - 'ts_paint', 23:22:30 INFO - 'tpaint', 23:22:30 INFO - 'sessionrestore', 23:22:30 INFO - 'sessionrestore_no_auto_restore', 23:22:30 INFO - 'tabpaint']}, 23:22:30 INFO - 'other-e10s': {'tests': ['a11yr', 23:22:30 INFO - 'ts_paint', 23:22:30 INFO - 'tpaint', 23:22:30 INFO - 'sessionrestore', 23:22:30 INFO - 'sessionrestore_no_auto_restore', 23:22:30 INFO - 'tabpaint']}, 23:22:30 INFO - 'other-e10s_l64': {'tests': ['a11yr', 23:22:30 INFO - 'ts_paint', 23:22:30 INFO - 'tpaint', 23:22:30 INFO - 'sessionrestore', 23:22:30 INFO - 'sessionrestore_no_auto_restore', 23:22:30 INFO - 'tabpaint']}, 23:22:30 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 23:22:30 INFO - 'ts_paint', 23:22:30 INFO - 'tpaint', 23:22:30 INFO - 'sessionrestore', 23:22:30 INFO - 'sessionrestore_no_auto_restore', 23:22:30 INFO - 'tabpaint']}, 23:22:30 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 23:22:30 INFO - 'tests': ['a11yr', 23:22:30 INFO - 'ts_paint', 23:22:30 INFO - 'tpaint', 23:22:30 INFO - 'sessionrestore', 23:22:30 INFO - 'sessionrestore_no_auto_restore', 23:22:30 INFO - 'tabpaint']}, 23:22:30 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 23:22:30 INFO - 'tests': ['a11yr', 23:22:30 INFO - 'ts_paint', 23:22:30 INFO - 'tpaint', 23:22:30 INFO - 'sessionrestore', 23:22:30 INFO - 'sessionrestore_no_auto_restore', 23:22:30 INFO - 'tabpaint']}, 23:22:30 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 23:22:30 INFO - 'tests': ['tsvgx', 23:22:30 INFO - 'tsvgr_opacity', 23:22:30 INFO - 'tart', 23:22:30 INFO - 'tscrollx', 23:22:30 INFO - 'cart']}, 23:22:30 INFO - 'svgr-e10s': {'tests': ['tsvgx', 23:22:30 INFO - 'tsvgr_opacity', 23:22:30 INFO - 'tart', 23:22:30 INFO - 'tscrollx', 23:22:30 INFO - 'cart']}, 23:22:30 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:22:30 INFO - 'talos_options': ['--disable-e10s'], 23:22:30 INFO - 'tests': ['tp5o']}, 23:22:30 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:22:30 INFO - 'tests': ['tp5o']}, 23:22:30 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:22:30 INFO - 'talos_options': ['--disable-e10s', 23:22:30 INFO - '--xperf_path', 23:22:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:22:30 INFO - 'tests': ['tp5n']}, 23:22:30 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:22:30 INFO - 'talos_options': ['--xperf_path', 23:22:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:22:30 INFO - 'tests': ['tp5n']}}, 23:22:30 INFO - 'talos.zip': {'path': '', 23:22:30 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 23:22:30 INFO - Running post-action listener: _resource_record_post_action 23:22:30 INFO - [mozharness: 2016-10-26 06:22:30.243779Z] Finished populate-webroot step (success) 23:22:30 INFO - [mozharness: 2016-10-26 06:22:30.243872Z] Running create-virtualenv step. 23:22:30 INFO - Running pre-action listener: _resource_record_pre_action 23:22:30 INFO - Running main action method: create_virtualenv 23:22:30 INFO - Creating virtualenv /builds/slave/test/build/venv 23:22:30 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 23:22:30 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 23:22:30 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:22:30 INFO - Using real prefix '/usr' 23:22:30 INFO - New python executable in /builds/slave/test/build/venv/bin/python 23:22:30 INFO - Installing distribute.............................................................................................................................................................................................done. 23:22:32 INFO - Installing pip.................done. 23:22:32 INFO - Return code: 0 23:22:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 23:22:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 23:22:33 INFO - Reading from file tmpfile_stdout 23:22:33 INFO - Output received: 23:22:33 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) 23:22:33 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 23:22: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')]} 23:22:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:22:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:22: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')]} 23:22:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:22:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:22:33 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 0x7f8bd790cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ddc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ea9ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ea6f60>, '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 0x1ea7d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ea81d0>, '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': '836cfdc75598d54cb747368e000001a9-1477460099.992012-1484926707', '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 23:22:33 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 23:22:33 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 23:22:33 INFO - Using env: {'DISPLAY': ':0', 23:22:33 INFO - 'HOME': '/home/cltbld', 23:22:33 INFO - 'LANG': 'en_US.UTF-8', 23:22:33 INFO - 'LANGUAGE': 'en_US:en', 23:22:33 INFO - 'LOGNAME': 'cltbld', 23:22:33 INFO - 'MAIL': '/var/mail/cltbld', 23:22:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:22:33 INFO - 'MOZ_NO_REMOTE': '1', 23:22:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:22:33 INFO - 'NO_EM_RESTART': '1', 23:22:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:22:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:22:33 INFO - 'PWD': '/builds/slave/test', 23:22:33 INFO - 'SHELL': '/bin/bash', 23:22:33 INFO - 'SHLVL': '1', 23:22:33 INFO - 'TERM': 'linux', 23:22:33 INFO - 'TMOUT': '86400', 23:22:33 INFO - 'USER': 'cltbld', 23:22:33 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1477460099.992012-1484926707', 23:22:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:22:33 INFO - '_': '/tools/buildbot/bin/python'} 23:22:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:22:33 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 23:22:33 INFO - Cleaning up... 23:22:33 INFO - Return code: 0 23:22:33 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 23:22: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')]} 23:22:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:22:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:22: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')]} 23:22:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:22:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:22:33 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 0x7f8bd790cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ddc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ea9ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ea6f60>, '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 0x1ea7d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ea81d0>, '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': '836cfdc75598d54cb747368e000001a9-1477460099.992012-1484926707', '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 23:22:33 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 23:22:33 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 23:22:33 INFO - Using env: {'DISPLAY': ':0', 23:22:33 INFO - 'HOME': '/home/cltbld', 23:22:33 INFO - 'LANG': 'en_US.UTF-8', 23:22:33 INFO - 'LANGUAGE': 'en_US:en', 23:22:33 INFO - 'LOGNAME': 'cltbld', 23:22:33 INFO - 'MAIL': '/var/mail/cltbld', 23:22:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:22:33 INFO - 'MOZ_NO_REMOTE': '1', 23:22:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:22:33 INFO - 'NO_EM_RESTART': '1', 23:22:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:22:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:22:33 INFO - 'PWD': '/builds/slave/test', 23:22:33 INFO - 'SHELL': '/bin/bash', 23:22:33 INFO - 'SHLVL': '1', 23:22:33 INFO - 'TERM': 'linux', 23:22:33 INFO - 'TMOUT': '86400', 23:22:33 INFO - 'USER': 'cltbld', 23:22:33 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1477460099.992012-1484926707', 23:22:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:22:33 INFO - '_': '/tools/buildbot/bin/python'} 23:22:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:22:33 INFO - Downloading/unpacking psutil>=3.1.1 23:22:33 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 23:22:33 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 23:22:33 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 23:22:33 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 23:22:33 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 23:22:33 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 23:22:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 23:22:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:22:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:22:35 INFO - Installing collected packages: psutil 23:22:35 INFO - Running setup.py install for psutil 23:22:35 INFO - building 'psutil._psutil_linux' extension 23:22:35 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 23:22:35 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 23:22:35 INFO - building 'psutil._psutil_posix' extension 23:22:35 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 23:22:35 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 23:22:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:22:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:22:35 INFO - Successfully installed psutil 23:22:35 INFO - Cleaning up... 23:22:36 INFO - Return code: 0 23:22:36 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 23:22:36 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')]} 23:22:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:22:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:22:36 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')]} 23:22:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:22:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:22:36 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 0x7f8bd790cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ddc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ea9ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ea6f60>, '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 0x1ea7d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ea81d0>, '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': '836cfdc75598d54cb747368e000001a9-1477460099.992012-1484926707', '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 23:22:36 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 23:22:36 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 23:22:36 INFO - Using env: {'DISPLAY': ':0', 23:22:36 INFO - 'HOME': '/home/cltbld', 23:22:36 INFO - 'LANG': 'en_US.UTF-8', 23:22:36 INFO - 'LANGUAGE': 'en_US:en', 23:22:36 INFO - 'LOGNAME': 'cltbld', 23:22:36 INFO - 'MAIL': '/var/mail/cltbld', 23:22:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:22:36 INFO - 'MOZ_NO_REMOTE': '1', 23:22:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:22:36 INFO - 'NO_EM_RESTART': '1', 23:22:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:22:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:22:36 INFO - 'PWD': '/builds/slave/test', 23:22:36 INFO - 'SHELL': '/bin/bash', 23:22:36 INFO - 'SHLVL': '1', 23:22:36 INFO - 'TERM': 'linux', 23:22:36 INFO - 'TMOUT': '86400', 23:22:36 INFO - 'USER': 'cltbld', 23:22:36 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1477460099.992012-1484926707', 23:22:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:22:36 INFO - '_': '/tools/buildbot/bin/python'} 23:22:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:22:36 INFO - Downloading/unpacking mozsystemmonitor==0.3 23:22:36 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 23:22:36 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 23:22:36 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 23:22:36 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 23:22:36 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 23:22:36 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 23:22:38 INFO - Downloading mozsystemmonitor-0.3.tar.gz 23:22:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 23:22:38 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 23:22:38 INFO - Installing collected packages: mozsystemmonitor 23:22:38 INFO - Running setup.py install for mozsystemmonitor 23:22:38 INFO - Successfully installed mozsystemmonitor 23:22:38 INFO - Cleaning up... 23:22:38 INFO - Return code: 0 23:22:38 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 23:22:38 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')]} 23:22:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:22:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:22:38 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')]} 23:22:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:22:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:22:38 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 0x7f8bd790cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ddc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ea9ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ea6f60>, '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 0x1ea7d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ea81d0>, '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': '836cfdc75598d54cb747368e000001a9-1477460099.992012-1484926707', '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 23:22:38 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 23:22:38 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 23:22:38 INFO - Using env: {'DISPLAY': ':0', 23:22:38 INFO - 'HOME': '/home/cltbld', 23:22:38 INFO - 'LANG': 'en_US.UTF-8', 23:22:38 INFO - 'LANGUAGE': 'en_US:en', 23:22:38 INFO - 'LOGNAME': 'cltbld', 23:22:38 INFO - 'MAIL': '/var/mail/cltbld', 23:22:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:22:38 INFO - 'MOZ_NO_REMOTE': '1', 23:22:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:22:38 INFO - 'NO_EM_RESTART': '1', 23:22:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:22:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:22:38 INFO - 'PWD': '/builds/slave/test', 23:22:38 INFO - 'SHELL': '/bin/bash', 23:22:38 INFO - 'SHLVL': '1', 23:22:38 INFO - 'TERM': 'linux', 23:22:38 INFO - 'TMOUT': '86400', 23:22:38 INFO - 'USER': 'cltbld', 23:22:38 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1477460099.992012-1484926707', 23:22:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:22:38 INFO - '_': '/tools/buildbot/bin/python'} 23:22:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:22:38 INFO - Downloading/unpacking jsonschema==2.5.1 23:22:38 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 23:22:38 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 23:22:38 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 23:22:38 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 23:22:38 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 23:22:38 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 23:22:40 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 23:22:40 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 23:22:40 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 23:22:40 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 23:22:40 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 23:22:40 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 23:22:40 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 23:22:40 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 23:22:40 INFO - Downloading functools32-3.2.3-2.tar.gz 23:22:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 23:22:40 INFO - warning: no files found matching '*.txt' 23:22:40 INFO - no previously-included directories found matching 'build' 23:22:40 INFO - no previously-included directories found matching 'dist' 23:22:40 INFO - no previously-included directories found matching '.git*' 23:22:40 INFO - Installing collected packages: jsonschema, functools32 23:22:41 INFO - Running setup.py install for functools32 23:22:41 INFO - warning: no files found matching '*.txt' 23:22:41 INFO - no previously-included directories found matching 'build' 23:22:41 INFO - no previously-included directories found matching 'dist' 23:22:41 INFO - no previously-included directories found matching '.git*' 23:22:41 INFO - Successfully installed jsonschema functools32 23:22:41 INFO - Cleaning up... 23:22:41 INFO - Return code: 0 23:22:41 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 23:22:41 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')]} 23:22:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:22:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:22:41 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')]} 23:22:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:22:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:22:41 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 0x7f8bd790cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ddc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ea9ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ea6f60>, '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 0x1ea7d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ea81d0>, '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': '836cfdc75598d54cb747368e000001a9-1477460099.992012-1484926707', '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 23:22:41 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 23:22:41 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 23:22:41 INFO - Using env: {'DISPLAY': ':0', 23:22:41 INFO - 'HOME': '/home/cltbld', 23:22:41 INFO - 'LANG': 'en_US.UTF-8', 23:22:41 INFO - 'LANGUAGE': 'en_US:en', 23:22:41 INFO - 'LOGNAME': 'cltbld', 23:22:41 INFO - 'MAIL': '/var/mail/cltbld', 23:22:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:22:41 INFO - 'MOZ_NO_REMOTE': '1', 23:22:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:22:41 INFO - 'NO_EM_RESTART': '1', 23:22:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:22:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:22:41 INFO - 'PWD': '/builds/slave/test', 23:22:41 INFO - 'SHELL': '/bin/bash', 23:22:41 INFO - 'SHLVL': '1', 23:22:41 INFO - 'TERM': 'linux', 23:22:41 INFO - 'TMOUT': '86400', 23:22:41 INFO - 'USER': 'cltbld', 23:22:41 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1477460099.992012-1484926707', 23:22:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:22:41 INFO - '_': '/tools/buildbot/bin/python'} 23:22:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:22:41 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 23:22:41 INFO - Cleaning up... 23:22:41 INFO - Return code: 0 23:22:41 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 23:22:41 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')]} 23:22:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:22:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:22:41 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')]} 23:22:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:22:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:22:41 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 0x7f8bd790cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ddc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ea9ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ea6f60>, '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 0x1ea7d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ea81d0>, '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': '836cfdc75598d54cb747368e000001a9-1477460099.992012-1484926707', '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 23:22:41 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 23:22:41 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 23:22:41 INFO - Using env: {'DISPLAY': ':0', 23:22:41 INFO - 'HOME': '/home/cltbld', 23:22:41 INFO - 'LANG': 'en_US.UTF-8', 23:22:41 INFO - 'LANGUAGE': 'en_US:en', 23:22:41 INFO - 'LOGNAME': 'cltbld', 23:22:41 INFO - 'MAIL': '/var/mail/cltbld', 23:22:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:22:41 INFO - 'MOZ_NO_REMOTE': '1', 23:22:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:22:41 INFO - 'NO_EM_RESTART': '1', 23:22:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:22:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:22:41 INFO - 'PWD': '/builds/slave/test', 23:22:41 INFO - 'SHELL': '/bin/bash', 23:22:41 INFO - 'SHLVL': '1', 23:22:41 INFO - 'TERM': 'linux', 23:22:41 INFO - 'TMOUT': '86400', 23:22:41 INFO - 'USER': 'cltbld', 23:22:41 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1477460099.992012-1484926707', 23:22:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:22:41 INFO - '_': '/tools/buildbot/bin/python'} 23:22:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:22:41 INFO - Downloading/unpacking blobuploader==1.2.4 23:22:41 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 23:22:41 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 23:22:41 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 23:22:41 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 23:22:41 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 23:22:41 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 23:22:43 INFO - Downloading blobuploader-1.2.4.tar.gz 23:22:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:22:43 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 23:22:43 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 23:22:43 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 23:22:43 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 23:22:43 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 23:22:43 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 23:22:43 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 23:22:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 23:22:44 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:22:44 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 23:22:44 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 23:22:44 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 23:22:44 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 23:22:44 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 23:22:44 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 23:22:44 INFO - Downloading docopt-0.6.1.tar.gz 23:22:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 23:22:44 INFO - Installing collected packages: blobuploader, requests, docopt 23:22:44 INFO - Running setup.py install for blobuploader 23:22:44 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:22:44 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 23:22:44 INFO - Running setup.py install for requests 23:22:44 INFO - Running setup.py install for docopt 23:22:44 INFO - Successfully installed blobuploader requests docopt 23:22:44 INFO - Cleaning up... 23:22:44 INFO - Return code: 0 23:22:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:22:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:22:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:22:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:22:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:22:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:22:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:22:44 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 0x7f8bd790cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ddc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ea9ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ea6f60>, '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 0x1ea7d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ea81d0>, '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': '836cfdc75598d54cb747368e000001a9-1477460099.992012-1484926707', '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 23:22:44 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 23:22:44 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 23:22:44 INFO - Using env: {'DISPLAY': ':0', 23:22:44 INFO - 'HOME': '/home/cltbld', 23:22:44 INFO - 'LANG': 'en_US.UTF-8', 23:22:44 INFO - 'LANGUAGE': 'en_US:en', 23:22:44 INFO - 'LOGNAME': 'cltbld', 23:22:44 INFO - 'MAIL': '/var/mail/cltbld', 23:22:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:22:44 INFO - 'MOZ_NO_REMOTE': '1', 23:22:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:22:44 INFO - 'NO_EM_RESTART': '1', 23:22:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:22:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:22:44 INFO - 'PWD': '/builds/slave/test', 23:22:44 INFO - 'SHELL': '/bin/bash', 23:22:44 INFO - 'SHLVL': '1', 23:22:44 INFO - 'TERM': 'linux', 23:22:44 INFO - 'TMOUT': '86400', 23:22:44 INFO - 'USER': 'cltbld', 23:22:44 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1477460099.992012-1484926707', 23:22:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:22:44 INFO - '_': '/tools/buildbot/bin/python'} 23:22:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:22:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:22:45 INFO - Running setup.py (path:/tmp/pip-vLw1QC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:22:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:22:45 INFO - Running setup.py (path:/tmp/pip-QXOPng-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:22:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:22:45 INFO - Running setup.py (path:/tmp/pip-ojGkBx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:22:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:22:45 INFO - Running setup.py (path:/tmp/pip-qNg2aR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:22:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:22:45 INFO - Running setup.py (path:/tmp/pip-CGKObO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:22:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:22:45 INFO - Running setup.py (path:/tmp/pip-8t37kg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:22:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:22:45 INFO - Running setup.py (path:/tmp/pip-7H5uhl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:22:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:22:45 INFO - Running setup.py (path:/tmp/pip-Td5CEA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:22:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:22:45 INFO - Running setup.py (path:/tmp/pip-5dhyT2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:22:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:22:45 INFO - Running setup.py (path:/tmp/pip-50qNZZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:22:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:22:45 INFO - Running setup.py (path:/tmp/pip-RYnrUs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:22:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:22:45 INFO - Running setup.py (path:/tmp/pip-B6v9cA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:22:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:22:46 INFO - Running setup.py (path:/tmp/pip-XnfbdL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:22:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:22:46 INFO - Running setup.py (path:/tmp/pip-49Xj6a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:22:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:22:46 INFO - Running setup.py (path:/tmp/pip-tmI3x2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:22:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:22:46 INFO - Running setup.py (path:/tmp/pip-EnEjtZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:22:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:22:46 INFO - Running setup.py (path:/tmp/pip-9QLPTS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:22:46 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:22:46 INFO - Running setup.py install for manifestparser 23:22:46 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 23:22:46 INFO - Running setup.py install for mozcrash 23:22:46 INFO - Running setup.py install for mozdebug 23:22:46 INFO - Running setup.py install for mozdevice 23:22:46 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 23:22:46 INFO - Installing dm script to /builds/slave/test/build/venv/bin 23:22:46 INFO - Running setup.py install for mozfile 23:22:46 INFO - Running setup.py install for mozhttpd 23:22:46 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 23:22:46 INFO - Running setup.py install for mozinfo 23:22:47 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 23:22:47 INFO - Running setup.py install for mozInstall 23:22:47 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 23:22:47 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 23:22:47 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 23:22:47 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 23:22:47 INFO - Running setup.py install for mozleak 23:22:47 INFO - Running setup.py install for mozlog 23:22:47 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 23:22:47 INFO - Running setup.py install for moznetwork 23:22:47 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 23:22:47 INFO - Running setup.py install for mozprocess 23:22:47 INFO - Running setup.py install for mozprofile 23:22:47 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 23:22:47 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 23:22:47 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 23:22:47 INFO - Running setup.py install for mozrunner 23:22:47 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 23:22:47 INFO - Running setup.py install for mozscreenshot 23:22:47 INFO - Running setup.py install for moztest 23:22:48 INFO - Running setup.py install for mozversion 23:22:48 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 23:22:48 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:22:48 INFO - Cleaning up... 23:22:48 INFO - Return code: 0 23:22:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:22:48 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')]} 23:22:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:22:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:22:48 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')]} 23:22:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:22:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:22:48 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 0x7f8bd790cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ddc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ea9ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ea6f60>, '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 0x1ea7d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ea81d0>, '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': '836cfdc75598d54cb747368e000001a9-1477460099.992012-1484926707', '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 23:22:48 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 23:22:48 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 23:22:48 INFO - Using env: {'DISPLAY': ':0', 23:22:48 INFO - 'HOME': '/home/cltbld', 23:22:48 INFO - 'LANG': 'en_US.UTF-8', 23:22:48 INFO - 'LANGUAGE': 'en_US:en', 23:22:48 INFO - 'LOGNAME': 'cltbld', 23:22:48 INFO - 'MAIL': '/var/mail/cltbld', 23:22:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:22:48 INFO - 'MOZ_NO_REMOTE': '1', 23:22:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:22:48 INFO - 'NO_EM_RESTART': '1', 23:22:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:22:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:22:48 INFO - 'PWD': '/builds/slave/test', 23:22:48 INFO - 'SHELL': '/bin/bash', 23:22:48 INFO - 'SHLVL': '1', 23:22:48 INFO - 'TERM': 'linux', 23:22:48 INFO - 'TMOUT': '86400', 23:22:48 INFO - 'USER': 'cltbld', 23:22:48 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1477460099.992012-1484926707', 23:22:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:22:48 INFO - '_': '/tools/buildbot/bin/python'} 23:22:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:22:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:22:48 INFO - Running setup.py (path:/tmp/pip-9PmrtK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:22:48 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)) 23:22:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:22:48 INFO - Running setup.py (path:/tmp/pip-A0dmkz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:22:48 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)) 23:22:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:22:48 INFO - Running setup.py (path:/tmp/pip-Z6oYHA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:22:48 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)) 23:22:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:22:48 INFO - Running setup.py (path:/tmp/pip-5DlOta-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:22:48 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)) 23:22:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:22:48 INFO - Running setup.py (path:/tmp/pip-UeyIsk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:22:48 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)) 23:22:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:22:48 INFO - Running setup.py (path:/tmp/pip-rg5xAU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:22:48 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)) 23:22:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:22:48 INFO - Running setup.py (path:/tmp/pip-60YGu2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:22:48 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)) 23:22:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:22:48 INFO - Running setup.py (path:/tmp/pip-UCcJvQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:22:48 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)) 23:22:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:22:48 INFO - Running setup.py (path:/tmp/pip-g4NF01-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:22:49 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)) 23:22:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:22:49 INFO - Running setup.py (path:/tmp/pip-lRK7dh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:22:49 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)) 23:22:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:22:49 INFO - Running setup.py (path:/tmp/pip-HDdVDU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:22:49 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)) 23:22:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:22:49 INFO - Running setup.py (path:/tmp/pip-vW6zRu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:22:49 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)) 23:22:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:22:49 INFO - Running setup.py (path:/tmp/pip-ifVWTy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:22:49 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)) 23:22:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:22:49 INFO - Running setup.py (path:/tmp/pip-GxACNT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:22:49 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)) 23:22:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:22:49 INFO - Running setup.py (path:/tmp/pip-L1AIGB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:22:49 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)) 23:22:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:22:49 INFO - Running setup.py (path:/tmp/pip-wCgKGe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:22:49 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)) 23:22:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:22:49 INFO - Running setup.py (path:/tmp/pip-f1uoSy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:22:49 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)) 23:22:49 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)) 23:22:49 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)) 23:22:49 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)) 23:22:49 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)) 23:22:49 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)) 23:22:49 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:22:49 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 23:22:49 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 23:22:49 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 23:22:49 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 23:22:49 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 23:22:49 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 23:22:52 INFO - Downloading blessings-1.6.tar.gz 23:22:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 23:22:52 INFO - Installing collected packages: blessings 23:22:52 INFO - Running setup.py install for blessings 23:22:52 INFO - Successfully installed blessings 23:22:52 INFO - Cleaning up... 23:22:52 INFO - Return code: 0 23:22:52 INFO - Done creating virtualenv /builds/slave/test/build/venv. 23:22:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:22:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:22:53 INFO - Reading from file tmpfile_stdout 23:22:53 INFO - Current package versions: 23:22:53 INFO - argparse == 1.2.1 23:22:53 INFO - blessings == 1.6 23:22:53 INFO - blobuploader == 1.2.4 23:22:53 INFO - docopt == 0.6.1 23:22:53 INFO - functools32 == 3.2.3-2 23:22:53 INFO - jsonschema == 2.5.1 23:22:53 INFO - manifestparser == 1.1 23:22:53 INFO - mozInstall == 1.12 23:22:53 INFO - mozcrash == 0.17 23:22:53 INFO - mozdebug == 0.1 23:22:53 INFO - mozdevice == 0.48 23:22:53 INFO - mozfile == 1.2 23:22:53 INFO - mozhttpd == 0.7 23:22:53 INFO - mozinfo == 0.9 23:22:53 INFO - mozleak == 0.1 23:22:53 INFO - mozlog == 3.4 23:22:53 INFO - moznetwork == 0.27 23:22:53 INFO - mozprocess == 0.23 23:22:53 INFO - mozprofile == 0.28 23:22:53 INFO - mozrunner == 6.12 23:22:53 INFO - mozscreenshot == 0.1 23:22:53 INFO - mozsystemmonitor == 0.3 23:22:53 INFO - moztest == 0.7 23:22:53 INFO - mozversion == 1.4 23:22:53 INFO - psutil == 3.1.1 23:22:53 INFO - requests == 1.2.3 23:22:53 INFO - wsgiref == 0.1.2 23:22:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:22:53 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')]} 23:22:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:22:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:22:53 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')]} 23:22:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:22:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:22:53 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 0x7f8bd790cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ddc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ea9ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ea6f60>, '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 0x1ea7d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ea81d0>, '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': '836cfdc75598d54cb747368e000001a9-1477460099.992012-1484926707', '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 23:22:53 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 23:22:53 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 23:22:53 INFO - Using env: {'DISPLAY': ':0', 23:22:53 INFO - 'HOME': '/home/cltbld', 23:22:53 INFO - 'LANG': 'en_US.UTF-8', 23:22:53 INFO - 'LANGUAGE': 'en_US:en', 23:22:53 INFO - 'LOGNAME': 'cltbld', 23:22:53 INFO - 'MAIL': '/var/mail/cltbld', 23:22:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:22:53 INFO - 'MOZ_NO_REMOTE': '1', 23:22:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:22:53 INFO - 'NO_EM_RESTART': '1', 23:22:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:22:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:22:53 INFO - 'PWD': '/builds/slave/test', 23:22:53 INFO - 'SHELL': '/bin/bash', 23:22:53 INFO - 'SHLVL': '1', 23:22:53 INFO - 'TERM': 'linux', 23:22:53 INFO - 'TMOUT': '86400', 23:22:53 INFO - 'USER': 'cltbld', 23:22:53 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1477460099.992012-1484926707', 23:22:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:22:53 INFO - '_': '/tools/buildbot/bin/python'} 23:22:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:22:53 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)) 23:22:53 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)) 23:22:53 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)) 23:22:53 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)) 23:22:53 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)) 23:22:53 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)) 23:22:53 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)) 23:22:53 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)) 23:22:53 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)) 23:22:53 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)) 23:22:53 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)) 23:22:53 INFO - Cleaning up... 23:22:53 INFO - Return code: 0 23:22:53 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 23:22:53 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')]} 23:22:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:22:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:22:53 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')]} 23:22:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:22:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:22:53 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 0x7f8bd790cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ddc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ea9ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ea6f60>, '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 0x1ea7d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ea81d0>, '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': '836cfdc75598d54cb747368e000001a9-1477460099.992012-1484926707', '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 23:22:53 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 23:22:53 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 23:22:53 INFO - Using env: {'DISPLAY': ':0', 23:22:53 INFO - 'HOME': '/home/cltbld', 23:22:53 INFO - 'LANG': 'en_US.UTF-8', 23:22:53 INFO - 'LANGUAGE': 'en_US:en', 23:22:53 INFO - 'LOGNAME': 'cltbld', 23:22:53 INFO - 'MAIL': '/var/mail/cltbld', 23:22:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:22:53 INFO - 'MOZ_NO_REMOTE': '1', 23:22:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:22:53 INFO - 'NO_EM_RESTART': '1', 23:22:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:22:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:22:53 INFO - 'PWD': '/builds/slave/test', 23:22:53 INFO - 'SHELL': '/bin/bash', 23:22:53 INFO - 'SHLVL': '1', 23:22:53 INFO - 'TERM': 'linux', 23:22:53 INFO - 'TMOUT': '86400', 23:22:53 INFO - 'USER': 'cltbld', 23:22:53 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1477460099.992012-1484926707', 23:22:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:22:53 INFO - '_': '/tools/buildbot/bin/python'} 23:22:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:22:53 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 23:22:53 INFO - Cleaning up... 23:22:53 INFO - Return code: 0 23:22:53 INFO - Running post-action listener: _resource_record_post_action 23:22:53 INFO - Running post-action listener: _start_resource_monitoring 23:22:53 INFO - Starting resource monitoring. 23:22:53 INFO - [mozharness: 2016-10-26 06:22:53.540122Z] Finished create-virtualenv step (success) 23:22:53 INFO - [mozharness: 2016-10-26 06:22:53.540615Z] Running install step. 23:22:53 INFO - Running pre-action listener: _resource_record_pre_action 23:22:53 INFO - Running main action method: install 23:22:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:22:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:22:53 INFO - Reading from file tmpfile_stdout 23:22:53 INFO - Detecting whether we're running mozinstall >=1.0... 23:22:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 23:22:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 23:22:53 INFO - Reading from file tmpfile_stdout 23:22:53 INFO - Output received: 23:22:53 INFO - Usage: mozinstall [options] installer 23:22:53 INFO - Options: 23:22:53 INFO - -h, --help show this help message and exit 23:22:53 INFO - -d DEST, --destination=DEST 23:22:53 INFO - Directory to install application into. [default: 23:22:53 INFO - "/builds/slave/test"] 23:22:53 INFO - --app=APP Application being installed. [default: firefox] 23:22:53 INFO - mkdir: /builds/slave/test/build/application 23:22:53 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'] 23:22:53 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 23:23:09 INFO - Reading from file tmpfile_stdout 23:23:09 INFO - Output received: 23:23:09 INFO - /builds/slave/test/build/application/firefox/firefox 23:23:09 INFO - Running post-action listener: _resource_record_post_action 23:23:09 INFO - [mozharness: 2016-10-26 06:23:09.905027Z] Finished install step (success) 23:23:09 INFO - [mozharness: 2016-10-26 06:23:09.905271Z] Running run-tests step. 23:23:09 INFO - Running pre-action listener: _resource_record_pre_action 23:23:09 INFO - Running main action method: run_tests 23:23:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 23:23:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 23:23:09 INFO - Python 2.7.3 23:23:09 INFO - Return code: 0 23:23:09 INFO - grabbing minidump binary from tooltool 23:23:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:23:09 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 0x1ea6f60>, '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 0x1ea7d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ea81d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 23:23:09 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 23:23:09 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 23:23:09 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 23:23:09 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:23:09 INFO - Return code: 0 23:23:09 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 23:23:09 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 23:23:09 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 23:23:09 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 23:23:09 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 23:23:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CbSo9_5vT7SKBqDvdnI4oA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-028', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 23:23:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/CbSo9_5vT7SKBqDvdnI4oA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-028 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 23:23:09 INFO - Using env: {'DISPLAY': ':0', 23:23:09 INFO - 'HOME': '/home/cltbld', 23:23:09 INFO - 'LANG': 'en_US.UTF-8', 23:23:09 INFO - 'LANGUAGE': 'en_US:en', 23:23:09 INFO - 'LOGNAME': 'cltbld', 23:23:09 INFO - 'MAIL': '/var/mail/cltbld', 23:23:09 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 23:23:09 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 23:23:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:23:09 INFO - 'MOZ_NO_REMOTE': '1', 23:23:09 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 23:23:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:23:09 INFO - 'NO_EM_RESTART': '1', 23:23:09 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:23:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:23:09 INFO - 'PWD': '/builds/slave/test', 23:23:09 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 23:23:09 INFO - 'SHELL': '/bin/bash', 23:23:09 INFO - 'SHLVL': '1', 23:23:09 INFO - 'TERM': 'linux', 23:23:09 INFO - 'TMOUT': '86400', 23:23:09 INFO - 'USER': 'cltbld', 23:23:09 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1477460099.992012-1484926707', 23:23:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:23:09 INFO - '_': '/tools/buildbot/bin/python'} 23:23:09 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CbSo9_5vT7SKBqDvdnI4oA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-028', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 23:23:10 INFO - mozversion application_buildid: 20161025220526 23:23:10 INFO - mozversion application_changeset: f9f3cc95d7282f1fd83f66dd74acbcdbfe821915 23:23:10 INFO - mozversion application_display_name: Nightly 23:23:10 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:23:10 INFO - mozversion application_name: Firefox 23:23:10 INFO - mozversion application_remotingname: firefox 23:23:10 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 23:23:10 INFO - mozversion application_vendor: Mozilla 23:23:10 INFO - mozversion application_version: 52.0a1 23:23:10 INFO - mozversion platform_buildid: 20161025220526 23:23:10 INFO - mozversion platform_changeset: f9f3cc95d7282f1fd83f66dd74acbcdbfe821915 23:23:10 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 23:23:10 INFO - mozversion platform_version: 52.0a1 23:23:10 INFO - using testdate: 1477462990 23:23:10 INFO - actual date: 1477462990 23:23:10 INFO - starting webserver on 'localhost:49010' 23:23:10 INFO - SUITE-START | Running 2 tests 23:23:10 INFO - TEST-START | dromaeo_css 23:23:10 INFO - operating with platform_type : linux_ 23:23:10 INFO - Initialising browser for dromaeo_css test... 23:23:10 INFO - TEST-INFO | started process 7636 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPcWA18/profile http://localhost:49010/getInfo.html) 23:23:14 INFO - PROCESS | 7636 | __metrics Screen width/height:1600/1200 23:23:14 INFO - PROCESS | 7636 | colorDepth:24 23:23:14 INFO - PROCESS | 7636 | Browser inner width/height: 1024/697 23:23:14 INFO - PROCESS | 7636 | __metrics 23:23:15 ERROR - PROCESS | 7636 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3097: TypeError: this.tabs is undefined 23:23:16 INFO - TEST-INFO | 7636: exit 0 23:23:16 INFO - Browser initialized. 23:23:16 INFO - Running cycle 1/1 for dromaeo_css test... 23:23:16 INFO - TEST-INFO | started process 7757 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPcWA18/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:23:28 INFO - PROCESS | 7757 | RSS: Main: 183087104 23:23:28 INFO - PROCESS | 7757 | 23:24:18 INFO - PROCESS | 7757 | 1477463058529 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] 23:26:32 INFO - PROCESS | 7757 | Cycle 1(1): loaded http://localhost:49010/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49010/tests/dromaeo/cssquery-ext.html) 23:26:33 INFO - PROCESS | 7757 | RSS: Main: 193839104 23:26:33 INFO - PROCESS | 7757 | 23:29:36 INFO - PROCESS | 7757 | Cycle 1(1): loaded http://localhost:49010/tests/dromaeo/cssquery-ext.html (next: http://localhost:49010/tests/dromaeo/cssquery-jquery.html) 23:29:36 INFO - PROCESS | 7757 | RSS: Main: 194011136 23:29:36 INFO - PROCESS | 7757 | 23:32:38 INFO - PROCESS | 7757 | Cycle 1(1): loaded http://localhost:49010/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49010/tests/dromaeo/cssquery-mootools.html) 23:32:39 INFO - PROCESS | 7757 | RSS: Main: 196673536 23:32:39 INFO - PROCESS | 7757 | 23:35:41 INFO - PROCESS | 7757 | Cycle 1(1): loaded http://localhost:49010/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49010/tests/dromaeo/cssquery-prototype.html) 23:35:42 INFO - PROCESS | 7757 | RSS: Main: 193527808 23:35:42 INFO - PROCESS | 7757 | 23:38:45 INFO - PROCESS | 7757 | Cycle 1(1): loaded http://localhost:49010/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49010/tests/dromaeo/cssquery-yui.html) 23:38:45 INFO - PROCESS | 7757 | RSS: Main: 196165632 23:38:45 INFO - PROCESS | 7757 | 23:41:48 INFO - PROCESS | 7757 | Cycle 1(1): loaded http://localhost:49010/tests/dromaeo/cssquery-yui.html (next: http://localhost:49010/tests/dromaeo/cssquery-dojo.html) 23:41:48 INFO - PROCESS | 7757 | RSS: Main: 195850240 23:41:48 INFO - PROCESS | 7757 | 23:41:48 INFO - PROCESS | 7757 | __start_tp_report 23:41:48 INFO - PROCESS | 7757 | _x_x_mozilla_page_load 23:41:48 INFO - PROCESS | 7757 | _x_x_mozilla_page_load_details 23:41:48 INFO - PROCESS | 7757 | |i|pagename|runs| 23:41:48 INFO - PROCESS | 7757 | |0;dojo.html;2624.7244039375855;2634.84190948543;2636.301380134264;2640.3003204150905;2653.6948250951136;4554.089182163564;4602.516735742741;4604.631629469639;4606.009707912798;4641.6054635355995;4621.676482646216;4642.512536183703;4647.070585882829;4650.651201159918;4750.7149571025675;4246.2356775780345;4282.850100246492;4306.397104405386;4331.198728235287;4442.689011769177;3988.501437320335;4377.058932329549;4382.561743825608;4427.845025424111;4429.844955426561;4208.158368326316;4281.614654681062;4288.656907447396;4343.761093139876;4383.802728877208;4242.342436922282;4242.406063151161;4262.296721041024;4281;4300.09697963425;4201.621854033121;4215.220184265921;4243.596858298457;4264.765437900915;4273.572642735701;4559.3388958601145;4590.311453282035;4599.517050709695;4638.257878739386;4683.88290292742;4904.485029071968;4976.701397916137;4992;5000.499950005007;5012.6966988583235;4983.426905905795;5021.221710634857;5032.069067222539;5036.370453693288;5067.543921047123;4526.366308716782;4568.223402021665;4672.953270467286;4687.67186296956;4740.644451666139;5028.321176641107;5061.493850614909;5075.111855425286;5094.643374963791;5158.226266060121;4882.8779280517565;4893.4617192108835;4893.828715994923;4901.730404827768;4956;4835.0571638530855;4899.510048995072;4975.378077740283;4982.177940639754;4996.675216110941;4823.131836269435;4857.80568777252;4897.14299997499;4924.384451943507;4984.42679091909;4885.169521181408;4893.926591101136;4904.8038078477175;4914.992426552548;4971.055499455092;4069.877903662895;4098.241825262336;4106.897327566775;4111.1366613011005;4152.397902304209;3617.764845285048;3626.0572251214876;3652.7990960496895;3676.246369494247;3679.1170119171743;4332.826686932487;4349.565043495625;4362.890927726832;4376.934345984812;4396.428464299621;4977.352944117241;4990.800367985313;4991.226359914219;4992.475790042066;5041.974790126026;4224.704270701083;4260.44614200152;4341.782910854445;4363.672724545671;4376.9124617508105;4390.1878152541885;4404.009097952935;4409.49290831552;4456.376107344974;4463.732176069446;4702.482726900107;4721.858344249678;4730.668853180313;4737.644676649334;4787.186178349759;4879.829205977774;4889.657723959289;4920.6063514918005;4971.229459433794;4981.551660350441;4716.693414928019;4718.504557021463;4718.929216061693;4745.501722319107;4757.524247575215;4897.020595880766;4898.804047838046;4899.412070551557;4900.70595764241;4959.62802789785;4832.9275060873415;4873.95126048735;4958.603311734981;4974.228994505857;5031.446540880427;4722.079194557028;4753.47711751714;4776.641751868554;4778.068276686013;4838.927416088691;4735.857924262277;4766.213574760126;4770.713757174581;4771.355866958055;4833.903321933612;4672.556107169813;4716.033213191219;4718.245080787057;4746.1694203514935;4755.7859896305445;4817.975910120427;4851.369321988119;4860.295257187759;4914.115459217375;4918.2376731606655;4745.359376484131;4756;4763.3807605011125;4778.832740854054;4821.276808478756 23:41:48 INFO - PROCESS | 7757 | |1;ext.html;523.777394607292;527.1723394270996;544.6350944866939;550.7383992603517;550.7769353411868;37880;39691.80154099229;39940.60059399405;40264.79867600665;43684.78157609208;40687.79656101715;40899.386509202384;40926.59073409265;41038.17923641526;41145.17709645805;7636.465447418683;7747.767566973;7764;7767.067951845758;7770.883436748453;7634.809129771772;7719.305262526372;7730.342920851706;7760.57316847576;7783.260590243946;7692.961535192344;7770.9222907771045;7787.493812902171;7787.844243115134;7803.258690424401;7717.344025757818;7719.9614001930195;7747.535147891144;7785.455018148732;7804.687812487494;7653.540787552764;7744.496607720536;7746.341560967325;7764.883526747103;7770.844583108363;37793;37871.8106409469;37899;37918.62081379206;38218.23563528742;3058.8470576471086;3209.3581283743347;3565.7682250653625;3571.428571428559;3603.837827297778;28787.856060719772;28900.710992890014;29075;29147;29283.41433171346;3484.6689564491335;3604.5854726706502;3653.50677658518;3701.2782507411066;3721.404575267944;231350;232475;233203;233459;234274;51678.48321516812;51800.48199518032;51935;52083;52145.2178217327;54731.17903231455;55046;55081.449185507634;55181.448185518435;55242;11329.546818127183;11459;11460.624725032883;11516.596919107791;11572.958433740836;9895.356801807859;9972.401655900669;10023.599056037678;10028.949855250678;10034.24743144267;14983.475578354706;16305.347786088661;16420.671586568442;16595.17024148788;16694.165291735608;2946.720061594145;3131.2171957010746;5863.882722345529;5921.437463440966;5927.347991720907;805.3879051920466;910.9863352049724;916.1434059154578;963.9710808675751;974.0989584634185;27024.86487567589;28267.43465130686;28544.85727571349;28764.568531472043;29092.709072909;993.2004736187295;1006.2101250518308;1036.533559898049;1043.796459690353;1061.3048453263125;15055.096694198164;15086.698266034837;15167.089974601558;15253.542393728207;15262.618434539003;349604;354153;354287;355198;357124;49756;49827.75086124619;50115;50223.24665130026;50251.24623130656;1152.608113241502;1175.1773758369177;1189.191349882071;1194.6416075177585;1206.5053328135423;26600.201993940213;27347.31631709223;27774.166774996782;29533.704662953096;30072.84963575256;47196.7640161797;47966.76016620034;47988.5201147998;48076;48090.5190948086;333262;336810;337906;338034;339300;24425.75574244306;25478.872605637596;38009.61990380061;38406;38566.42150367803;41145.58854411537;41358.58641413668;41793.373099402925;42096.789516052224;42472;33678;34238;35273.47089793604;36114.638853611126;36360.636393636785;35286;35659.10852228715;35707;35812.462813058344;36031;34756.30487390289;34767.30465390729;35422.645773542965;35906.8204658975;36116.63883361133;30097.398052039276;32282.19294517562;32697.509537356484;32795.83602081974;32895.67104328926;24979.125730599342;25242.873785630953;25286.620700689873;25513.362165946;25544.872275638503 23:41:48 INFO - PROCESS | 7757 | |2;jquery.html;357.26938410949606;363.8180909545227;364.9361361761692;377.91685829117586;385.10463173122497;15594.064356138626;16993.490195294147;17285.135743212853;17421.82578174218;17422;15651.765223521628;16448.67102657946;16855.157242137873;16944.576385590368;16997.830021699778;4802.687825291354;5035.899282014358;5069.112905241586;5078.771455284503;5079.771410286546;4967.528084831935;5220.973895130538;5491.780328786864;5555.611107222496;5592.07730724432;5486.204500347447;5538.086215774392;5546.91679624806;5602.1036634138545;5608.495235428811;5388.488093631118;5515.227868098469;5581.2186293918885;5589.413111623262;5593.496585307322;5237.3453318335205;5388.78444862205;5389.541888939445;5400.324959380077;5402.6758394496455;12180.330081845495;12478.625641230778;12534.81197782034;12536.122471427003;12540.498380064877;1839.6412699523598;1867.9252829886789;2044.7341845559981;2164.722813540019;2276.5333106713083;9035.819283614357;9048.230900373475;9128.178463938277;9623.085806848338;9670.75823104421;1627.593101724569;1646.3579204110288;1693.119577819527;1695.2710334556136;1743.8779285450023;57021.42978570203;61296.69351653258;65285.3471465284;65322.673386633236;66531;9737.805243895082;9803.656872009446;9912.56267841159;9955;10090.848637270446;13597.184168949894;13612.727745445234;13657.248851313074;13663.316834158451;13699.589012329647;6953.155625244943;6959.4432445404245;7047.471439642048;7077.433805295564;7091.964540177266;6218.409251121137;6289.96855015722;6313.968430157912;6742.662866856637;6749.696263668048;4093.385992101149;4202.915941681149;4226;4350.869473915787;4363.5418281080665;1615.8626516745974;1688.5440930948575;1725.4306078993902;1734.670412621598;1842.2815102110187;858.6822875536092;888.9911100889037;896.6010125494223;924.0805398628407;946.668665966906;15322.79614802206;15853.52439426819;16340.346386144658;16824.66350673004;16856.41002564929;812.8414959083041;839.8278352937633;846.6359465429802;866.7399780065955;878.5958459108881;8808.603612837438;9197.448153110834;9406.670766523139;10137.797244055078;10229.386236825814;358973;361727;363684;364335;364975;76524;78590.56913170456;78800;79816.60091699504;80300.59849700831;946.4415994563241;954.7231302922074;972.3193764364972;974.2692980264801;976.7411635916487;15285.694286113992;15328;15450.30473628667;15685.764713529534;16027.759583606488;35460.29079418449;35808.641913581574;36719.63280367162;37064.44403333898;37495.81252093722;46914;50720.74639626778;50988.235176471644;52681.73659131833;54172.45827541674;6918;7232.963835180791;7328.523645962995;7403.925960740324;7596.658150383136;8010.239027292398;9545.665901693685;10955.616553420592;11097.278676885977;12151;9498.965548259433;9572.425654460754;9829.606815727577;10075.596976120873;10400.323978941344;9773.657921972697;9780;9962.452065136487;10049.849252261076;10118.291719579558;9793.902060979584;9911.801763964824;10185.032421919906;10308;10338.534765935701;7075.5047146699235;7254.875494298392;7308.853822923618;7375.262473752582;7534.171241163577;9047.773805654648;9145;9215.2627789778;9260.953695231481;9343.813123737624 23:41:48 INFO - PROCESS | 7757 | |3;mootools.html;1356.5116558039108;1376.1949259683086;1467.4790449390466;1647.1599484263022;1667.0914351678327;6166.691665416723;6335.081413195084;6962.338577835104;7399.556026638399;7448.813779655511;6950.6524673766235;7183.353498185163;7193.85612287754;7379.409647228223;7394.038774959261;2063.143795324942;2085.6037352902977;2089.8014688604635;2091.874487530753;2092.769795322521;2062.7009083682856;2099.9055042523046;2109.050927082811;2110.1453911166004;2111;2015.5263513074415;2029.6346657601625;2036.6130435217262;2037.8471614628888;2052.0663098290242;2044.2231951858273;2049.4466494046524;2060.453979695382;2061.7319748432756;2063.525389160494;1977.3870100268819;2013.3054096336741;2024.2409096588779;2040.9795902040937;2048.549319149785;7102.467314951347;7178.2103968563415;7192.208857025723;7265.527740696838;7295.0516432863915;4221.493420789494;4345.174416860818;4346.456692913386;4350.434443522322;4353.1293741251875;2509.962350564743;2680.973190268092;2701.932451688704;2715.1854443667016;2742.1773467959533;841.2722994609679;877.4954401219261;885.9379843410964;902.596462500811;909.4452384045727;9697.369670971435;9712.75718107046;9736;9760.609575616967;9812.754681133028;3713.88858334245;3859.6526312632;3920.5295364555864;3925.823337949799;3987.5414327352146;8340.37447191463;8349.749507514784;8350.415470916978;8353.081161072278;8356.289715374262;4330.783460826946;4346.413234213404;4347.826086956549;4350.32569951658;4354.4992325882295;3407.9148021299666;3512.332656795201;3831.7700937943814;3988.3818008208773;3993.6206060424215;3196.3447493263825;3234.741220702338;3314.2931390333997;3329.217633856042;3371.8651253950056;1093.2893619147617;1100.5707773968159;1102.2945314998408;1104.5140138339104;1115.4088333183263;852.3181454836106;860.694453469022;862.5126803356084;870.6560908441257;887.2813021452644;5046.823361182341;5113.233015047698;5156.278121063054;5257.553107985864;5263.6578622389425;375.41247946962915;408.82829211731143;410.8130800485772;412.4514395853508;418.9958100419018;3512.2624248907505;3532.91167720809;3543.344481270973;3565.5008298838184;3649.3978493548266;8900.332475064397;9164.083591640916;9188.908110918805;9253.306002049738;9273.814523709489;9085.818283634422;9088.681896133603;9099.272058235325;9112;9112.81774364509;6680.532362734659;6943.548669336578;6976.720931162697;6979.581225126509;7070.681819318143;5228.189630607262;5368.812091576932;5387.838364849061;5445.782168713207;5471.452854714496;7794.427838813064;7962.163972782774;8035.67857285702;8195.795105122419;8368.330533557422;7997.1203167652675;8129.268365847102;8161.79595510117;8267.255946964802;8309.459885107448;6802.421794147553;6843.828904277433;6878.58728476293;6907.274736152833;6910.308969103049;6898.206706228848;7023.719051237893;7035.437165026888;7040.471964602573;7041.718331266692;6201.441870231701;6281.434670879643;6309.589876658002;6439.227292724903;6454.967725161344;6071.210742603434;6205.596636218631;6286.18279623646;6310.148130002391;6341.334159913143;6078.300995385587;6192.504599632109;6208.286047104641;6208.782692605918;6214.471769899609;4436.13495368413;4496.0558282760985;4522.163399771053;4586.88532786683;4655.06898620284;4628.352030715635;4717.457492388419;4782.187028205144;4806.206975849085;4976.726280054631 23:41:48 INFO - PROCESS | 7757 | |4;prototype.html;281.6732590195372;289.7319979019407;290.1310574828388;290.49598945828996;300.1386022116524;4843.709377437347;4950.405951285851;4992.70043797372;5038.773255203511;5049.444561098277;4788.688735232207;4868.707877527342;4898.4366797818175;4924.556789888909;4943.703377797326;3873.3802591585354;3881;3900.1224724437056;3903.277893589695;3906.9609303907023;3761.924761504782;3839.884803455901;3901.902452438683;3916.9608303917025;3932.193900250442;3875.1087249932534;3878.398848178537;3890.144168282973;3891.299566078105;3891.5135608048995;3860.9189426960497;3865.4974853269177;3867.7099217558793;3875.2443273561667;3892.338302488584;3452.188735647121;3455.289631632333;3467.49721290414;3470.1151206442446;3470.7049900758466;4639.744814035227;4775.904481910377;4822.276658501253;4825.589824864891;4838.564529192355;4417.182821178092;4428.889277768049;4458.9331160032625;4461.576150265752;4464.285714285698;5022.417938349445;5123.359580052494;5142.357205349332;5152.124138896396;5157.8452646420665;3689.7786132831848;3765.717571182145;3776.395776675746;3793.430985352192;3799.4300854871713;5337;5346.599005074596;5348.438413966555;5348.973255133699;5403.729813509309;3736.3461394255896;3748.9437658435145;3748.9690335157507;3758.229562939591;3782.8486860525823;3789.8105094745706;3835.5013848199555;3840.635139661728;3841.116543195081;3842.9239812852447;4263.147370525907;4289.82840686369;4305.590968857953;4343.522212556616;4349.739015659071;5070.847874563769;5094.923576146361;5112.747376892611;5113.590912726973;5118.411382691038;1266.65167079054;1281.8207249330637;1282.8390306772385;1303.1464390824026;1317.5454468208452;934.5934518484481;952.7951490429591;956.3305686019675;960.351762560269;967.685502211784;4519.254323036728;4541.591256786905;4541.841035563805;4552.908941821145;4555.726656400627;5043.293938848564;5231.136862417735;5290.994711004897;5307.52232299095;5310.6723319170205;4527.977360113178;4543.613792827647;4545.272756358967;4550.772461376918;4552.726836389827;2449.978767516806;2478.330850670309;2483.341914392687;2503.5743923532677;2505.8872350743895;4368.584984426474;4383.890402739957;4385.210662080793;4388.232059389594;4701.341812146302;5421.349438067457;5432.891342173134;5461.563074953994;5468.671879687152;5497.51567076887;5089.643724939293;5096.23556466533;5099.36257967754;5103.566196873233;5108.540231379194;5212.50481204285;5273.235380869829;5309.159599614188;5376.301080859464;5385.649932754359;5199.896002080013;5200.375954885287;5214.227162764678;5216.817411390583;5224.58203343724;5018.297438358706;5062;5067.493250674903;5085.288059671723;5114.514121158632;3642.9089272767333;3698.352788262097;3700.389435743072;3714.8699795507027;3733.1973625669525;5317.574594032545;5322.787088516416;5338.786448542171;5339.572834173335;5340.412554618911;5092.898142037065;5135.15269980449;5161.864389834231;5171;5174.404943431403;4950.8762280943265;5113.233015047773;5130.948690513196;5140.871478213075;5147.6911385317;4875.464228767927;5047.444781074152;5050;5061.822836200715;5071.2139618359215;5163.483651634957;5168.095583272837;5173.844784656466;5206.505381988705;5221.712805795718;5050.217216331474;5065.569426598633;5072.51811077947;5077.9238311424615;5086.262491938722 23:41:48 INFO - PROCESS | 7757 | |5;yui.html;658.4633523678202;662.5759513911098;690.658124228507;725.9092613423322;759.0701390796273;11499.482523286451;11777.411129443515;12310.569130080426;12380.380980950962;12464.127511074217;11177.21759476837;11267.830982535268;11302.039326657223;11325.490352934117;11332.036776873976;783.3693876429472;797.6769408389612;800.6797281087553;801.0747586537558;802.2298593350362;777.4363586399871;783.6826085435408;786.1273985875673;786.3237615650536;803.6222975201675;833.6040380819123;838.76933843193;840.5083026429546;840.6805413942693;841.2134654098408;822.0751654388813;832.2883934236262;832.7085520067989;832.7585000349891;832.9583520823965;610.9022556390956;612.0390986151743;612.6079309242089;612.8069658057698;613.8035828534871;12243.93878030613;12286.447109879988;12314.199577027553;12406.56577019809;12441.440135193847;11256.831147532794;11292.717682057932;11301.321920684784;11602.825957610643;11774.587889423914;9659.758506037406;9731.708048758548;9882.752931176707;10769.19231057666;11442.485088171052;4050.3316952702767;4072.409500622423;4097.89755256118;4150.107726838744;4273.529911709709;49355;50340.49659503395;50898.74550627223;50934.72663183413;51707.741461292826;8091.39314551411;9641.758956026155;9714.805703885882;10008.64969726056;10451.84322235167;15270.007449515746;15454.072755634697;15596.220188990505;15746;15985.200739962955;6509.707063182168;6515.804525864137;6545.541812073109;6589.110470086573;6749.392554670005;3578.8926332210076;3585.4084076127147;3621.022323972513;3641.599424063351;3706.610805865399;2731.9726802732116;2793.1201671473423;2831.7734581233453;2842.6020357150014;2985.402919416082;536.7933345661949;537.7660717587862;539.8731298144933;546.137103376664;549.8130635583841;436.9344598310279;479.7505297245413;527.3381905708311;534.7860855657768;546.710243570908;7236.165934311503;7537.623118844036;7630.465867389229;7873;8190.959045204736;568.590614757374;583.3990989281048;586.6714639801725;598.7545106506311;611.3672349118641;3526.947095793565;3734.2344819311975;3738.738288319846;3749.2876353492748;3843.8078096095082;72260;72670.63664681643;73209;73792.26207737855;75730.24269757232;38164;41882.58117418787;59397.40602594005;62850.37149628536;62968;36293.81853090718;38582.80708596439;56127.43872561222;57807.13289300664;58398.41601584015;7094.893576596252;7315.707371705073;7335.4498412618195;7494.5503269803985;7609.6575654094595;39673.40489892712;39703.60296397115;40250.79874600608;40291.1941761169;41136.58863411328;31141.377172456876;31839.6816031846;33101.33797324088;35467.64532354747;35849.283014340086;9404.905950940403;9408.388454750419;9518.381305215138;9661.758456038655;10272.589096436357;11455.770884582429;11644.88355116438;11909.94045029804;12438.875611244133;13018.218906865619;10764.730881727706;11410.486528106088;11518.481668324777;11574.479148438171;11811.645650630495;10650.520726567169;10802.89197108019;11309.982101610894;11323.32060076398;11380.601678941197;10640.463552812498;10645.794911010262;10703.839442408525;10815.188860835311;11226.494807733508;9006.205023491728;9215.354925155174;9450.196733277748;9480.525973701426;9511.66709165176;8869.467831930106;9338.159565639126;9398.953005235204;10090.09189172978;10118.342307749972 23:41:48 INFO - PROCESS | 7757 | __end_tp_report 23:41:48 INFO - PROCESS | 7757 | __start_cc_report 23:41:48 INFO - PROCESS | 7757 | _x_x_mozilla_cycle_collect,329 23:41:48 INFO - PROCESS | 7757 | __end_cc_report 23:41:48 INFO - PROCESS | 7757 | __startTimestamp1477464108846__endTimestamp 23:41:48 INFO - PROCESS | 7757 | 23:41:48 INFO - PROCESS | 7757 | ------- Summary: start ------- 23:41:48 INFO - PROCESS | 7757 | Number of tests: 6 23:41:48 INFO - PROCESS | 7757 | 23:41:48 INFO - PROCESS | 7757 | [#0] dojo.html Cycles:165 Average:4586.84 Median:4730.67 stddev:474.19 (10.0%) stddev-sans-first:449.96 23:41:48 INFO - PROCESS | 7757 | Values: 2624.7 2634.8 2636.3 2640.3 2653.7 4554.1 4602.5 4604.6 4606.0 4641.6 4621.7 4642.5 4647.1 4650.7 4750.7 4246.2 4282.9 4306.4 4331.2 4442.7 3988.5 4377.1 4382.6 4427.8 4429.8 4208.2 4281.6 4288.7 4343.8 4383.8 4242.3 4242.4 4262.3 4281.0 4300.1 4201.6 4215.2 4243.6 4264.8 4273.6 4559.3 4590.3 4599.5 4638.3 4683.9 4904.5 4976.7 4992.0 5000.5 5012.7 4983.4 5021.2 5032.1 5036.4 5067.5 4526.4 4568.2 4673.0 4687.7 4740.6 5028.3 5061.5 5075.1 5094.6 5158.2 4882.9 4893.5 4893.8 4901.7 4956.0 4835.1 4899.5 4975.4 4982.2 4996.7 4823.1 4857.8 4897.1 4924.4 4984.4 4885.2 4893.9 4904.8 4915.0 4971.1 4069.9 4098.2 4106.9 4111.1 4152.4 3617.8 3626.1 3652.8 3676.2 3679.1 4332.8 4349.6 4362.9 4376.9 4396.4 4977.4 4990.8 4991.2 4992.5 5042.0 4224.7 4260.4 4341.8 4363.7 4376.9 4390.2 4404.0 4409.5 4456.4 4463.7 4702.5 4721.9 4730.7 4737.6 4787.2 4879.8 4889.7 4920.6 4971.2 4981.6 4716.7 4718.5 4718.9 4745.5 4757.5 4897.0 4898.8 4899.4 4900.7 4959.6 4832.9 4874.0 4958.6 4974.2 5031.4 4722.1 4753.5 4776.6 4778.1 4838.9 4735.9 4766.2 4770.7 4771.4 4833.9 4672.6 4716.0 4718.2 4746.2 4755.8 4818.0 4851.4 4860.3 4914.1 4918.2 4745.4 4756.0 4763.4 4778.8 4821.3 23:41:48 INFO - PROCESS | 7757 | 23:41:48 INFO - PROCESS | 7757 | [#1] ext.html Cycles:180 Average:46645.40 Median:36115.64 stddev:82223.39 (227.7%) stddev-sans-first:82381.12 23:41:48 INFO - PROCESS | 7757 | Values: 523.8 527.2 544.6 550.7 550.8 37880.0 39691.8 39940.6 40264.8 43684.8 40687.8 40899.4 40926.6 41038.2 41145.2 7636.5 7747.8 7764.0 7767.1 7770.9 7634.8 7719.3 7730.3 7760.6 7783.3 7693.0 7770.9 7787.5 7787.8 7803.3 7717.3 7720.0 7747.5 7785.5 7804.7 7653.5 7744.5 7746.3 7764.9 7770.8 37793.0 37871.8 37899.0 37918.6 38218.2 3058.8 3209.4 3565.8 3571.4 3603.8 28787.9 28900.7 29075.0 29147.0 29283.4 3484.7 3604.6 3653.5 3701.3 3721.4 231350.0 232475.0 233203.0 233459.0 234274.0 51678.5 51800.5 51935.0 52083.0 52145.2 54731.2 55046.0 55081.4 55181.4 55242.0 11329.5 11459.0 11460.6 11516.6 11573.0 9895.4 9972.4 10023.6 10028.9 10034.2 14983.5 16305.3 16420.7 16595.2 16694.2 2946.7 3131.2 5863.9 5921.4 5927.3 805.4 911.0 916.1 964.0 974.1 27024.9 28267.4 28544.9 28764.6 29092.7 993.2 1006.2 1036.5 1043.8 1061.3 15055.1 15086.7 15167.1 15253.5 15262.6 349604.0 354153.0 354287.0 355198.0 357124.0 49756.0 49827.8 50115.0 50223.2 50251.2 1152.6 1175.2 1189.2 1194.6 1206.5 26600.2 27347.3 27774.2 29533.7 30072.8 47196.8 47966.8 47988.5 48076.0 48090.5 333262.0 336810.0 337906.0 338034.0 339300.0 24425.8 25478.9 38009.6 38406.0 38566.4 41145.6 41358.6 41793.4 42096.8 42472.0 33678.0 34238.0 35273.5 36114.6 36360.6 35286.0 35659.1 35707.0 35812.5 36031.0 34756.3 34767.3 35422.6 35906.8 36116.6 30097.4 32282.2 32697.5 32795.8 32895.7 24979.1 25242.9 25286.6 25513.4 25544.9 23:41:48 INFO - PROCESS | 7757 | 23:41:48 INFO - PROCESS | 7757 | [#2] jquery.html Cycles:180 Average:23044.27 Median:5388.64 stddev:60068.34 (1114.7%) stddev-sans-first:60212.69 23:41:48 INFO - PROCESS | 7757 | Values: 357.3 363.8 364.9 377.9 385.1 15594.1 16993.5 17285.1 17421.8 17422.0 15651.8 16448.7 16855.2 16944.6 16997.8 4802.7 5035.9 5069.1 5078.8 5079.8 4967.5 5221.0 5491.8 5555.6 5592.1 5486.2 5538.1 5546.9 5602.1 5608.5 5388.5 5515.2 5581.2 5589.4 5593.5 5237.3 5388.8 5389.5 5400.3 5402.7 12180.3 12478.6 12534.8 12536.1 12540.5 1839.6 1867.9 2044.7 2164.7 2276.5 9035.8 9048.2 9128.2 9623.1 9670.8 1627.6 1646.4 1693.1 1695.3 1743.9 57021.4 61296.7 65285.3 65322.7 66531.0 9737.8 9803.7 9912.6 9955.0 10090.8 13597.2 13612.7 13657.2 13663.3 13699.6 6953.2 6959.4 7047.5 7077.4 7092.0 6218.4 6290.0 6314.0 6742.7 6749.7 4093.4 4202.9 4226.0 4350.9 4363.5 1615.9 1688.5 1725.4 1734.7 1842.3 858.7 889.0 896.6 924.1 946.7 15322.8 15853.5 16340.3 16824.7 16856.4 812.8 839.8 846.6 866.7 878.6 8808.6 9197.4 9406.7 10137.8 10229.4 358973.0 361727.0 363684.0 364335.0 364975.0 76524.0 78590.6 78800.0 79816.6 80300.6 946.4 954.7 972.3 974.3 976.7 15285.7 15328.0 15450.3 15685.8 16027.8 35460.3 35808.6 36719.6 37064.4 37495.8 46914.0 50720.7 50988.2 52681.7 54172.5 6918.0 7233.0 7328.5 7403.9 7596.7 8010.2 9545.7 10955.6 11097.3 12151.0 9499.0 9572.4 9829.6 10075.6 10400.3 9773.7 9780.0 9962.5 10049.8 10118.3 9793.9 9911.8 10185.0 10308.0 10338.5 7075.5 7254.9 7308.9 7375.3 7534.2 9047.8 9145.0 9215.3 9261.0 9343.8 23:41:48 INFO - PROCESS | 7757 | 23:41:48 INFO - PROCESS | 7757 | [#3] mootools.html Cycles:180 Average:4838.71 Median:5316.23 stddev:2677.01 (50.4%) stddev-sans-first:2671.73 23:41:48 INFO - PROCESS | 7757 | Values: 1356.5 1376.2 1467.5 1647.2 1667.1 6166.7 6335.1 6962.3 7399.6 7448.8 6950.7 7183.4 7193.9 7379.4 7394.0 2063.1 2085.6 2089.8 2091.9 2092.8 2062.7 2099.9 2109.1 2110.1 2111.0 2015.5 2029.6 2036.6 2037.8 2052.1 2044.2 2049.4 2060.5 2061.7 2063.5 1977.4 2013.3 2024.2 2041.0 2048.5 7102.5 7178.2 7192.2 7265.5 7295.1 4221.5 4345.2 4346.5 4350.4 4353.1 2510.0 2681.0 2701.9 2715.2 2742.2 841.3 877.5 885.9 902.6 909.4 9697.4 9712.8 9736.0 9760.6 9812.8 3713.9 3859.7 3920.5 3925.8 3987.5 8340.4 8349.7 8350.4 8353.1 8356.3 4330.8 4346.4 4347.8 4350.3 4354.5 3407.9 3512.3 3831.8 3988.4 3993.6 3196.3 3234.7 3314.3 3329.2 3371.9 1093.3 1100.6 1102.3 1104.5 1115.4 852.3 860.7 862.5 870.7 887.3 5046.8 5113.2 5156.3 5257.6 5263.7 375.4 408.8 410.8 412.5 419.0 3512.3 3532.9 3543.3 3565.5 3649.4 8900.3 9164.1 9188.9 9253.3 9273.8 9085.8 9088.7 9099.3 9112.0 9112.8 6680.5 6943.5 6976.7 6979.6 7070.7 5228.2 5368.8 5387.8 5445.8 5471.5 7794.4 7962.2 8035.7 8195.8 8368.3 7997.1 8129.3 8161.8 8267.3 8309.5 6802.4 6843.8 6878.6 6907.3 6910.3 6898.2 7023.7 7035.4 7040.5 7041.7 6201.4 6281.4 6309.6 6439.2 6455.0 6071.2 6205.6 6286.2 6310.1 6341.3 6078.3 6192.5 6208.3 6208.8 6214.5 4436.1 4496.1 4522.2 4586.9 4655.1 4628.4 4717.5 4782.2 4806.2 4976.7 23:41:48 INFO - PROCESS | 7757 | 23:41:48 INFO - PROCESS | 7757 | [#4] prototype.html Cycles:180 Average:4272.16 Median:4841.14 stddev:1244.87 (25.7%) stddev-sans-first:1211.79 23:41:48 INFO - PROCESS | 7757 | Values: 281.7 289.7 290.1 290.5 300.1 4843.7 4950.4 4992.7 5038.8 5049.4 4788.7 4868.7 4898.4 4924.6 4943.7 3873.4 3881.0 3900.1 3903.3 3907.0 3761.9 3839.9 3901.9 3917.0 3932.2 3875.1 3878.4 3890.1 3891.3 3891.5 3860.9 3865.5 3867.7 3875.2 3892.3 3452.2 3455.3 3467.5 3470.1 3470.7 4639.7 4775.9 4822.3 4825.6 4838.6 4417.2 4428.9 4458.9 4461.6 4464.3 5022.4 5123.4 5142.4 5152.1 5157.8 3689.8 3765.7 3776.4 3793.4 3799.4 5337.0 5346.6 5348.4 5349.0 5403.7 3736.3 3748.9 3749.0 3758.2 3782.8 3789.8 3835.5 3840.6 3841.1 3842.9 4263.1 4289.8 4305.6 4343.5 4349.7 5070.8 5094.9 5112.7 5113.6 5118.4 1266.7 1281.8 1282.8 1303.1 1317.5 934.6 952.8 956.3 960.4 967.7 4519.3 4541.6 4541.8 4552.9 4555.7 5043.3 5231.1 5291.0 5307.5 5310.7 4528.0 4543.6 4545.3 4550.8 4552.7 2450.0 2478.3 2483.3 2503.6 2505.9 4368.6 4383.9 4385.2 4388.2 4701.3 5421.3 5432.9 5461.6 5468.7 5497.5 5089.6 5096.2 5099.4 5103.6 5108.5 5212.5 5273.2 5309.2 5376.3 5385.6 5199.9 5200.4 5214.2 5216.8 5224.6 5018.3 5062.0 5067.5 5085.3 5114.5 3642.9 3698.4 3700.4 3714.9 3733.2 5317.6 5322.8 5338.8 5339.6 5340.4 5092.9 5135.2 5161.9 5171.0 5174.4 4950.9 5113.2 5130.9 5140.9 5147.7 4875.5 5047.4 5050.0 5061.8 5071.2 5163.5 5168.1 5173.8 5206.5 5221.7 5050.2 5065.6 5072.5 5077.9 5086.3 23:41:48 INFO - PROCESS | 7757 | 23:41:48 INFO - PROCESS | 7757 | [#5] yui.html Cycles:180 Average:13864.54 Median:50916.74 stddev:17742.98 (34.8%) stddev-sans-first:17765.04 23:41:48 INFO - PROCESS | 7757 | Values: 658.5 662.6 690.7 725.9 759.1 11499.5 11777.4 12310.6 12380.4 12464.1 11177.2 11267.8 11302.0 11325.5 11332.0 783.4 797.7 800.7 801.1 802.2 777.4 783.7 786.1 786.3 803.6 833.6 838.8 840.5 840.7 841.2 822.1 832.3 832.7 832.8 833.0 610.9 612.0 612.6 612.8 613.8 12243.9 12286.4 12314.2 12406.6 12441.4 11256.8 11292.7 11301.3 11602.8 11774.6 9659.8 9731.7 9882.8 10769.2 11442.5 4050.3 4072.4 4097.9 4150.1 4273.5 49355.0 50340.5 50898.7 50934.7 51707.7 8091.4 9641.8 9714.8 10008.6 10451.8 15270.0 15454.1 15596.2 15746.0 15985.2 6509.7 6515.8 6545.5 6589.1 6749.4 3578.9 3585.4 3621.0 3641.6 3706.6 2732.0 2793.1 2831.8 2842.6 2985.4 536.8 537.8 539.9 546.1 549.8 436.9 479.8 527.3 534.8 546.7 7236.2 7537.6 7630.5 7873.0 8191.0 568.6 583.4 586.7 598.8 611.4 3526.9 3734.2 3738.7 3749.3 3843.8 72260.0 72670.6 73209.0 73792.3 75730.2 38164.0 41882.6 59397.4 62850.4 62968.0 36293.8 38582.8 56127.4 57807.1 58398.4 7094.9 7315.7 7335.4 7494.6 7609.7 39673.4 39703.6 40250.8 40291.2 41136.6 31141.4 31839.7 33101.3 35467.6 35849.3 9404.9 9408.4 9518.4 9661.8 10272.6 11455.8 11644.9 11909.9 12438.9 13018.2 10764.7 11410.5 11518.5 11574.5 11811.6 10650.5 10802.9 11310.0 11323.3 11380.6 10640.5 10645.8 10703.8 10815.2 11226.5 9006.2 9215.4 9450.2 9480.5 9511.7 8869.5 9338.2 9399.0 10090.1 10118.3 23:41:48 INFO - PROCESS | 7757 | -------- Summary: end -------- 23:41:48 INFO - PROCESS | 7757 | 23:41:49 INFO - TEST-INFO | 7757: exit 0 23:41:49 INFO - TEST-OK | dromaeo_css | took 1119784ms 23:41:49 INFO - TEST-START | kraken 23:41:49 INFO - operating with platform_type : linux_ 23:41:49 INFO - Initialising browser for kraken test... 23:41:49 INFO - TEST-INFO | started process 8115 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmph0rzBb/profile http://localhost:49010/getInfo.html) 23:41:54 INFO - PROCESS | 8115 | __metrics Screen width/height:1600/1200 23:41:54 INFO - PROCESS | 8115 | colorDepth:24 23:41:54 INFO - PROCESS | 8115 | Browser inner width/height: 1024/697 23:41:54 INFO - PROCESS | 8115 | __metrics 23:41:55 ERROR - PROCESS | 8115 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3097: TypeError: this.tabs is undefined 23:41:56 INFO - TEST-INFO | 8115: exit 0 23:41:56 INFO - Browser initialized. 23:41:56 INFO - Running cycle 1/1 for kraken test... 23:41:56 INFO - TEST-INFO | started process 8238 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmph0rzBb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:42:08 INFO - PROCESS | 8238 | RSS: Main: 183767040 23:42:08 INFO - PROCESS | 8238 | 23:42:11 INFO - PROCESS | 8238 | Cycle 1(1): loaded http://localhost:49010/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49010/tests/kraken/driver.html?testName=audio-beat-detection) 23:42:12 INFO - PROCESS | 8238 | RSS: Main: 196530176 23:42:12 INFO - PROCESS | 8238 | 23:42:15 INFO - PROCESS | 8238 | Cycle 1(1): loaded http://localhost:49010/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49010/tests/kraken/driver.html?testName=audio-dft) 23:42:16 INFO - PROCESS | 8238 | RSS: Main: 195088384 23:42:16 INFO - PROCESS | 8238 | 23:42:19 INFO - PROCESS | 8238 | Cycle 1(1): loaded http://localhost:49010/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49010/tests/kraken/driver.html?testName=audio-fft) 23:42:19 INFO - PROCESS | 8238 | RSS: Main: 191852544 23:42:19 INFO - PROCESS | 8238 | 23:42:21 INFO - PROCESS | 8238 | Cycle 1(1): loaded http://localhost:49010/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49010/tests/kraken/driver.html?testName=audio-oscillator) 23:42:22 INFO - PROCESS | 8238 | RSS: Main: 192135168 23:42:22 INFO - PROCESS | 8238 | 23:42:24 INFO - PROCESS | 8238 | Cycle 1(1): loaded http://localhost:49010/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49010/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:42:25 INFO - PROCESS | 8238 | RSS: Main: 192540672 23:42:25 INFO - PROCESS | 8238 | 23:42:28 INFO - PROCESS | 8238 | Cycle 1(1): loaded http://localhost:49010/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49010/tests/kraken/driver.html?testName=imaging-darkroom) 23:42:29 INFO - PROCESS | 8238 | RSS: Main: 193183744 23:42:29 INFO - PROCESS | 8238 | 23:42:32 INFO - PROCESS | 8238 | Cycle 1(1): loaded http://localhost:49010/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49010/tests/kraken/driver.html?testName=imaging-desaturate) 23:42:33 INFO - PROCESS | 8238 | RSS: Main: 191078400 23:42:33 INFO - PROCESS | 8238 | 23:42:36 INFO - PROCESS | 8238 | Cycle 1(1): loaded http://localhost:49010/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49010/tests/kraken/driver.html?testName=json-parse-financial) 23:42:36 INFO - PROCESS | 8238 | RSS: Main: 191836160 23:42:36 INFO - PROCESS | 8238 | 23:42:38 INFO - PROCESS | 8238 | Cycle 1(1): loaded http://localhost:49010/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49010/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:42:39 INFO - PROCESS | 8238 | RSS: Main: 191496192 23:42:39 INFO - PROCESS | 8238 | 23:42:41 INFO - PROCESS | 8238 | Cycle 1(1): loaded http://localhost:49010/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49010/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:42:41 INFO - PROCESS | 8238 | RSS: Main: 191471616 23:42:41 INFO - PROCESS | 8238 | 23:42:43 INFO - PROCESS | 8238 | Cycle 1(1): loaded http://localhost:49010/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49010/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:42:44 INFO - PROCESS | 8238 | RSS: Main: 191991808 23:42:44 INFO - PROCESS | 8238 | 23:42:47 INFO - PROCESS | 8238 | Cycle 1(1): loaded http://localhost:49010/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49010/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:42:48 INFO - PROCESS | 8238 | RSS: Main: 192811008 23:42:48 INFO - PROCESS | 8238 | 23:42:51 INFO - PROCESS | 8238 | Cycle 1(1): loaded http://localhost:49010/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49010/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:42:51 INFO - PROCESS | 8238 | RSS: Main: 192483328 23:42:51 INFO - PROCESS | 8238 | 23:42:53 INFO - PROCESS | 8238 | Cycle 1(1): loaded http://localhost:49010/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49010/tests/kraken/driver.html?testName=ai-astar) 23:42:53 INFO - PROCESS | 8238 | RSS: Main: 195371008 23:42:53 INFO - PROCESS | 8238 | 23:42:53 INFO - PROCESS | 8238 | __start_tp_report 23:42:53 INFO - PROCESS | 8238 | _x_x_mozilla_page_load 23:42:53 INFO - PROCESS | 8238 | _x_x_mozilla_page_load_details 23:42:53 INFO - PROCESS | 8238 | |i|pagename|runs| 23:42:53 INFO - PROCESS | 8238 | |0;ai-astar;108;116;114;114;115;115;114;118;117;115 23:42:53 INFO - PROCESS | 8238 | |1;audio-beat-detection;157;134;130;166;130;131;129;131;165;131 23:42:53 INFO - PROCESS | 8238 | |2;audio-dft;178;164;163;166;163;164;163;165;165;163 23:42:53 INFO - PROCESS | 8238 | |3;audio-fft;77;77;77;109;76;79;76;77;100;81 23:42:53 INFO - PROCESS | 8238 | |4;audio-oscillator;83;83;111;84;85;84;104;84;84;116 23:42:53 INFO - PROCESS | 8238 | |5;imaging-gaussian-blur;118;120;120;120;120;119;118;117;118;117 23:42:53 INFO - PROCESS | 8238 | |6;imaging-darkroom;147;147;148;147;150;148;147;148;148;147 23:42:53 INFO - PROCESS | 8238 | |7;imaging-desaturate;85;86;85;85;84;86;86;86;85;85 23:42:53 INFO - PROCESS | 8238 | |8;json-parse-financial;64;64;64;65;65;69;66;64;64;64 23:42:53 INFO - PROCESS | 8238 | |9;json-stringify-tinderbox;66;67;67;67;66;67;67;66;66;66 23:42:53 INFO - PROCESS | 8238 | |10;stanford-crypto-aes;85;85;84;94;92;84;95;88;83;85 23:42:53 INFO - PROCESS | 8238 | |11;stanford-crypto-ccm;146;154;153;144;145;152;143;149;181;148 23:42:53 INFO - PROCESS | 8238 | |12;stanford-crypto-pbkdf2;179;181;182;180;179;181;190;182;177;180 23:42:53 INFO - PROCESS | 8238 | |13;stanford-crypto-sha256-iterative;73;71;74;75;71;74;73;70;73;77 23:42:53 INFO - PROCESS | 8238 | __end_tp_report 23:42:53 INFO - PROCESS | 8238 | __start_cc_report 23:42:53 INFO - PROCESS | 8238 | _x_x_mozilla_cycle_collect,873 23:42:53 INFO - PROCESS | 8238 | __end_cc_report 23:42:53 INFO - PROCESS | 8238 | __startTimestamp1477464173956__endTimestamp 23:42:53 INFO - PROCESS | 8238 | 23:42:53 INFO - PROCESS | 8238 | ------- Summary: start ------- 23:42:53 INFO - PROCESS | 8238 | Number of tests: 14 23:42:53 INFO - PROCESS | 8238 | 23:42:53 INFO - PROCESS | 8238 | [#0] ai-astar Cycles:10 Average:114.60 Median:115.00 stddev:2.67 (2.3%) stddev-sans-first:1.41 23:42:53 INFO - PROCESS | 8238 | Values: 108.0 116.0 114.0 114.0 115.0 115.0 114.0 118.0 117.0 115.0 23:42:53 INFO - PROCESS | 8238 | 23:42:53 INFO - PROCESS | 8238 | [#1] audio-beat-detection Cycles:10 Average:140.40 Median:132.50 stddev:15.59 (11.8%) stddev-sans-first:15.34 23:42:53 INFO - PROCESS | 8238 | Values: 157.0 134.0 130.0 166.0 130.0 131.0 129.0 131.0 165.0 131.0 23:42:53 INFO - PROCESS | 8238 | 23:42:53 INFO - PROCESS | 8238 | [#2] audio-dft Cycles:10 Average:165.40 Median:164.50 stddev:4.55 (2.8%) stddev-sans-first:1.12 23:42:53 INFO - PROCESS | 8238 | Values: 178.0 164.0 163.0 166.0 163.0 164.0 163.0 165.0 165.0 163.0 23:42:53 INFO - PROCESS | 8238 | 23:42:53 INFO - PROCESS | 8238 | [#3] audio-fft Cycles:10 Average:82.90 Median:77.00 stddev:11.68 (15.2%) stddev-sans-first:12.19 23:42:53 INFO - PROCESS | 8238 | Values: 77.0 77.0 77.0 109.0 76.0 79.0 76.0 77.0 100.0 81.0 23:42:53 INFO - PROCESS | 8238 | 23:42:53 INFO - PROCESS | 8238 | [#4] audio-oscillator Cycles:10 Average:91.80 Median:84.00 stddev:13.11 (15.6%) stddev-sans-first:13.52 23:42:53 INFO - PROCESS | 8238 | Values: 83.0 83.0 111.0 84.0 85.0 84.0 104.0 84.0 84.0 116.0 23:42:53 INFO - PROCESS | 8238 | 23:42:53 INFO - PROCESS | 8238 | [#5] imaging-gaussian-blur Cycles:10 Average:118.70 Median:119.50 stddev:1.25 (1.0%) stddev-sans-first:1.30 23:42:53 INFO - PROCESS | 8238 | Values: 118.0 120.0 120.0 120.0 120.0 119.0 118.0 117.0 118.0 117.0 23:42:53 INFO - PROCESS | 8238 | 23:42:53 INFO - PROCESS | 8238 | [#6] imaging-darkroom Cycles:10 Average:147.70 Median:148.00 stddev:0.95 (0.6%) stddev-sans-first:0.97 23:42:53 INFO - PROCESS | 8238 | Values: 147.0 147.0 148.0 147.0 150.0 148.0 147.0 148.0 148.0 147.0 23:42:53 INFO - PROCESS | 8238 | 23:42:53 INFO - PROCESS | 8238 | [#7] imaging-desaturate Cycles:10 Average:85.30 Median:85.50 stddev:0.67 (0.8%) stddev-sans-first:0.71 23:42:53 INFO - PROCESS | 8238 | Values: 85.0 86.0 85.0 85.0 84.0 86.0 86.0 86.0 85.0 85.0 23:42:53 INFO - PROCESS | 8238 | 23:42:53 INFO - PROCESS | 8238 | [#8] json-parse-financial Cycles:10 Average:64.90 Median:64.50 stddev:1.60 (2.5%) stddev-sans-first:1.66 23:42:53 INFO - PROCESS | 8238 | Values: 64.0 64.0 64.0 65.0 65.0 69.0 66.0 64.0 64.0 64.0 23:42:53 INFO - PROCESS | 8238 | 23:42:53 INFO - PROCESS | 8238 | [#9] json-stringify-tinderbox Cycles:10 Average:66.50 Median:67.00 stddev:0.53 (0.8%) stddev-sans-first:0.53 23:42:53 INFO - PROCESS | 8238 | Values: 66.0 67.0 67.0 67.0 66.0 67.0 67.0 66.0 66.0 66.0 23:42:53 INFO - PROCESS | 8238 | 23:42:53 INFO - PROCESS | 8238 | [#10] stanford-crypto-aes Cycles:10 Average:87.50 Median:86.50 stddev:4.50 (5.2%) stddev-sans-first:4.68 23:42:53 INFO - PROCESS | 8238 | Values: 85.0 85.0 84.0 94.0 92.0 84.0 95.0 88.0 83.0 85.0 23:42:53 INFO - PROCESS | 8238 | 23:42:53 INFO - PROCESS | 8238 | [#11] stanford-crypto-ccm Cycles:10 Average:151.50 Median:150.50 stddev:11.05 (7.3%) stddev-sans-first:11.54 23:42:53 INFO - PROCESS | 8238 | Values: 146.0 154.0 153.0 144.0 145.0 152.0 143.0 149.0 181.0 148.0 23:42:53 INFO - PROCESS | 8238 | 23:42:53 INFO - PROCESS | 8238 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:181.10 Median:181.00 stddev:3.48 (1.9%) stddev-sans-first:3.61 23:42:53 INFO - PROCESS | 8238 | Values: 179.0 181.0 182.0 180.0 179.0 181.0 190.0 182.0 177.0 180.0 23:42:53 INFO - PROCESS | 8238 | 23:42:53 INFO - PROCESS | 8238 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.10 Median:73.50 stddev:2.08 (2.8%) stddev-sans-first:2.20 23:42:53 INFO - PROCESS | 8238 | Values: 73.0 71.0 74.0 75.0 71.0 74.0 73.0 70.0 73.0 77.0 23:42:53 INFO - PROCESS | 8238 | -------- Summary: end -------- 23:42:53 INFO - PROCESS | 8238 | 23:42:55 INFO - TEST-INFO | 8238: exit 0 23:42:55 INFO - TEST-OK | kraken | took 65327ms 23:42:55 INFO - SUITE-END | took 1185s 23:42:55 INFO - Completed test suite (00:19:45) 23:42:55 INFO - javascript benchmark 23:42:55 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6188.7238186724135, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2624.7244039375855, 2634.84190948543, 2636.301380134264, 2640.3003204150905, 2653.6948250951136, 4554.089182163564, 4602.516735742741, 4604.631629469639, 4606.009707912798, 4641.6054635355995, 4621.676482646216, 4642.512536183703, 4647.070585882829, 4650.651201159918, 4750.7149571025675, 4246.2356775780345, 4282.850100246492, 4306.397104405386, 4331.198728235287, 4442.689011769177, 3988.501437320335, 4377.058932329549, 4382.561743825608, 4427.845025424111, 4429.844955426561, 4208.158368326316, 4281.614654681062, 4288.656907447396, 4343.761093139876, 4383.802728877208, 4242.342436922282, 4242.406063151161, 4262.296721041024, 4281.0, 4300.09697963425, 4201.621854033121, 4215.220184265921, 4243.596858298457, 4264.765437900915, 4273.572642735701, 4559.3388958601145, 4590.311453282035, 4599.517050709695, 4638.257878739386, 4683.88290292742, 4904.485029071968, 4976.701397916137, 4992.0, 5000.499950005007, 5012.6966988583235, 4983.426905905795, 5021.221710634857, 5032.069067222539, 5036.370453693288, 5067.543921047123, 4526.366308716782, 4568.223402021665, 4672.953270467286, 4687.67186296956, 4740.644451666139, 5028.321176641107, 5061.493850614909, 5075.111855425286, 5094.643374963791, 5158.226266060121, 4882.8779280517565, 4893.4617192108835, 4893.828715994923, 4901.730404827768, 4956.0, 4835.0571638530855, 4899.510048995072, 4975.378077740283, 4982.177940639754, 4996.675216110941, 4823.131836269435, 4857.80568777252, 4897.14299997499, 4924.384451943507, 4984.42679091909, 4885.169521181408, 4893.926591101136, 4904.8038078477175, 4914.992426552548, 4971.055499455092, 4069.877903662895, 4098.241825262336, 4106.897327566775, 4111.1366613011005, 4152.397902304209, 3617.764845285048, 3626.0572251214876, 3652.7990960496895, 3676.246369494247, 3679.1170119171743, 4332.826686932487, 4349.565043495625, 4362.890927726832, 4376.934345984812, 4396.428464299621, 4977.352944117241, 4990.800367985313, 4991.226359914219, 4992.475790042066, 5041.974790126026, 4224.704270701083, 4260.44614200152, 4341.782910854445, 4363.672724545671, 4376.9124617508105, 4390.1878152541885, 4404.009097952935, 4409.49290831552, 4456.376107344974, 4463.732176069446, 4702.482726900107, 4721.858344249678, 4730.668853180313, 4737.644676649334, 4787.186178349759, 4879.829205977774, 4889.657723959289, 4920.6063514918005, 4971.229459433794, 4981.551660350441, 4716.693414928019, 4718.504557021463, 4718.929216061693, 4745.501722319107, 4757.524247575215, 4897.020595880766, 4898.804047838046, 4899.412070551557, 4900.70595764241, 4959.62802789785, 4832.9275060873415, 4873.95126048735, 4958.603311734981, 4974.228994505857, 5031.446540880427, 4722.079194557028, 4753.47711751714, 4776.641751868554, 4778.068276686013, 4838.927416088691, 4735.857924262277, 4766.213574760126, 4770.713757174581, 4771.355866958055, 4833.903321933612, 4672.556107169813, 4716.033213191219, 4718.245080787057, 4746.1694203514935, 4755.7859896305445, 4817.975910120427, 4851.369321988119, 4860.295257187759, 4914.115459217375, 4918.2376731606655, 4745.359376484131, 4756.0, 4763.3807605011125, 4778.832740854054, 4821.276808478756], "value": 4557.248451691047, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [523.777394607292, 527.1723394270996, 544.6350944866939, 550.7383992603517, 550.7769353411868, 37880.0, 39691.80154099229, 39940.60059399405, 40264.79867600665, 43684.78157609208, 40687.79656101715, 40899.386509202384, 40926.59073409265, 41038.17923641526, 41145.17709645805, 7636.465447418683, 7747.767566973, 7764.0, 7767.067951845758, 7770.883436748453, 7634.809129771772, 7719.305262526372, 7730.342920851706, 7760.57316847576, 7783.260590243946, 7692.961535192344, 7770.9222907771045, 7787.493812902171, 7787.844243115134, 7803.258690424401, 7717.344025757818, 7719.9614001930195, 7747.535147891144, 7785.455018148732, 7804.687812487494, 7653.540787552764, 7744.496607720536, 7746.341560967325, 7764.883526747103, 7770.844583108363, 37793.0, 37871.8106409469, 37899.0, 37918.62081379206, 38218.23563528742, 3058.8470576471086, 3209.3581283743347, 3565.7682250653625, 3571.428571428559, 3603.837827297778, 28787.856060719772, 28900.710992890014, 29075.0, 29147.0, 29283.41433171346, 3484.6689564491335, 3604.5854726706502, 3653.50677658518, 3701.2782507411066, 3721.404575267944, 231350.0, 232475.0, 233203.0, 233459.0, 234274.0, 51678.48321516812, 51800.48199518032, 51935.0, 52083.0, 52145.2178217327, 54731.17903231455, 55046.0, 55081.449185507634, 55181.448185518435, 55242.0, 11329.546818127183, 11459.0, 11460.624725032883, 11516.596919107791, 11572.958433740836, 9895.356801807859, 9972.401655900669, 10023.599056037678, 10028.949855250678, 10034.24743144267, 14983.475578354706, 16305.347786088661, 16420.671586568442, 16595.17024148788, 16694.165291735608, 2946.720061594145, 3131.2171957010746, 5863.882722345529, 5921.437463440966, 5927.347991720907, 805.3879051920466, 910.9863352049724, 916.1434059154578, 963.9710808675751, 974.0989584634185, 27024.86487567589, 28267.43465130686, 28544.85727571349, 28764.568531472043, 29092.709072909, 993.2004736187295, 1006.2101250518308, 1036.533559898049, 1043.796459690353, 1061.3048453263125, 15055.096694198164, 15086.698266034837, 15167.089974601558, 15253.542393728207, 15262.618434539003, 349604.0, 354153.0, 354287.0, 355198.0, 357124.0, 49756.0, 49827.75086124619, 50115.0, 50223.24665130026, 50251.24623130656, 1152.608113241502, 1175.1773758369177, 1189.191349882071, 1194.6416075177585, 1206.5053328135423, 26600.201993940213, 27347.31631709223, 27774.166774996782, 29533.704662953096, 30072.84963575256, 47196.7640161797, 47966.76016620034, 47988.5201147998, 48076.0, 48090.5190948086, 333262.0, 336810.0, 337906.0, 338034.0, 339300.0, 24425.75574244306, 25478.872605637596, 38009.61990380061, 38406.0, 38566.42150367803, 41145.58854411537, 41358.58641413668, 41793.373099402925, 42096.789516052224, 42472.0, 33678.0, 34238.0, 35273.47089793604, 36114.638853611126, 36360.636393636785, 35286.0, 35659.10852228715, 35707.0, 35812.462813058344, 36031.0, 34756.30487390289, 34767.30465390729, 35422.645773542965, 35906.8204658975, 36116.63883361133, 30097.398052039276, 32282.19294517562, 32697.509537356484, 32795.83602081974, 32895.67104328926, 24979.125730599342, 25242.873785630953, 25286.620700689873, 25513.362165946, 25544.872275638503], "value": 17315.667705290703, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [357.26938410949606, 363.8180909545227, 364.9361361761692, 377.91685829117586, 385.10463173122497, 15594.064356138626, 16993.490195294147, 17285.135743212853, 17421.82578174218, 17422.0, 15651.765223521628, 16448.67102657946, 16855.157242137873, 16944.576385590368, 16997.830021699778, 4802.687825291354, 5035.899282014358, 5069.112905241586, 5078.771455284503, 5079.771410286546, 4967.528084831935, 5220.973895130538, 5491.780328786864, 5555.611107222496, 5592.07730724432, 5486.204500347447, 5538.086215774392, 5546.91679624806, 5602.1036634138545, 5608.495235428811, 5388.488093631118, 5515.227868098469, 5581.2186293918885, 5589.413111623262, 5593.496585307322, 5237.3453318335205, 5388.78444862205, 5389.541888939445, 5400.324959380077, 5402.6758394496455, 12180.330081845495, 12478.625641230778, 12534.81197782034, 12536.122471427003, 12540.498380064877, 1839.6412699523598, 1867.9252829886789, 2044.7341845559981, 2164.722813540019, 2276.5333106713083, 9035.819283614357, 9048.230900373475, 9128.178463938277, 9623.085806848338, 9670.75823104421, 1627.593101724569, 1646.3579204110288, 1693.119577819527, 1695.2710334556136, 1743.8779285450023, 57021.42978570203, 61296.69351653258, 65285.3471465284, 65322.673386633236, 66531.0, 9737.805243895082, 9803.656872009446, 9912.56267841159, 9955.0, 10090.848637270446, 13597.184168949894, 13612.727745445234, 13657.248851313074, 13663.316834158451, 13699.589012329647, 6953.155625244943, 6959.4432445404245, 7047.471439642048, 7077.433805295564, 7091.964540177266, 6218.409251121137, 6289.96855015722, 6313.968430157912, 6742.662866856637, 6749.696263668048, 4093.385992101149, 4202.915941681149, 4226.0, 4350.869473915787, 4363.5418281080665, 1615.8626516745974, 1688.5440930948575, 1725.4306078993902, 1734.670412621598, 1842.2815102110187, 858.6822875536092, 888.9911100889037, 896.6010125494223, 924.0805398628407, 946.668665966906, 15322.79614802206, 15853.52439426819, 16340.346386144658, 16824.66350673004, 16856.41002564929, 812.8414959083041, 839.8278352937633, 846.6359465429802, 866.7399780065955, 878.5958459108881, 8808.603612837438, 9197.448153110834, 9406.670766523139, 10137.797244055078, 10229.386236825814, 358973.0, 361727.0, 363684.0, 364335.0, 364975.0, 76524.0, 78590.56913170456, 78800.0, 79816.60091699504, 80300.59849700831, 946.4415994563241, 954.7231302922074, 972.3193764364972, 974.2692980264801, 976.7411635916487, 15285.694286113992, 15328.0, 15450.30473628667, 15685.764713529534, 16027.759583606488, 35460.29079418449, 35808.641913581574, 36719.63280367162, 37064.44403333898, 37495.81252093722, 46914.0, 50720.74639626778, 50988.235176471644, 52681.73659131833, 54172.45827541674, 6918.0, 7232.963835180791, 7328.523645962995, 7403.925960740324, 7596.658150383136, 8010.239027292398, 9545.665901693685, 10955.616553420592, 11097.278676885977, 12151.0, 9498.965548259433, 9572.425654460754, 9829.606815727577, 10075.596976120873, 10400.323978941344, 9773.657921972697, 9780.0, 9962.452065136487, 10049.849252261076, 10118.291719579558, 9793.902060979584, 9911.801763964824, 10185.032421919906, 10308.0, 10338.534765935701, 7075.5047146699235, 7254.875494298392, 7308.853822923618, 7375.262473752582, 7534.171241163577, 9047.773805654648, 9145.0, 9215.2627789778, 9260.953695231481, 9343.813123737624], "value": 7942.211105742875, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1356.5116558039108, 1376.1949259683086, 1467.4790449390466, 1647.1599484263022, 1667.0914351678327, 6166.691665416723, 6335.081413195084, 6962.338577835104, 7399.556026638399, 7448.813779655511, 6950.6524673766235, 7183.353498185163, 7193.85612287754, 7379.409647228223, 7394.038774959261, 2063.143795324942, 2085.6037352902977, 2089.8014688604635, 2091.874487530753, 2092.769795322521, 2062.7009083682856, 2099.9055042523046, 2109.050927082811, 2110.1453911166004, 2111.0, 2015.5263513074415, 2029.6346657601625, 2036.6130435217262, 2037.8471614628888, 2052.0663098290242, 2044.2231951858273, 2049.4466494046524, 2060.453979695382, 2061.7319748432756, 2063.525389160494, 1977.3870100268819, 2013.3054096336741, 2024.2409096588779, 2040.9795902040937, 2048.549319149785, 7102.467314951347, 7178.2103968563415, 7192.208857025723, 7265.527740696838, 7295.0516432863915, 4221.493420789494, 4345.174416860818, 4346.456692913386, 4350.434443522322, 4353.1293741251875, 2509.962350564743, 2680.973190268092, 2701.932451688704, 2715.1854443667016, 2742.1773467959533, 841.2722994609679, 877.4954401219261, 885.9379843410964, 902.596462500811, 909.4452384045727, 9697.369670971435, 9712.75718107046, 9736.0, 9760.609575616967, 9812.754681133028, 3713.88858334245, 3859.6526312632, 3920.5295364555864, 3925.823337949799, 3987.5414327352146, 8340.37447191463, 8349.749507514784, 8350.415470916978, 8353.081161072278, 8356.289715374262, 4330.783460826946, 4346.413234213404, 4347.826086956549, 4350.32569951658, 4354.4992325882295, 3407.9148021299666, 3512.332656795201, 3831.7700937943814, 3988.3818008208773, 3993.6206060424215, 3196.3447493263825, 3234.741220702338, 3314.2931390333997, 3329.217633856042, 3371.8651253950056, 1093.2893619147617, 1100.5707773968159, 1102.2945314998408, 1104.5140138339104, 1115.4088333183263, 852.3181454836106, 860.694453469022, 862.5126803356084, 870.6560908441257, 887.2813021452644, 5046.823361182341, 5113.233015047698, 5156.278121063054, 5257.553107985864, 5263.6578622389425, 375.41247946962915, 408.82829211731143, 410.8130800485772, 412.4514395853508, 418.9958100419018, 3512.2624248907505, 3532.91167720809, 3543.344481270973, 3565.5008298838184, 3649.3978493548266, 8900.332475064397, 9164.083591640916, 9188.908110918805, 9253.306002049738, 9273.814523709489, 9085.818283634422, 9088.681896133603, 9099.272058235325, 9112.0, 9112.81774364509, 6680.532362734659, 6943.548669336578, 6976.720931162697, 6979.581225126509, 7070.681819318143, 5228.189630607262, 5368.812091576932, 5387.838364849061, 5445.782168713207, 5471.452854714496, 7794.427838813064, 7962.163972782774, 8035.67857285702, 8195.795105122419, 8368.330533557422, 7997.1203167652675, 8129.268365847102, 8161.79595510117, 8267.255946964802, 8309.459885107448, 6802.421794147553, 6843.828904277433, 6878.58728476293, 6907.274736152833, 6910.308969103049, 6898.206706228848, 7023.719051237893, 7035.437165026888, 7040.471964602573, 7041.718331266692, 6201.441870231701, 6281.434670879643, 6309.589876658002, 6439.227292724903, 6454.967725161344, 6071.210742603434, 6205.596636218631, 6286.18279623646, 6310.148130002391, 6341.334159913143, 6078.300995385587, 6192.504599632109, 6208.286047104641, 6208.782692605918, 6214.471769899609, 4436.13495368413, 4496.0558282760985, 4522.163399771053, 4586.88532786683, 4655.06898620284, 4628.352030715635, 4717.457492388419, 4782.187028205144, 4806.206975849085, 4976.726280054631], "value": 3857.814142949584, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [281.6732590195372, 289.7319979019407, 290.1310574828388, 290.49598945828996, 300.1386022116524, 4843.709377437347, 4950.405951285851, 4992.70043797372, 5038.773255203511, 5049.444561098277, 4788.688735232207, 4868.707877527342, 4898.4366797818175, 4924.556789888909, 4943.703377797326, 3873.3802591585354, 3881.0, 3900.1224724437056, 3903.277893589695, 3906.9609303907023, 3761.924761504782, 3839.884803455901, 3901.902452438683, 3916.9608303917025, 3932.193900250442, 3875.1087249932534, 3878.398848178537, 3890.144168282973, 3891.299566078105, 3891.5135608048995, 3860.9189426960497, 3865.4974853269177, 3867.7099217558793, 3875.2443273561667, 3892.338302488584, 3452.188735647121, 3455.289631632333, 3467.49721290414, 3470.1151206442446, 3470.7049900758466, 4639.744814035227, 4775.904481910377, 4822.276658501253, 4825.589824864891, 4838.564529192355, 4417.182821178092, 4428.889277768049, 4458.9331160032625, 4461.576150265752, 4464.285714285698, 5022.417938349445, 5123.359580052494, 5142.357205349332, 5152.124138896396, 5157.8452646420665, 3689.7786132831848, 3765.717571182145, 3776.395776675746, 3793.430985352192, 3799.4300854871713, 5337.0, 5346.599005074596, 5348.438413966555, 5348.973255133699, 5403.729813509309, 3736.3461394255896, 3748.9437658435145, 3748.9690335157507, 3758.229562939591, 3782.8486860525823, 3789.8105094745706, 3835.5013848199555, 3840.635139661728, 3841.116543195081, 3842.9239812852447, 4263.147370525907, 4289.82840686369, 4305.590968857953, 4343.522212556616, 4349.739015659071, 5070.847874563769, 5094.923576146361, 5112.747376892611, 5113.590912726973, 5118.411382691038, 1266.65167079054, 1281.8207249330637, 1282.8390306772385, 1303.1464390824026, 1317.5454468208452, 934.5934518484481, 952.7951490429591, 956.3305686019675, 960.351762560269, 967.685502211784, 4519.254323036728, 4541.591256786905, 4541.841035563805, 4552.908941821145, 4555.726656400627, 5043.293938848564, 5231.136862417735, 5290.994711004897, 5307.52232299095, 5310.6723319170205, 4527.977360113178, 4543.613792827647, 4545.272756358967, 4550.772461376918, 4552.726836389827, 2449.978767516806, 2478.330850670309, 2483.341914392687, 2503.5743923532677, 2505.8872350743895, 4368.584984426474, 4383.890402739957, 4385.210662080793, 4388.232059389594, 4701.341812146302, 5421.349438067457, 5432.891342173134, 5461.563074953994, 5468.671879687152, 5497.51567076887, 5089.643724939293, 5096.23556466533, 5099.36257967754, 5103.566196873233, 5108.540231379194, 5212.50481204285, 5273.235380869829, 5309.159599614188, 5376.301080859464, 5385.649932754359, 5199.896002080013, 5200.375954885287, 5214.227162764678, 5216.817411390583, 5224.58203343724, 5018.297438358706, 5062.0, 5067.493250674903, 5085.288059671723, 5114.514121158632, 3642.9089272767333, 3698.352788262097, 3700.389435743072, 3714.8699795507027, 3733.1973625669525, 5317.574594032545, 5322.787088516416, 5338.786448542171, 5339.572834173335, 5340.412554618911, 5092.898142037065, 5135.15269980449, 5161.864389834231, 5171.0, 5174.404943431403, 4950.8762280943265, 5113.233015047773, 5130.948690513196, 5140.871478213075, 5147.6911385317, 4875.464228767927, 5047.444781074152, 5050.0, 5061.822836200715, 5071.2139618359215, 5163.483651634957, 5168.095583272837, 5173.844784656466, 5206.505381988705, 5221.712805795718, 5050.217216331474, 5065.569426598633, 5072.51811077947, 5077.9238311424615, 5086.262491938722], "value": 3875.5065875735295, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [658.4633523678202, 662.5759513911098, 690.658124228507, 725.9092613423322, 759.0701390796273, 11499.482523286451, 11777.411129443515, 12310.569130080426, 12380.380980950962, 12464.127511074217, 11177.21759476837, 11267.830982535268, 11302.039326657223, 11325.490352934117, 11332.036776873976, 783.3693876429472, 797.6769408389612, 800.6797281087553, 801.0747586537558, 802.2298593350362, 777.4363586399871, 783.6826085435408, 786.1273985875673, 786.3237615650536, 803.6222975201675, 833.6040380819123, 838.76933843193, 840.5083026429546, 840.6805413942693, 841.2134654098408, 822.0751654388813, 832.2883934236262, 832.7085520067989, 832.7585000349891, 832.9583520823965, 610.9022556390956, 612.0390986151743, 612.6079309242089, 612.8069658057698, 613.8035828534871, 12243.93878030613, 12286.447109879988, 12314.199577027553, 12406.56577019809, 12441.440135193847, 11256.831147532794, 11292.717682057932, 11301.321920684784, 11602.825957610643, 11774.587889423914, 9659.758506037406, 9731.708048758548, 9882.752931176707, 10769.19231057666, 11442.485088171052, 4050.3316952702767, 4072.409500622423, 4097.89755256118, 4150.107726838744, 4273.529911709709, 49355.0, 50340.49659503395, 50898.74550627223, 50934.72663183413, 51707.741461292826, 8091.39314551411, 9641.758956026155, 9714.805703885882, 10008.64969726056, 10451.84322235167, 15270.007449515746, 15454.072755634697, 15596.220188990505, 15746.0, 15985.200739962955, 6509.707063182168, 6515.804525864137, 6545.541812073109, 6589.110470086573, 6749.392554670005, 3578.8926332210076, 3585.4084076127147, 3621.022323972513, 3641.599424063351, 3706.610805865399, 2731.9726802732116, 2793.1201671473423, 2831.7734581233453, 2842.6020357150014, 2985.402919416082, 536.7933345661949, 537.7660717587862, 539.8731298144933, 546.137103376664, 549.8130635583841, 436.9344598310279, 479.7505297245413, 527.3381905708311, 534.7860855657768, 546.710243570908, 7236.165934311503, 7537.623118844036, 7630.465867389229, 7873.0, 8190.959045204736, 568.590614757374, 583.3990989281048, 586.6714639801725, 598.7545106506311, 611.3672349118641, 3526.947095793565, 3734.2344819311975, 3738.738288319846, 3749.2876353492748, 3843.8078096095082, 72260.0, 72670.63664681643, 73209.0, 73792.26207737855, 75730.24269757232, 38164.0, 41882.58117418787, 59397.40602594005, 62850.37149628536, 62968.0, 36293.81853090718, 38582.80708596439, 56127.43872561222, 57807.13289300664, 58398.41601584015, 7094.893576596252, 7315.707371705073, 7335.4498412618195, 7494.5503269803985, 7609.6575654094595, 39673.40489892712, 39703.60296397115, 40250.79874600608, 40291.1941761169, 41136.58863411328, 31141.377172456876, 31839.6816031846, 33101.33797324088, 35467.64532354747, 35849.283014340086, 9404.905950940403, 9408.388454750419, 9518.381305215138, 9661.758456038655, 10272.589096436357, 11455.770884582429, 11644.88355116438, 11909.94045029804, 12438.875611244133, 13018.218906865619, 10764.730881727706, 11410.486528106088, 11518.481668324777, 11574.479148438171, 11811.645650630495, 10650.520726567169, 10802.89197108019, 11309.982101610894, 11323.32060076398, 11380.601678941197, 10640.463552812498, 10645.794911010262, 10703.839442408525, 10815.188860835311, 11226.494807733508, 9006.205023491728, 9215.354925155174, 9450.196733277748, 9480.525973701426, 9511.66709165176, 8869.467831930106, 9338.159565639126, 9398.953005235204, 10090.09189172978, 10118.342307749972], "value": 5995.18218805807, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1571.3999999999996, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 116.0, 114.0, 114.0, 115.0, 115.0, 114.0, 118.0, 117.0, 115.0], "value": 114.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 134.0, 130.0, 166.0, 130.0, 131.0, 129.0, 131.0, 165.0, 131.0], "value": 140.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [178.0, 164.0, 163.0, 166.0, 163.0, 164.0, 163.0, 165.0, 165.0, 163.0], "value": 165.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 77.0, 77.0, 109.0, 76.0, 79.0, 76.0, 77.0, 100.0, 81.0], "value": 82.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 111.0, 84.0, 85.0, 84.0, 104.0, 84.0, 84.0, 116.0], "value": 91.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 120.0, 120.0, 120.0, 120.0, 119.0, 118.0, 117.0, 118.0, 117.0], "value": 118.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 148.0, 147.0, 150.0, 148.0, 147.0, 148.0, 148.0, 147.0], "value": 147.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 85.0, 85.0, 84.0, 86.0, 86.0, 86.0, 85.0, 85.0], "value": 85.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 64.0, 65.0, 65.0, 69.0, 66.0, 64.0, 64.0, 64.0], "value": 64.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 67.0, 67.0, 66.0, 67.0, 67.0, 66.0, 66.0, 66.0], "value": 66.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 84.0, 94.0, 92.0, 84.0, 95.0, 88.0, 83.0, 85.0], "value": 87.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 154.0, 153.0, 144.0, 145.0, 152.0, 143.0, 149.0, 181.0, 148.0], "value": 151.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [179.0, 181.0, 182.0, 180.0, 179.0, 181.0, 190.0, 182.0, 177.0, 180.0], "value": 181.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 71.0, 74.0, 75.0, 71.0, 74.0, 73.0, 70.0, 73.0, 77.0], "value": 73.1, "unit": "score"}]}]} 23:42:55 INFO - Return code: 0 23:42:55 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 23:42:55 ERROR - # TBPL SUCCESS # 23:42:55 INFO - Running post-action listener: _resource_record_post_action 23:42:55 INFO - [mozharness: 2016-10-26 06:42:55.750132Z] Finished run-tests step (success) 23:42:55 INFO - Running post-run listener: _resource_record_post_run 23:42:55 INFO - Total resource usage - Wall time: 1202s; CPU: 13.0%; Read bytes: 4096; Write bytes: 403271680; Read time: 12; Write time: 251772 23:42:55 INFO - TinderboxPrint: CPU usage
13.4% 23:42:55 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 23:42:55 INFO - TinderboxPrint: I/O write bytes / time
403,271,680 / 251,772 23:42:55 INFO - TinderboxPrint: CPU idle
8,299.7 (86.6%) 23:42:55 INFO - TinderboxPrint: CPU user
1,223.7 (12.8%) 23:42:55 INFO - TinderboxPrint: Swap in / out
0 / 0 23:42:55 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 110493696; Read time: 0; Write time: 63760 23:42:55 INFO - run-tests - Wall time: 1186s; CPU: 13.0%; Read bytes: 0; Write bytes: 291790848; Read time: 0; Write time: 187980 23:42:56 INFO - Running post-run listener: _upload_blobber_files 23:42:56 INFO - Blob upload gear active. 23:42:56 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 23:42:56 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 23:42:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 23:42:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 23:42:56 INFO - (blobuploader) - INFO - Open directory for files ... 23:42:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 23:42:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:42:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:42:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 23:42:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:42:57 INFO - (blobuploader) - INFO - Done attempting. 23:42:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 23:42:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:42:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:43:00 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 23:43:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:43:00 INFO - (blobuploader) - INFO - Done attempting. 23:43:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 23:43:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:43:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:43:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 23:43:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:43:01 INFO - (blobuploader) - INFO - Done attempting. 23:43:01 INFO - (blobuploader) - INFO - Iteration through files over. 23:43:01 INFO - Return code: 0 23:43:01 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 23:43:01 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 23:43:01 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1f3f44dc639867509a9362e7adb143688de1c3651e81b0a123e24322d6dd425069f814a8d568e7ab3061f7b2b0c863f5c91a7561bbb934d542b4bf0c13139e32", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4ecf80a5961abb547d991e89ff34fba0de502a66e503908b2bc16b6abb690f93c1e533cde43d5b1e4a036ca547683f8c6c23e589ca2c6da5fc752b42e589eab3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8b86912e3a5f1822007eeeccc30b40ec307664ab8e78a79bc0307518f5f2b2fe9fc05045fb08ee368cb8dea27ea825677f690e49e438d1b970c9906c76087bfe"} 23:43:01 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 23:43:01 INFO - Writing to file /builds/slave/test/properties/blobber_files 23:43:01 INFO - Contents: 23:43:01 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1f3f44dc639867509a9362e7adb143688de1c3651e81b0a123e24322d6dd425069f814a8d568e7ab3061f7b2b0c863f5c91a7561bbb934d542b4bf0c13139e32", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4ecf80a5961abb547d991e89ff34fba0de502a66e503908b2bc16b6abb690f93c1e533cde43d5b1e4a036ca547683f8c6c23e589ca2c6da5fc752b42e589eab3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8b86912e3a5f1822007eeeccc30b40ec307664ab8e78a79bc0307518f5f2b2fe9fc05045fb08ee368cb8dea27ea825677f690e49e438d1b970c9906c76087bfe"} 23:43:01 INFO - Running post-run listener: copy_logs_to_upload_dir 23:43:01 INFO - Copying logs to upload dir... 23:43:01 INFO - mkdir: /builds/slave/test/build/upload/logs 23:43:01 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1245.797185 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-10-25 23:43:01.571592) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-25 23:43:01.574880) ========= 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=836cfdc75598d54cb747368e000001a9-1477460099.992012-1484926707 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1f3f44dc639867509a9362e7adb143688de1c3651e81b0a123e24322d6dd425069f814a8d568e7ab3061f7b2b0c863f5c91a7561bbb934d542b4bf0c13139e32", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4ecf80a5961abb547d991e89ff34fba0de502a66e503908b2bc16b6abb690f93c1e533cde43d5b1e4a036ca547683f8c6c23e589ca2c6da5fc752b42e589eab3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8b86912e3a5f1822007eeeccc30b40ec307664ab8e78a79bc0307518f5f2b2fe9fc05045fb08ee368cb8dea27ea825677f690e49e438d1b970c9906c76087bfe"} build_url:https://queue.taskcluster.net/v1/task/CbSo9_5vT7SKBqDvdnI4oA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011456 build_url: 'https://queue.taskcluster.net/v1/task/CbSo9_5vT7SKBqDvdnI4oA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1f3f44dc639867509a9362e7adb143688de1c3651e81b0a123e24322d6dd425069f814a8d568e7ab3061f7b2b0c863f5c91a7561bbb934d542b4bf0c13139e32", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4ecf80a5961abb547d991e89ff34fba0de502a66e503908b2bc16b6abb690f93c1e533cde43d5b1e4a036ca547683f8c6c23e589ca2c6da5fc752b42e589eab3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8b86912e3a5f1822007eeeccc30b40ec307664ab8e78a79bc0307518f5f2b2fe9fc05045fb08ee368cb8dea27ea825677f690e49e438d1b970c9906c76087bfe"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-25 23:43:01.601265) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-25 23:43:01.601621) ========= 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=836cfdc75598d54cb747368e000001a9-1477460099.992012-1484926707 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004469 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-25 23:43:01.685615) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-25 23:43:01.685995) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-25 23:43:01.686387) ========= ========= Total master_lag: 0.16 =========