builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-028 starttime: 1478872330.89 results: success (0) buildid: 20161111030203 builduid: 877d3042e6be47fe855c1bdb51df7af8 revision: d38d06f85ef5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-11 05:52:10.886637) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-11 05:52:10.887090) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-11 05:52:10.887393) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-11 05:52:10.902225) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-11 05:52:10.902513) ========= 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-1478868532.594343-1661560718 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-11 05:52:11-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 101M=0s 2016-11-11 05:52:12 (101 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.128944 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-11 05:52:11.047603) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-11 05:52:11.048679) ========= 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-1478868532.594343-1661560718 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019119 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-11 05:52:11.098725) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-11 05:52:11.099113) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev d38d06f85ef5 --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 d38d06f85ef5 --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-1478868532.594343-1661560718 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-11 05:52:12,177 Setting DEBUG logging. 2016-11-11 05:52:12,178 attempt 1/10 2016-11-11 05:52:12,178 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/d38d06f85ef5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-11 05:52:12,509 unpacking tar archive at: mozilla-central-d38d06f85ef5/testing/mozharness/ program finished with exit code 0 elapsedTime=0.705288 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-11 05:52:11.818847) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-11 05:52:11.819199) ========= script_repo_revision: d38d06f85ef5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-11 05:52:11.819679) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-11 05:52:11.820132) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-11 05:52:11.830773) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-11-11 05:52:11.831171) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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-1478868532.594343-1661560718 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:52:13 INFO - MultiFileLogger online at 20161111 05:52:13 in /builds/slave/test 05:52:13 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:52:13 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:52:13 INFO - {'append_to_log': False, 05:52:13 INFO - 'base_work_dir': '/builds/slave/test', 05:52:13 INFO - 'blob_upload_branch': 'Firefox', 05:52:13 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:52:13 INFO - 'branch': 'Firefox', 05:52:13 INFO - 'buildbot_json_path': 'buildprops.json', 05:52:13 INFO - 'config_files': ('talos/linux_config.py',), 05:52:13 INFO - 'default_actions': ('clobber', 05:52:13 INFO - 'read-buildbot-config', 05:52:13 INFO - 'download-and-extract', 05:52:13 INFO - 'populate-webroot', 05:52:13 INFO - 'create-virtualenv', 05:52:13 INFO - 'install', 05:52:13 INFO - 'run-tests'), 05:52:13 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:52:13 INFO - 'download_minidump_stackwalk': True, 05:52:13 INFO - 'download_symbols': 'ondemand', 05:52:13 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:52:13 INFO - 'tooltool.py': '/tools/tooltool.py', 05:52:13 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:52:13 INFO - '/tools/misc-python/virtualenv.py')}, 05:52:13 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:52:13 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:52:13 INFO - 'installer_path': 'installer.exe', 05:52:13 INFO - 'log_level': 'info', 05:52:13 INFO - 'log_name': 'talos', 05:52:13 INFO - 'log_to_console': True, 05:52:13 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:52:13 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:52:13 INFO - 'opt_config_files': (), 05:52:13 INFO - 'pip_index': False, 05:52:13 INFO - 'sps_profile': False, 05:52:13 INFO - 'sps_profile_interval': 0, 05:52:13 INFO - 'suite': 'dromaeojs', 05:52:13 INFO - 'system_bits': '32', 05:52:13 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:52:13 INFO - 'title': 'talos-linux64-ix-028', 05:52:13 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:52:13 INFO - 'use_talos_json': True, 05:52:13 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:52:13 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:52:13 INFO - 'work_dir': 'build'} 05:52:13 INFO - [mozharness: 2016-11-11 13:52:13.011036Z] Running clobber step. 05:52:13 INFO - Running pre-action listener: _resource_record_pre_action 05:52:13 INFO - Running main action method: clobber 05:52:13 INFO - rmtree: /builds/slave/test/build 05:52:13 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:52:13 INFO - Running post-action listener: _resource_record_post_action 05:52:13 INFO - [mozharness: 2016-11-11 13:52:13.471265Z] Finished clobber step (success) 05:52:13 INFO - [mozharness: 2016-11-11 13:52:13.471364Z] Running read-buildbot-config step. 05:52:13 INFO - Running pre-action listener: _resource_record_pre_action 05:52:13 INFO - Running main action method: read_buildbot_config 05:52:13 INFO - Using buildbot properties: 05:52:13 INFO - { 05:52:13 INFO - "project": "", 05:52:13 INFO - "product": "firefox", 05:52:13 INFO - "script_repo_revision": "production", 05:52:13 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 05:52:13 INFO - "repository": "", 05:52:13 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 05:52:13 INFO - "buildid": "20161111030203", 05:52:13 INFO - "stage_platform": "linux64-pgo", 05:52:13 INFO - "basedir": "/builds/slave/test", 05:52:13 INFO - "nightly_build": "True", 05:52:13 INFO - "buildnumber": 78, 05:52:13 INFO - "slavename": "talos-linux64-ix-028", 05:52:13 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:52:13 INFO - "platform": "ubuntu64_hw", 05:52:13 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 05:52:13 INFO - "branch": "mozilla-central", 05:52:13 INFO - "repo_path": "mozilla-central", 05:52:13 INFO - "revision": "d38d06f85ef5", 05:52:13 INFO - "pgo_build": "True", 05:52:13 INFO - "builduid": "877d3042e6be47fe855c1bdb51df7af8", 05:52:13 INFO - "slavebuilddir": "test" 05:52:13 INFO - } 05:52:13 INFO - Found installer url https://queue.taskcluster.net/v1/task/didJpmEMRayoj4gBJxkTxw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 05:52:13 INFO - Running post-action listener: _resource_record_post_action 05:52:13 INFO - [mozharness: 2016-11-11 13:52:13.473942Z] Finished read-buildbot-config step (success) 05:52:13 INFO - [mozharness: 2016-11-11 13:52:13.474031Z] Running download-and-extract step. 05:52:13 INFO - Running pre-action listener: _resource_record_pre_action 05:52:13 INFO - Running main action method: download_and_extract 05:52:13 INFO - mkdir: /builds/slave/test/build/tests 05:52:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:52:13 INFO - trying https://queue.taskcluster.net/v1/task/didJpmEMRayoj4gBJxkTxw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 05:52:13 INFO - Downloading https://queue.taskcluster.net/v1/task/didJpmEMRayoj4gBJxkTxw/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 05:52:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/didJpmEMRayoj4gBJxkTxw/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 05:52:14 INFO - Downloaded 1361 bytes. 05:52:14 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 05:52:14 INFO - Using the following test package requirements: 05:52:14 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 05:52:14 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:52:14 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:52:14 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:52:14 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:52:14 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:52:14 INFO - u'jsshell-linux-x86_64.zip'], 05:52:14 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:52:14 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:52:14 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 05:52:14 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:52:14 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:52:14 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:52:14 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:52:14 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:52:14 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:52:14 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:52:14 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:52:14 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:52:14 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/didJpmEMRayoj4gBJxkTxw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 05:52:14 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/didJpmEMRayoj4gBJxkTxw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:52:14 INFO - Fetch https://queue.taskcluster.net/v1/task/didJpmEMRayoj4gBJxkTxw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 05:52:14 INFO - Http code: 200 05:52:14 INFO - via: 1.1 978198446b6fdba8a499c04f84a3a7e6.cloudfront.net (CloudFront) 05:52:14 INFO - x-amz-cf-id: cu_WvVuKC_dZ6TtJAx3QAloZh1urGPYBogif0zEIkyJ7iZDyK8HuOw== 05:52:14 INFO - x-amz-version-id: FLAc._B8ezsvlykDYDowJ2Sg2VxSJNBK 05:52:14 INFO - Expected file size: 21969016 05:52:14 INFO - Obtained file size: 21969016 05:52:18 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 05:52:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/didJpmEMRayoj4gBJxkTxw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 05:52:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/didJpmEMRayoj4gBJxkTxw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:52:18 INFO - Fetch https://queue.taskcluster.net/v1/task/didJpmEMRayoj4gBJxkTxw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 05:52:19 INFO - Http code: 200 05:52:19 INFO - via: 1.1 dc553909528b8b63475c922dc07d8ba6.cloudfront.net (CloudFront) 05:52:19 INFO - x-amz-cf-id: s-D8RO-fw6u-kuV41Yl7RTAIUkMU1YWtmn1zQieuZUM5A-tI34b97Q== 05:52:19 INFO - x-amz-version-id: FLAc._B8ezsvlykDYDowJ2Sg2VxSJNBK 05:52:19 INFO - Expected file size: 21969016 05:52:19 INFO - Obtained file size: 21969016 05:52:24 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/didJpmEMRayoj4gBJxkTxw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 05:52:24 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/didJpmEMRayoj4gBJxkTxw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:52:24 INFO - Fetch https://queue.taskcluster.net/v1/task/didJpmEMRayoj4gBJxkTxw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 05:52:24 INFO - Http code: 200 05:52:24 INFO - via: 1.1 1c6cc78b8ca6319854350cf7a741a470.cloudfront.net (CloudFront) 05:52:24 INFO - x-amz-cf-id: cDS0g33AEiNd088hKRPP6GhJWjQruolXs2f05pivUuKbGaO4JS2A_A== 05:52:24 INFO - x-amz-version-id: MT_MirC2LfTcKKWsKOhuHCM6C4djdXIm 05:52:25 INFO - Expected file size: 14409038 05:52:25 INFO - Obtained file size: 14409038 05:52:25 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')]} 05:52:25 INFO - trying https://queue.taskcluster.net/v1/task/didJpmEMRayoj4gBJxkTxw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 05:52:25 INFO - Downloading https://queue.taskcluster.net/v1/task/didJpmEMRayoj4gBJxkTxw/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 05:52:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/didJpmEMRayoj4gBJxkTxw/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 05:52:27 INFO - Downloaded 59304708 bytes. 05:52:27 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/didJpmEMRayoj4gBJxkTxw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 05:52:27 INFO - mkdir: /builds/slave/test/properties 05:52:27 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:52:27 INFO - Writing to file /builds/slave/test/properties/build_url 05:52:27 INFO - Contents: 05:52:27 INFO - build_url:https://queue.taskcluster.net/v1/task/didJpmEMRayoj4gBJxkTxw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 05:52:28 INFO - Running post-action listener: _resource_record_post_action 05:52:28 INFO - Running post-action listener: set_extra_try_arguments 05:52:28 INFO - [mozharness: 2016-11-11 13:52:28.515489Z] Finished download-and-extract step (success) 05:52:28 INFO - [mozharness: 2016-11-11 13:52:28.515717Z] Running populate-webroot step. 05:52:28 INFO - Running pre-action listener: _resource_record_pre_action 05:52:28 INFO - Running main action method: populate_webroot 05:52:28 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:52:28 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:52:28 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:52:28 INFO - '--tppagecycles', 05:52:28 INFO - '7'], 05:52:28 INFO - 'tests': ['tsvgm']}}, 05:52:28 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:52:28 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:52:28 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:52:28 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:52:28 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:52:28 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:52:28 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:52:28 INFO - 'talos_options': ['--disable-e10s'], 05:52:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:52:28 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:52:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:52:28 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:52:28 INFO - 'talos_options': ['--disable-e10s'], 05:52:28 INFO - 'tests': ['damp', 'tps']}, 05:52:28 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:52:28 INFO - 'tests': ['damp', 'tps']}, 05:52:28 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:52:28 INFO - 'tests': ['dromaeo_dom']}, 05:52:28 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:52:28 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:52:28 INFO - 'tests': ['basic_compositor_video']}, 05:52:28 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:52:28 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:52:28 INFO - 'tests': ['a11yr', 05:52:28 INFO - 'ts_paint', 05:52:28 INFO - 'tpaint', 05:52:28 INFO - 'sessionrestore', 05:52:28 INFO - 'sessionrestore_no_auto_restore', 05:52:28 INFO - 'tabpaint']}, 05:52:28 INFO - 'other-e10s': {'tests': ['a11yr', 05:52:28 INFO - 'ts_paint', 05:52:28 INFO - 'tpaint', 05:52:28 INFO - 'sessionrestore', 05:52:28 INFO - 'sessionrestore_no_auto_restore', 05:52:28 INFO - 'tabpaint']}, 05:52:28 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:52:28 INFO - 'ts_paint', 05:52:28 INFO - 'tpaint', 05:52:28 INFO - 'sessionrestore', 05:52:28 INFO - 'sessionrestore_no_auto_restore', 05:52:28 INFO - 'tabpaint']}, 05:52:28 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:52:28 INFO - 'ts_paint', 05:52:28 INFO - 'tpaint', 05:52:28 INFO - 'sessionrestore', 05:52:28 INFO - 'sessionrestore_no_auto_restore', 05:52:28 INFO - 'tabpaint']}, 05:52:28 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:52:28 INFO - 'tests': ['a11yr', 05:52:28 INFO - 'ts_paint', 05:52:28 INFO - 'tpaint', 05:52:28 INFO - 'sessionrestore', 05:52:28 INFO - 'sessionrestore_no_auto_restore', 05:52:28 INFO - 'tabpaint']}, 05:52:28 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:52:28 INFO - 'tests': ['a11yr', 05:52:28 INFO - 'ts_paint', 05:52:28 INFO - 'tpaint', 05:52:28 INFO - 'sessionrestore', 05:52:28 INFO - 'sessionrestore_no_auto_restore', 05:52:28 INFO - 'tabpaint']}, 05:52:28 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:52:28 INFO - 'tests': ['tsvgx', 05:52:28 INFO - 'tsvgr_opacity', 05:52:28 INFO - 'tart', 05:52:28 INFO - 'tscrollx', 05:52:28 INFO - 'cart']}, 05:52:28 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:52:28 INFO - 'tsvgr_opacity', 05:52:28 INFO - 'tart', 05:52:28 INFO - 'tscrollx', 05:52:28 INFO - 'cart']}, 05:52:28 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:52:28 INFO - 'talos_options': ['--disable-e10s'], 05:52:28 INFO - 'tests': ['tp5o']}, 05:52:28 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:52:28 INFO - 'tests': ['tp5o']}, 05:52:28 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:52:28 INFO - 'talos_options': ['--disable-e10s', 05:52:28 INFO - '--xperf_path', 05:52:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:52:28 INFO - 'tests': ['tp5n']}, 05:52:28 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:52:28 INFO - 'talos_options': ['--xperf_path', 05:52:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:52:28 INFO - 'tests': ['tp5n']}}, 05:52:28 INFO - 'talos.zip': {'path': '', 05:52:28 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:52:28 INFO - Running post-action listener: _resource_record_post_action 05:52:28 INFO - [mozharness: 2016-11-11 13:52:28.533609Z] Finished populate-webroot step (success) 05:52:28 INFO - [mozharness: 2016-11-11 13:52:28.533698Z] Running create-virtualenv step. 05:52:28 INFO - Running pre-action listener: _resource_record_pre_action 05:52:28 INFO - Running main action method: create_virtualenv 05:52:28 INFO - Creating virtualenv /builds/slave/test/build/venv 05:52:28 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 05:52:28 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:52:28 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:52:28 INFO - Using real prefix '/usr' 05:52:28 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:52:29 INFO - Installing distribute.............................................................................................................................................................................................done. 05:52:31 INFO - Installing pip.................done. 05:52:31 INFO - Return code: 0 05:52:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 05:52:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 05:52:31 INFO - Reading from file tmpfile_stdout 05:52:31 INFO - Output received: 05:52:31 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) 05:52:31 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:52:31 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')]} 05:52:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:52:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:31 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')]} 05:52:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:52:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:31 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 0x7f0cf8b34f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14bc790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14b9930>, '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 0x14ba830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14bacc0>, '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-1478868532.594343-1661560718', '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 05:52:31 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 05:52:31 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 05:52:31 INFO - Using env: {'DISPLAY': ':0', 05:52:31 INFO - 'HOME': '/home/cltbld', 05:52:31 INFO - 'LANG': 'en_US.UTF-8', 05:52:31 INFO - 'LANGUAGE': 'en_US:en', 05:52:31 INFO - 'LOGNAME': 'cltbld', 05:52:31 INFO - 'MAIL': '/var/mail/cltbld', 05:52:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:52:31 INFO - 'MOZ_NO_REMOTE': '1', 05:52:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:52:31 INFO - 'NO_EM_RESTART': '1', 05:52:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:52:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:52:31 INFO - 'PWD': '/builds/slave/test', 05:52:31 INFO - 'SHELL': '/bin/bash', 05:52:31 INFO - 'SHLVL': '1', 05:52:31 INFO - 'TERM': 'linux', 05:52:31 INFO - 'TMOUT': '86400', 05:52:31 INFO - 'USER': 'cltbld', 05:52:31 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1478868532.594343-1661560718', 05:52:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:52:31 INFO - '_': '/tools/buildbot/bin/python'} 05:52:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:52:31 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 05:52:31 INFO - Cleaning up... 05:52:31 INFO - Return code: 0 05:52:31 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:52:31 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')]} 05:52:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:52:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:31 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')]} 05:52:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:52:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:31 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 0x7f0cf8b34f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14bc790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14b9930>, '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 0x14ba830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14bacc0>, '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-1478868532.594343-1661560718', '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 05:52:31 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 05:52:31 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 05:52:31 INFO - Using env: {'DISPLAY': ':0', 05:52:31 INFO - 'HOME': '/home/cltbld', 05:52:31 INFO - 'LANG': 'en_US.UTF-8', 05:52:31 INFO - 'LANGUAGE': 'en_US:en', 05:52:31 INFO - 'LOGNAME': 'cltbld', 05:52:31 INFO - 'MAIL': '/var/mail/cltbld', 05:52:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:52:31 INFO - 'MOZ_NO_REMOTE': '1', 05:52:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:52:31 INFO - 'NO_EM_RESTART': '1', 05:52:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:52:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:52:31 INFO - 'PWD': '/builds/slave/test', 05:52:31 INFO - 'SHELL': '/bin/bash', 05:52:31 INFO - 'SHLVL': '1', 05:52:31 INFO - 'TERM': 'linux', 05:52:31 INFO - 'TMOUT': '86400', 05:52:31 INFO - 'USER': 'cltbld', 05:52:31 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1478868532.594343-1661560718', 05:52:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:52:31 INFO - '_': '/tools/buildbot/bin/python'} 05:52:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:52:31 INFO - Downloading/unpacking psutil>=3.1.1 05:52:31 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 05:52:31 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 05:52:31 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 05:52:31 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 05:52:31 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 05:52:31 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 05:52:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:52:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:52:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:52:33 INFO - Installing collected packages: psutil 05:52:33 INFO - Running setup.py install for psutil 05:52:33 INFO - building 'psutil._psutil_linux' extension 05:52:33 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 05:52:34 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 05:52:34 INFO - building 'psutil._psutil_posix' extension 05:52:34 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 05:52:34 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 05:52:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:52:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:52:34 INFO - Successfully installed psutil 05:52:34 INFO - Cleaning up... 05:52:34 INFO - Return code: 0 05:52:34 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:52:34 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')]} 05:52:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:52:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:34 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')]} 05:52:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:52:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:34 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 0x7f0cf8b34f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14bc790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14b9930>, '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 0x14ba830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14bacc0>, '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-1478868532.594343-1661560718', '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 05:52:34 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 05:52:34 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 05:52:34 INFO - Using env: {'DISPLAY': ':0', 05:52:34 INFO - 'HOME': '/home/cltbld', 05:52:34 INFO - 'LANG': 'en_US.UTF-8', 05:52:34 INFO - 'LANGUAGE': 'en_US:en', 05:52:34 INFO - 'LOGNAME': 'cltbld', 05:52:34 INFO - 'MAIL': '/var/mail/cltbld', 05:52:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:52:34 INFO - 'MOZ_NO_REMOTE': '1', 05:52:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:52:34 INFO - 'NO_EM_RESTART': '1', 05:52:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:52:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:52:34 INFO - 'PWD': '/builds/slave/test', 05:52:34 INFO - 'SHELL': '/bin/bash', 05:52:34 INFO - 'SHLVL': '1', 05:52:34 INFO - 'TERM': 'linux', 05:52:34 INFO - 'TMOUT': '86400', 05:52:34 INFO - 'USER': 'cltbld', 05:52:34 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1478868532.594343-1661560718', 05:52:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:52:34 INFO - '_': '/tools/buildbot/bin/python'} 05:52:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:52:34 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:52:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:52:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:52:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:52:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:52:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:52:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:52:36 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:52:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:52:36 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:52:36 INFO - Installing collected packages: mozsystemmonitor 05:52:36 INFO - Running setup.py install for mozsystemmonitor 05:52:36 INFO - Successfully installed mozsystemmonitor 05:52:36 INFO - Cleaning up... 05:52:36 INFO - Return code: 0 05:52:36 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:52: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')]} 05:52:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:52:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52: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')]} 05:52:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:52:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52: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', '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 0x7f0cf8b34f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14bc790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14b9930>, '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 0x14ba830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14bacc0>, '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-1478868532.594343-1661560718', '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 05:52: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 05:52: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 jsonschema==2.5.1 05:52:36 INFO - Using env: {'DISPLAY': ':0', 05:52:36 INFO - 'HOME': '/home/cltbld', 05:52:36 INFO - 'LANG': 'en_US.UTF-8', 05:52:36 INFO - 'LANGUAGE': 'en_US:en', 05:52:36 INFO - 'LOGNAME': 'cltbld', 05:52:36 INFO - 'MAIL': '/var/mail/cltbld', 05:52:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:52:36 INFO - 'MOZ_NO_REMOTE': '1', 05:52:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:52:36 INFO - 'NO_EM_RESTART': '1', 05:52:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:52:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:52:36 INFO - 'PWD': '/builds/slave/test', 05:52:36 INFO - 'SHELL': '/bin/bash', 05:52:36 INFO - 'SHLVL': '1', 05:52:36 INFO - 'TERM': 'linux', 05:52:36 INFO - 'TMOUT': '86400', 05:52:36 INFO - 'USER': 'cltbld', 05:52:36 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1478868532.594343-1661560718', 05:52:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:52:36 INFO - '_': '/tools/buildbot/bin/python'} 05:52:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:52:36 INFO - Downloading/unpacking jsonschema==2.5.1 05:52: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 05:52: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 05:52: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 05:52: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 05:52: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 05:52: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 05:52:38 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:52:38 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:52: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 05:52: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 05:52: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 05:52: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 05:52: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 05:52: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 05:52:39 INFO - Downloading functools32-3.2.3-2.tar.gz 05:52:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:52:39 INFO - warning: no files found matching '*.txt' 05:52:39 INFO - no previously-included directories found matching 'build' 05:52:39 INFO - no previously-included directories found matching 'dist' 05:52:39 INFO - no previously-included directories found matching '.git*' 05:52:39 INFO - Installing collected packages: jsonschema, functools32 05:52:39 INFO - Running setup.py install for functools32 05:52:39 INFO - warning: no files found matching '*.txt' 05:52:39 INFO - no previously-included directories found matching 'build' 05:52:39 INFO - no previously-included directories found matching 'dist' 05:52:39 INFO - no previously-included directories found matching '.git*' 05:52:39 INFO - Successfully installed jsonschema functools32 05:52:39 INFO - Cleaning up... 05:52:39 INFO - Return code: 0 05:52:39 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:52:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:52:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:52:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:52:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:52:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:39 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 0x7f0cf8b34f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14bc790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14b9930>, '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 0x14ba830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14bacc0>, '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-1478868532.594343-1661560718', '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 05:52:39 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 05:52:39 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 05:52:39 INFO - Using env: {'DISPLAY': ':0', 05:52:39 INFO - 'HOME': '/home/cltbld', 05:52:39 INFO - 'LANG': 'en_US.UTF-8', 05:52:39 INFO - 'LANGUAGE': 'en_US:en', 05:52:39 INFO - 'LOGNAME': 'cltbld', 05:52:39 INFO - 'MAIL': '/var/mail/cltbld', 05:52:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:52:39 INFO - 'MOZ_NO_REMOTE': '1', 05:52:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:52:39 INFO - 'NO_EM_RESTART': '1', 05:52:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:52:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:52:39 INFO - 'PWD': '/builds/slave/test', 05:52:39 INFO - 'SHELL': '/bin/bash', 05:52:39 INFO - 'SHLVL': '1', 05:52:39 INFO - 'TERM': 'linux', 05:52:39 INFO - 'TMOUT': '86400', 05:52:39 INFO - 'USER': 'cltbld', 05:52:39 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1478868532.594343-1661560718', 05:52:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:52:39 INFO - '_': '/tools/buildbot/bin/python'} 05:52:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:52:39 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:52:39 INFO - Cleaning up... 05:52:39 INFO - Return code: 0 05:52:39 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:52:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:52:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:52:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:52:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:52:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:39 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 0x7f0cf8b34f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14bc790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14b9930>, '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 0x14ba830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14bacc0>, '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-1478868532.594343-1661560718', '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 05:52:39 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 05:52:39 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 05:52:39 INFO - Using env: {'DISPLAY': ':0', 05:52:39 INFO - 'HOME': '/home/cltbld', 05:52:39 INFO - 'LANG': 'en_US.UTF-8', 05:52:39 INFO - 'LANGUAGE': 'en_US:en', 05:52:39 INFO - 'LOGNAME': 'cltbld', 05:52:39 INFO - 'MAIL': '/var/mail/cltbld', 05:52:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:52:39 INFO - 'MOZ_NO_REMOTE': '1', 05:52:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:52:39 INFO - 'NO_EM_RESTART': '1', 05:52:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:52:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:52:39 INFO - 'PWD': '/builds/slave/test', 05:52:39 INFO - 'SHELL': '/bin/bash', 05:52:39 INFO - 'SHLVL': '1', 05:52:39 INFO - 'TERM': 'linux', 05:52:39 INFO - 'TMOUT': '86400', 05:52:39 INFO - 'USER': 'cltbld', 05:52:39 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1478868532.594343-1661560718', 05:52:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:52:39 INFO - '_': '/tools/buildbot/bin/python'} 05:52:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:52:39 INFO - Downloading/unpacking blobuploader==1.2.4 05:52:39 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 05:52:39 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 05:52:39 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 05:52:39 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 05:52:39 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 05:52:39 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 05:52:41 INFO - Downloading blobuploader-1.2.4.tar.gz 05:52:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:52:41 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:52: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 05:52: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 05:52: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 05:52: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 05:52: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 05:52: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 05:52:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:52:42 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:52:42 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 05:52:42 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 05:52:42 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 05:52:42 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 05:52:42 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 05:52:42 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 05:52:42 INFO - Downloading docopt-0.6.1.tar.gz 05:52:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:52:42 INFO - Installing collected packages: blobuploader, requests, docopt 05:52:42 INFO - Running setup.py install for blobuploader 05:52:42 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:52:42 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:52:42 INFO - Running setup.py install for requests 05:52:42 INFO - Running setup.py install for docopt 05:52:43 INFO - Successfully installed blobuploader requests docopt 05:52:43 INFO - Cleaning up... 05:52:43 INFO - Return code: 0 05:52:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:52:43 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')]} 05:52:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:52:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:43 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')]} 05:52:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:52:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:43 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 0x7f0cf8b34f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14bc790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14b9930>, '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 0x14ba830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14bacc0>, '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-1478868532.594343-1661560718', '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 05:52:43 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 05:52:43 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 05:52:43 INFO - Using env: {'DISPLAY': ':0', 05:52:43 INFO - 'HOME': '/home/cltbld', 05:52:43 INFO - 'LANG': 'en_US.UTF-8', 05:52:43 INFO - 'LANGUAGE': 'en_US:en', 05:52:43 INFO - 'LOGNAME': 'cltbld', 05:52:43 INFO - 'MAIL': '/var/mail/cltbld', 05:52:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:52:43 INFO - 'MOZ_NO_REMOTE': '1', 05:52:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:52:43 INFO - 'NO_EM_RESTART': '1', 05:52:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:52:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:52:43 INFO - 'PWD': '/builds/slave/test', 05:52:43 INFO - 'SHELL': '/bin/bash', 05:52:43 INFO - 'SHLVL': '1', 05:52:43 INFO - 'TERM': 'linux', 05:52:43 INFO - 'TMOUT': '86400', 05:52:43 INFO - 'USER': 'cltbld', 05:52:43 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1478868532.594343-1661560718', 05:52:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:52:43 INFO - '_': '/tools/buildbot/bin/python'} 05:52:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:52:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:52:43 INFO - Running setup.py (path:/tmp/pip-IfDiGc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:52:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:52:43 INFO - Running setup.py (path:/tmp/pip-gOf3x4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:52:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:52:43 INFO - Running setup.py (path:/tmp/pip-StXbwf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:52:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:52:43 INFO - Running setup.py (path:/tmp/pip-xXiTwM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:52:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:52:43 INFO - Running setup.py (path:/tmp/pip-hN5xND-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:52:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:52:43 INFO - Running setup.py (path:/tmp/pip-s6L7te-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:52:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:52:43 INFO - Running setup.py (path:/tmp/pip-r5E8aA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:52:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:52:43 INFO - Running setup.py (path:/tmp/pip-8mhGnv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:52:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:52:43 INFO - Running setup.py (path:/tmp/pip-spcgZJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:52:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:52:43 INFO - Running setup.py (path:/tmp/pip-kGKHBf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:52:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:52:44 INFO - Running setup.py (path:/tmp/pip-VrrSUy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:52:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:52:44 INFO - Running setup.py (path:/tmp/pip-BuVkKQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:52:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:52:44 INFO - Running setup.py (path:/tmp/pip-NSP8no-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:52:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:52:44 INFO - Running setup.py (path:/tmp/pip-JZP68I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:52:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:52:44 INFO - Running setup.py (path:/tmp/pip-sx_FCQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:52:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:52:44 INFO - Running setup.py (path:/tmp/pip-AWFSrt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:52:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:52:44 INFO - Running setup.py (path:/tmp/pip-HyMuP1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:52:44 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:52:44 INFO - Running setup.py install for manifestparser 05:52:44 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:52:44 INFO - Running setup.py install for mozcrash 05:52:44 INFO - Running setup.py install for mozdebug 05:52:44 INFO - Running setup.py install for mozdevice 05:52:44 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:52:44 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:52:44 INFO - Running setup.py install for mozfile 05:52:45 INFO - Running setup.py install for mozhttpd 05:52:45 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:52:45 INFO - Running setup.py install for mozinfo 05:52:45 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:52:45 INFO - Running setup.py install for mozInstall 05:52:45 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:52:45 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:52:45 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:52:45 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:52:45 INFO - Running setup.py install for mozleak 05:52:45 INFO - Running setup.py install for mozlog 05:52:45 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:52:45 INFO - Running setup.py install for moznetwork 05:52:45 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:52:45 INFO - Running setup.py install for mozprocess 05:52:45 INFO - Running setup.py install for mozprofile 05:52:45 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:52:45 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:52:45 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:52:45 INFO - Running setup.py install for mozrunner 05:52:46 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:52:46 INFO - Running setup.py install for mozscreenshot 05:52:46 INFO - Running setup.py install for moztest 05:52:46 INFO - Running setup.py install for mozversion 05:52:46 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:52:46 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:52:46 INFO - Cleaning up... 05:52:46 INFO - Return code: 0 05:52:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:52:46 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')]} 05:52:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:52:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:46 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')]} 05:52:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:52:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:46 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 0x7f0cf8b34f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14bc790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14b9930>, '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 0x14ba830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14bacc0>, '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-1478868532.594343-1661560718', '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 05:52:46 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 05:52:46 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 05:52:46 INFO - Using env: {'DISPLAY': ':0', 05:52:46 INFO - 'HOME': '/home/cltbld', 05:52:46 INFO - 'LANG': 'en_US.UTF-8', 05:52:46 INFO - 'LANGUAGE': 'en_US:en', 05:52:46 INFO - 'LOGNAME': 'cltbld', 05:52:46 INFO - 'MAIL': '/var/mail/cltbld', 05:52:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:52:46 INFO - 'MOZ_NO_REMOTE': '1', 05:52:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:52:46 INFO - 'NO_EM_RESTART': '1', 05:52:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:52:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:52:46 INFO - 'PWD': '/builds/slave/test', 05:52:46 INFO - 'SHELL': '/bin/bash', 05:52:46 INFO - 'SHLVL': '1', 05:52:46 INFO - 'TERM': 'linux', 05:52:46 INFO - 'TMOUT': '86400', 05:52:46 INFO - 'USER': 'cltbld', 05:52:46 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1478868532.594343-1661560718', 05:52:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:52:46 INFO - '_': '/tools/buildbot/bin/python'} 05:52:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:52:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:52:46 INFO - Running setup.py (path:/tmp/pip-0ISQhh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:52:46 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)) 05:52:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:52:46 INFO - Running setup.py (path:/tmp/pip-yT11Cg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:52:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:52:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:52:46 INFO - Running setup.py (path:/tmp/pip-iZ4i_U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:52:46 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)) 05:52:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:52:46 INFO - Running setup.py (path:/tmp/pip-EkxEQk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:52:46 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)) 05:52:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:52:46 INFO - Running setup.py (path:/tmp/pip-6zv9LS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:52:46 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)) 05:52:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:52:46 INFO - Running setup.py (path:/tmp/pip-Ygld8p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:52:47 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)) 05:52:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:52:47 INFO - Running setup.py (path:/tmp/pip-5ugtc5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:52:47 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)) 05:52:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:52:47 INFO - Running setup.py (path:/tmp/pip-uGGjxh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:52:47 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)) 05:52:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:52:47 INFO - Running setup.py (path:/tmp/pip-Smi3Ab-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:52:47 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)) 05:52:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:52:47 INFO - Running setup.py (path:/tmp/pip-7zD1qD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:52:47 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)) 05:52:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:52:47 INFO - Running setup.py (path:/tmp/pip-X0WW8u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:52:47 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)) 05:52:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:52:47 INFO - Running setup.py (path:/tmp/pip-aFR59m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:52:47 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)) 05:52:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:52:47 INFO - Running setup.py (path:/tmp/pip-1FfQ94-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:52:47 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)) 05:52:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:52:47 INFO - Running setup.py (path:/tmp/pip-1yaxOt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:52:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 05:52:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:52:47 INFO - Running setup.py (path:/tmp/pip-AQGoem-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:52:47 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)) 05:52:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:52:47 INFO - Running setup.py (path:/tmp/pip-OHddOV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:52:47 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)) 05:52:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:52:47 INFO - Running setup.py (path:/tmp/pip-HIKuT7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:52:47 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)) 05:52:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:52:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:52:47 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)) 05:52:47 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)) 05:52:47 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)) 05:52:47 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:52:47 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 05:52:47 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 05:52:47 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 05:52:47 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 05:52:47 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 05:52:47 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 05:52:49 INFO - Downloading blessings-1.6.tar.gz 05:52:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:52:49 INFO - Installing collected packages: blessings 05:52:49 INFO - Running setup.py install for blessings 05:52:49 INFO - Successfully installed blessings 05:52:49 INFO - Cleaning up... 05:52:50 INFO - Return code: 0 05:52:50 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:52:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:52:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:52:50 INFO - Reading from file tmpfile_stdout 05:52:50 INFO - Current package versions: 05:52:50 INFO - argparse == 1.2.1 05:52:50 INFO - blessings == 1.6 05:52:50 INFO - blobuploader == 1.2.4 05:52:50 INFO - docopt == 0.6.1 05:52:50 INFO - functools32 == 3.2.3-2 05:52:50 INFO - jsonschema == 2.5.1 05:52:50 INFO - manifestparser == 1.1 05:52:50 INFO - mozInstall == 1.12 05:52:50 INFO - mozcrash == 1.0 05:52:50 INFO - mozdebug == 0.1 05:52:50 INFO - mozdevice == 0.48 05:52:50 INFO - mozfile == 1.2 05:52:50 INFO - mozhttpd == 0.7 05:52:50 INFO - mozinfo == 0.9 05:52:50 INFO - mozleak == 0.1 05:52:50 INFO - mozlog == 3.4 05:52:50 INFO - moznetwork == 0.27 05:52:50 INFO - mozprocess == 0.23 05:52:50 INFO - mozprofile == 0.28 05:52:50 INFO - mozrunner == 6.13 05:52:50 INFO - mozscreenshot == 0.1 05:52:50 INFO - mozsystemmonitor == 0.3 05:52:50 INFO - moztest == 0.7 05:52:50 INFO - mozversion == 1.4 05:52:50 INFO - psutil == 3.1.1 05:52:50 INFO - requests == 1.2.3 05:52:50 INFO - wsgiref == 0.1.2 05:52:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:52:50 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')]} 05:52:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:52:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:50 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')]} 05:52:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:52:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:50 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 0x7f0cf8b34f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14bc790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14b9930>, '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 0x14ba830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14bacc0>, '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-1478868532.594343-1661560718', '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 05:52:50 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 05:52:50 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 05:52:50 INFO - Using env: {'DISPLAY': ':0', 05:52:50 INFO - 'HOME': '/home/cltbld', 05:52:50 INFO - 'LANG': 'en_US.UTF-8', 05:52:50 INFO - 'LANGUAGE': 'en_US:en', 05:52:50 INFO - 'LOGNAME': 'cltbld', 05:52:50 INFO - 'MAIL': '/var/mail/cltbld', 05:52:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:52:50 INFO - 'MOZ_NO_REMOTE': '1', 05:52:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:52:50 INFO - 'NO_EM_RESTART': '1', 05:52:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:52:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:52:50 INFO - 'PWD': '/builds/slave/test', 05:52:50 INFO - 'SHELL': '/bin/bash', 05:52:50 INFO - 'SHLVL': '1', 05:52:50 INFO - 'TERM': 'linux', 05:52:50 INFO - 'TMOUT': '86400', 05:52:50 INFO - 'USER': 'cltbld', 05:52:50 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1478868532.594343-1661560718', 05:52:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:52:50 INFO - '_': '/tools/buildbot/bin/python'} 05:52:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:52:50 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)) 05:52:50 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)) 05:52:50 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)) 05:52:50 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)) 05:52:50 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)) 05:52:50 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)) 05:52:50 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)) 05:52:50 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)) 05:52:50 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)) 05:52:50 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)) 05:52:50 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)) 05:52:50 INFO - Cleaning up... 05:52:50 INFO - Return code: 0 05:52:50 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:52:50 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')]} 05:52:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:52:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:50 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')]} 05:52:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:52:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:50 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 0x7f0cf8b34f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14bc790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14b9930>, '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 0x14ba830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14bacc0>, '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-1478868532.594343-1661560718', '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 05:52:50 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 05:52:50 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 05:52:50 INFO - Using env: {'DISPLAY': ':0', 05:52:50 INFO - 'HOME': '/home/cltbld', 05:52:50 INFO - 'LANG': 'en_US.UTF-8', 05:52:50 INFO - 'LANGUAGE': 'en_US:en', 05:52:50 INFO - 'LOGNAME': 'cltbld', 05:52:50 INFO - 'MAIL': '/var/mail/cltbld', 05:52:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:52:50 INFO - 'MOZ_NO_REMOTE': '1', 05:52:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:52:50 INFO - 'NO_EM_RESTART': '1', 05:52:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:52:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:52:50 INFO - 'PWD': '/builds/slave/test', 05:52:50 INFO - 'SHELL': '/bin/bash', 05:52:50 INFO - 'SHLVL': '1', 05:52:50 INFO - 'TERM': 'linux', 05:52:50 INFO - 'TMOUT': '86400', 05:52:50 INFO - 'USER': 'cltbld', 05:52:50 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1478868532.594343-1661560718', 05:52:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:52:50 INFO - '_': '/tools/buildbot/bin/python'} 05:52:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:52:50 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:52:50 INFO - Cleaning up... 05:52:50 INFO - Return code: 0 05:52:50 INFO - Running post-action listener: _resource_record_post_action 05:52:50 INFO - Running post-action listener: _start_resource_monitoring 05:52:50 INFO - Starting resource monitoring. 05:52:50 INFO - [mozharness: 2016-11-11 13:52:50.752199Z] Finished create-virtualenv step (success) 05:52:50 INFO - [mozharness: 2016-11-11 13:52:50.752662Z] Running install step. 05:52:50 INFO - Running pre-action listener: _resource_record_pre_action 05:52:50 INFO - Running main action method: install 05:52:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:52:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:52:50 INFO - Reading from file tmpfile_stdout 05:52:50 INFO - Detecting whether we're running mozinstall >=1.0... 05:52:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:52:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:52:51 INFO - Reading from file tmpfile_stdout 05:52:51 INFO - Output received: 05:52:51 INFO - Usage: mozinstall [options] installer 05:52:51 INFO - Options: 05:52:51 INFO - -h, --help show this help message and exit 05:52:51 INFO - -d DEST, --destination=DEST 05:52:51 INFO - Directory to install application into. [default: 05:52:51 INFO - "/builds/slave/test"] 05:52:51 INFO - --app=APP Application being installed. [default: firefox] 05:52:51 INFO - mkdir: /builds/slave/test/build/application 05:52:51 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'] 05:52:51 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 05:53:07 INFO - Reading from file tmpfile_stdout 05:53:07 INFO - Output received: 05:53:07 INFO - /builds/slave/test/build/application/firefox/firefox 05:53:07 INFO - Running post-action listener: _resource_record_post_action 05:53:07 INFO - [mozharness: 2016-11-11 13:53:07.916751Z] Finished install step (success) 05:53:07 INFO - [mozharness: 2016-11-11 13:53:07.916997Z] Running run-tests step. 05:53:07 INFO - Running pre-action listener: _resource_record_pre_action 05:53:07 INFO - Running main action method: run_tests 05:53:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:53:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:53:07 INFO - Python 2.7.3 05:53:07 INFO - Return code: 0 05:53:07 INFO - grabbing minidump binary from tooltool 05:53:07 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')]} 05:53:07 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 0x14b9930>, '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 0x14ba830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14bacc0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:53:07 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 05:53:07 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 05:53:07 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 05:53:07 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:53:07 INFO - Return code: 0 05:53:07 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:53:07 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:53:07 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:53:07 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:53:07 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:53:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/didJpmEMRayoj4gBJxkTxw/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_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 05:53:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/didJpmEMRayoj4gBJxkTxw/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_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 05:53:08 INFO - Using env: {'DISPLAY': ':0', 05:53:08 INFO - 'HOME': '/home/cltbld', 05:53:08 INFO - 'LANG': 'en_US.UTF-8', 05:53:08 INFO - 'LANGUAGE': 'en_US:en', 05:53:08 INFO - 'LOGNAME': 'cltbld', 05:53:08 INFO - 'MAIL': '/var/mail/cltbld', 05:53:08 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:53:08 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:53:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:53:08 INFO - 'MOZ_NO_REMOTE': '1', 05:53:08 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:53:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:53:08 INFO - 'NO_EM_RESTART': '1', 05:53:08 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:53:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:53:08 INFO - 'PWD': '/builds/slave/test', 05:53:08 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:53:08 INFO - 'SHELL': '/bin/bash', 05:53:08 INFO - 'SHLVL': '1', 05:53:08 INFO - 'TERM': 'linux', 05:53:08 INFO - 'TMOUT': '86400', 05:53:08 INFO - 'USER': 'cltbld', 05:53:08 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1478868532.594343-1661560718', 05:53:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:53:08 INFO - '_': '/tools/buildbot/bin/python'} 05:53:08 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/didJpmEMRayoj4gBJxkTxw/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_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 05:53:08 INFO - mozversion application_buildid: 20161111030203 05:53:08 INFO - mozversion application_changeset: d38d06f85ef59c5dbb5d4a1a8d895957a78714de 05:53:08 INFO - mozversion application_display_name: Nightly 05:53:08 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:53:08 INFO - mozversion application_name: Firefox 05:53:08 INFO - mozversion application_remotingname: firefox 05:53:08 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:53:08 INFO - mozversion application_vendor: Mozilla 05:53:08 INFO - mozversion application_version: 52.0a1 05:53:08 INFO - mozversion platform_buildid: 20161111030203 05:53:08 INFO - mozversion platform_changeset: d38d06f85ef59c5dbb5d4a1a8d895957a78714de 05:53:08 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:53:08 INFO - mozversion platform_version: 52.0a1 05:53:08 INFO - using testdate: 1478872388 05:53:08 INFO - actual date: 1478872388 05:53:08 INFO - starting webserver on 'localhost:40089' 05:53:08 INFO - SUITE-START | Running 2 tests 05:53:08 INFO - TEST-START | dromaeo_css 05:53:08 INFO - operating with platform_type : linux_ 05:53:08 INFO - Initialising browser for dromaeo_css test... 05:53:08 INFO - TEST-INFO | started process 7059 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpehLWkf/profile http://localhost:40089/getInfo.html) 05:53:12 INFO - PROCESS | 7059 | __metrics Screen width/height:1600/1200 05:53:12 INFO - PROCESS | 7059 | colorDepth:24 05:53:12 INFO - PROCESS | 7059 | Browser inner width/height: 1024/697 05:53:12 INFO - PROCESS | 7059 | __metrics 05:53:13 INFO - PROCESS | 7059 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:53:13 INFO - PROCESS | 7059 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:53:14 INFO - TEST-INFO | 7059: exit 0 05:53:14 INFO - Browser initialized. 05:53:14 INFO - Running cycle 1/1 for dromaeo_css test... 05:53:14 INFO - TEST-INFO | started process 7143 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpehLWkf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:53:26 INFO - PROCESS | 7143 | RSS: Main: 173322240 05:53:26 INFO - PROCESS | 7143 | 05:54:17 INFO - PROCESS | 7143 | 1478872457995 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] 05:56:28 INFO - PROCESS | 7143 | Cycle 1(1): loaded http://localhost:40089/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40089/tests/dromaeo/cssquery-ext.html) 05:56:30 INFO - PROCESS | 7143 | RSS: Main: 294404096 05:56:30 INFO - PROCESS | 7143 | 05:59:32 INFO - PROCESS | 7143 | Cycle 1(1): loaded http://localhost:40089/tests/dromaeo/cssquery-ext.html (next: http://localhost:40089/tests/dromaeo/cssquery-jquery.html) 05:59:33 INFO - PROCESS | 7143 | RSS: Main: 282869760 05:59:33 INFO - PROCESS | 7143 | 06:02:35 INFO - PROCESS | 7143 | Cycle 1(1): loaded http://localhost:40089/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40089/tests/dromaeo/cssquery-mootools.html) 06:02:36 INFO - PROCESS | 7143 | RSS: Main: 250765312 06:02:36 INFO - PROCESS | 7143 | 06:05:38 INFO - PROCESS | 7143 | Cycle 1(1): loaded http://localhost:40089/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40089/tests/dromaeo/cssquery-prototype.html) 06:05:38 INFO - PROCESS | 7143 | RSS: Main: 260251648 06:05:38 INFO - PROCESS | 7143 | 06:08:41 INFO - PROCESS | 7143 | Cycle 1(1): loaded http://localhost:40089/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40089/tests/dromaeo/cssquery-yui.html) 06:08:42 INFO - PROCESS | 7143 | RSS: Main: 216395776 06:08:42 INFO - PROCESS | 7143 | 06:11:44 INFO - PROCESS | 7143 | Cycle 1(1): loaded http://localhost:40089/tests/dromaeo/cssquery-yui.html (next: http://localhost:40089/tests/dromaeo/cssquery-dojo.html) 06:11:45 INFO - PROCESS | 7143 | RSS: Main: 307679232 06:11:45 INFO - PROCESS | 7143 | 06:11:45 INFO - PROCESS | 7143 | __start_tp_report 06:11:45 INFO - PROCESS | 7143 | _x_x_mozilla_page_load 06:11:45 INFO - PROCESS | 7143 | _x_x_mozilla_page_load_details 06:11:45 INFO - PROCESS | 7143 | |i|pagename|runs| 06:11:45 INFO - PROCESS | 7143 | |0;dojo.html;2969.6584892737333;2984.8209107453567;3018.652854921684;3030.378772351668;3034.7572194224463;5212.270282160496;5252.343457067866;5266.157414813631;5328.120860058096;5344.305240318753;5270.868228294285;5322.733863306838;5376.704281264529;5387.865303367418;5426.8371948841495;4731.8817029574275;4759.357486739281;4778.116048531033;4791.928121078186;4826.589739872115;4866.975665121669;4912.361393018902;4915.82794602189;4916.655834091615;4957.82647607332;4694.178518759238;4841.588464980481;4847.345608342864;4864.270359446076;4937.530934561229;4728.338032675429;4777.856664300077;4788.090262850047;4821.059893320804;4821.445533763627;4821.22860342347;4823.20417131173;4827.806887724522;4865.829695960624;4887.608991280689;5372.892542149174;5401.567874570025;5409.891802163974;5416.052190866582;5417.214503896913;5547.916781248285;5570.944290557083;5586.525145362649;5615.241942337814;5779.971100144515;5662.178984047331;5689.203511508392;5728.8854222915725;5730.19777231188;5740.942590574083;5277.70972596507;5279.868003299872;5285.471452854761;5285.762140703678;5333.546648534841;5590.273264475592;5694.515966142924;5752.9424705753245;5790.536757059425;5796.101604251264;5626.212330273765;5648.15277708347;5650.5479561634975;5686.516646085046;5695.686737229409;5676.744546495418;5685.061964775766;5713.314402271754;5723;5730;5489.39616642169;5498.890022199534;5666.348369937427;5717.799877004368;5731.713414329267;5573.749181286852;5591.04952158126;5594.244776955059;5707.200991861143;5794.942050579524;4321.2653848845775;4336.0243945112725;4337.0458499130145;4339.370791235253;4372.519022907478;3820.331441997639;3832.9425058624142;3864.401017842239;3875.9224815504094;3885.941710874339;5409.675419474844;5471.6169868108855;5478.096114141202;5483.588730845203;5529.391766905637;5774.307083150049;5783.074708046693;5788.565857560699;5810.331811841608;5811.186433899257;5289.867753306198;5341.225522299244;5346.518813306821;5487.972560137174;5493.093639549509;4909.95090049095;4938.580220681282;4940.876478088005;4946.975265123723;4950.851474455772;5806.390329015477;5820.126980952721;5821.767129314865;5822.563307751935;5824.854378640568;5631.8592035199445;5671.971640141773;5702.144678298288;5703.914441283467;5706.372299047019;5748.223989761496;5794.449527294901;5797.391273916178;5799.246098007232;5803.593748437569;5537.529310008695;5582.134769110794;5602.887942241214;5606.355269144101;5613.46672066153;5667.404922483245;5667.603267771381;5670.234518340137;5697.800576979786;5709.857253568694;5619.747111380079;5626.212330273846;5636.915446268227;5636.915446268391;5638.097904335451;5446.809361672323;5489.58828087903;5590.217369568345;5596.692181930033;5599.384067752625;5516.089845175501;5518.420565840529;5569.610127291051;5615.971920140537;5665.461781130786;5691.4877661010705;5706.4864162225595;5707.600467967202;5718.599698021098;5720.599558031065;5381.13901775714;5533.2253484513;5544.057510223352;5570.164475328571;5578.693171875586 06:11:45 INFO - PROCESS | 7143 | |1;ext.html;556.3433517957636;590.6279044202153;611.947984421324;628.4187126907609;631.1700114349627;31650.683493165063;33608.66391336086;33794;33810.830945845264;40577.18845623093;42583.148337033315;42586.361204581954;42613.36079958803;42621.573784262146;42699.57300426995;8527.616257268422;8663.39356245063;8673.219410253076;8677.219050285474;8677.95661021694;8010.359171266314;8193.303569196625;8502.107278735737;8603.48379097253;8609.913900861005;10001.749956251115;10218.386896786216;10226.43754593497;10531.73670658232;10548.630797922075;10341.276110672256;10368.01503857136;10402.895971040269;10411;10418.114460270886;9931.950340248324;9962.850557241647;9970.601175952954;9981;9982.051705088004;38967.22065558673;39219.60780392188;39280.80359598212;39292.60707392947;39324.60675393267;3646.288973650113;3889.3971434427426;3912.3615038014636;3975.3043217436834;4100.425940368351;29799.40401191964;30343.69656303453;30669;30683;30734;4103;4171.582841715835;4340.110277393158;4340.739555626673;4379.408779814716;310070;310932;311162;312883;313624.99999999773;34058.65941340555;35114.648853511135;54546.727266363414;54831;54863;35929.640703593155;36110.09724756902;36117.45823812645;36125.81937090298;36186.27627447489;14734.336954837057;14824;14824.40702371893;14826.406943722346;14830.62923426923;12881.420336084899;12955.352232388343;12958.157719748375;12960.222386656831;12969;8142.226488483585;8190.918090819016;8225.383096267804;8502.277306429023;8519.446235994641;3262.4503360903855;3293.91765205867;3303.4219011672863;3319.3859136059423;3319.751018673609;974.8878878928872;1016.0601443664581;1018.0735530667057;1053.1153830782027;1081.799867024603;31558.684413156032;33148.834255829046;34267.657323426945;34450.827745861614;36236.45645315322;1070.983935240972;1095.5015467962057;1108.2851560743275;1113.1373185780922;1117.6758739965483;15619.794316266254;16820.915895420443;16870.746938795928;16873.578160546083;17020.319187232373;431466;442941;444280;444965;445563;50572.494275057514;51073.489265107615;54580.45419545754;55503.612409689275;56111;1364.5565191312862;1372.378756574957;1399.7900314952635;1414.1656422710444;1422.530564913576;30074.656579733924;32564.51153232751;32707.836460817543;32742;32788.83605581957;48725.75637121792;49384.75307623439;49551;49555.25667115068;49563;356347;359029;359181;360232;360669;40381.596184037786;40873.38689919713;41898;41898.79050604849;41919.37120943127;44517;44949.325760114276;45284.77357613323;45444.318335224336;45867;37953.62046379501;38282.80858595689;38643.03392415212;40197.1960560793;40220;37961.43057854079;38360.80819595884;38461;39477.60522394854;39697.40453893252;39138.533873908156;39153;39607;39785.80107099446;39824.80087599543;32345.676543235208;34332.31335373229;34415.32268097143;35084.473732893515;35178.47232291466;26508.204753857415;26889.596656050566;27250.863745681145;27409.862950685118;28779 06:11:45 INFO - PROCESS | 7143 | |2;jquery.html;369.17489411166054;377.52431935760933;390.36760448074114;400.6894656641103;414.3908454571778;14069.296535173238;15474.767878481818;17804.28782848688;18494.907525462353;18538.351157709483;18821.905890470527;18886.433406997778;18919.905400473013;19014.80985190148;19208.711869321938;4112.958870411302;5365.436629153932;5588.608797384185;5600.327960644729;5662.462066103713;4249.638780703628;6011.188489553898;6260.280067792217;6330.873382532347;6434.195725534309;6174.783882564111;6330.65181415022;6354.428101470867;6384.457321127709;6396.744130234785;6345.175127233476;6384.7126879290545;6387.936120638804;6391.360863913595;6392.744290228386;5431.212474191259;5622.662640241599;5662.09406494963;5664.858378540528;5674.290713660793;22222.222222222146;22878.54242915149;22989.88505057464;23015.53968920629;23312.533749324917;2311.9884400578057;2329.4176455886027;2344.0389440329554;2453.987730061356;2512.371907023244;13606.727865442635;13886.93056534721;13966.790498142536;14305.070170438888;14774.852251477563;1778.1376032624166;1825.525363405511;1834.8899066056078;1879.5489082620209;1883.6138591588692;75674.62162689152;76670.23329766742;78715.21284787136;79175;80091;10238.129758970423;10461.68614941553;10555;10767.6231331903;10971.396573188551;15072.472463463726;15093;15095.773563396559;15104.697906041818;15114.470993515175;7767.844643107106;8136.389770767216;8157.265846073763;8300.128486508951;8335.208155225366;7800.414968877357;7826.530408175528;7839.628065088701;8075.475094118863;8086.029676438865;6537.771178008747;6573.469214352509;6583.769568065095;6627.5029372797235;6759.932400675931;1847.2426305215065;1863.506170864722;1893.4792931943825;1917.5589614388768;1931.9323823666105;878.5212059427499;983.1986930651497;1026.5996261458038;1051.9579216831394;1068.7915856407926;18583.53541161482;19079;19258.71111933322;19631.803681962996;19669.803301966796;978.8433850583872;1011.1051719228535;1044.4099084017505;1046.2989796836139;1050.2910535388583;10252.313161928909;11097.38964356968;11110.833337499944;11129.777404452028;11145.72135696614;338233;340569;465223;465511;470304;89857.55071224603;91832;94934;96112;96751;1025.8666373371414;1040.0483557544762;1057.0909018244304;1104.4146602300793;1105.745678493951;16799.91600041992;16839.831601683825;17866.5533361667;18011.639767204844;18141.45575632733;39000.414993774546;39185;39619.60380396159;39892.60107399005;39893.60106398899;55316.17025744537;56733;57068;57820.421795781505;59591;8213.685810270328;8367.916320836714;8389.370797190113;8577.142285771373;8603.741887743377;11350.659480215607;12949.352532373532;13054.673633159247;13265.270410127536;13364.131331463424;11168.38573878412;11242;11513.769724605294;11742.823857641972;11972.341521216069;11102.2783519071;11244.493997770283;11285.37930413835;11350.375729334966;11716.589919352782;8477.533735644598;11575.88424115748;11642.417879105842;11716.23844450108;11976.101792365782;8324.583770811556;8575.442596231225;8643.308535317034;8659.177378149066;8686.438560190292;8913.37606367548;11109.222354435113;11408.657740267805;11433.256838305817;11964.222325548812 06:11:45 INFO - PROCESS | 7143 | |3;mootools.html;1317.6508225320297;1422.0330175480676;1469;1536.761801920702;1689.2820551265718;7144.106986626672;8094.838103237932;8306.54314012729;8321.459105158168;8584.098669639692;8421.915780842204;8493.150684931505;8507.404481686284;8510.446820956633;8517.06312305646;2259.751427342991;2266.3427605994243;2274.5109801392696;2303.0787684925995;2303.6429353450244;2283.5318759654233;2317.5249073939885;2344.7303560090554;2349.9647505287435;2350.976490235093;2191.6493361062235;2197.0113448948036;2223.6108680980765;2270.648049552322;2284.017872314904;2257.920972765962;2272.545490901818;2276.7381751098587;2291.6562515622622;2294.9541009179807;2283.303592404316;2301.608726516496;2302.82728795341;2305.5734689082406;2307.1924826310824;8334.749957501284;8406.159384061606;8455.788605284917;8463.534505602189;8471.661133554651;5128.487151284841;5251.947480525184;5255.921161182585;5278.551323137538;5318.228856815779;3341.3818443588016;3397.7281817454545;3459.498372735939;3463.2034632034774;3503.8948831535095;1132.722482991664;1135.528755566439;1152.1992215410294;1155.2952698853692;1156.1097954575014;11424.657260282205;11430.971212590906;11531.884681153166;11539.884601153964;11546.711332216677;4246.278132717445;4389.539098394686;4432.113577284556;4441.244988351923;4477.350784136347;9170.312226583033;9177.77055573616;9207.125323094295;9210.677626283048;9234;5188.507091826346;5190.714510701872;5193.143131383355;5196.92204616931;5198.038362902875;4182.456280683492;4278.679099067583;4739.075880203327;4824.614030877521;4831.855044348676;3549.2369140634887;3623.3296840084668;3641.071526760712;3713.517242758424;3716.7955762433326;1123.9325640461598;1129.9548018079186;1132.213111887247;1134.0643968725835;1137.9829302560468;798.972035978738;837.9874301885477;939.4222553129913;963.3016063354012;969.2100937735722;5306.54894333986;5453.536449401766;5529.778808847682;5601.5238704709745;5900.144479050514;924.5007695844304;959.8848138223458;960.6493629825063;968.9127978481971;971.5336638413601;3982.4623675803396;4026.516817981861;4199.940552858465;4296.957030429656;4329.112531930947;9913.107820296207;10215.540300686487;10379.11777498906;10397.428141452292;10414.218933580012;10063.748406289755;10160.33957792741;10354.637587684394;10359.741006474747;10453.738656533647;7711.652975616111;7930.246626570582;7931.246531579491;7932.0169957510625;7934.365250779923;5578.442155784389;5652.689102099424;5686.744096515749;5722.484976352148;5943.257092863392;9284.860727088964;9323.300752443729;9410.717678469657;9415.623375065195;9417.717468475958;9324.300677449353;9387.202087822612;9423.434593924387;9485.857712134186;9529.761755956157;7879.290863822283;8046.83906321882;8161.347092232489;8174.959125204336;8179.182081791773;7740.496867703581;7892.382061677457;7905.367570594453;7906.446548741533;7953.085395179628;7230.891536626849;7311.268873112646;7319.560826350436;7327.34053935127;7415.925840741739;6936.7572134975035;7008.159020917523;7121.608311542707;7196.532225405332;7243.746468873775;6642.036904648896;6756.594604323756;6768.627725475146;6832;6835.93164068353;4946.851594452172;4966.528179822911;5005.399352077774;5053.191489361684;5192.324997750268;5050.123319277494;5104.4129925057605;5128.410232823273;5180.818671346636;5284.286621306074 06:11:45 INFO - PROCESS | 7143 | |4;prototype.html;327.5610681686541;331.9651436599157;341.60715177545814;344.3973047167457;348.78549691939463;5075.822346217874;5187.974060129694;5209.84370468886;5274.103402421588;5274.4461831507715;5025.632826006576;5094.184930411135;5132.20450830121;5134.229865520174;5180.352455943007;4000.2599519088917;4009.1781184857036;4022.3966405039187;4080.4287399764057;4091.4067460218325;3944.777119093076;4018.236535058344;4029.556748757649;4056.2495938251373;4074.775887326196;3963.326234540135;3983.8008099594904;4000.219957108365;4006.3589825627905;4014.487323591857;3977.880663580097;3985.362342025262;3995.2808494470983;4007.7156021068004;4013.8394464221396;3601.2077342984503;3608.3144202601684;3609.675129238355;3616.2405894762132;3641.7632853864416;4897.118518666639;5004.374453193351;5012.248162775576;5015.974920125376;5046.873828154289;4584.5873871351405;4599.632029437637;4600.895785011607;4622.745748983804;4626.653001024936;5322.2548843161985;5331.760070796785;5349.919751203735;5364.624476286662;5366.6511676741275;3837.539495260559;3872.341701910682;3923.901902452433;3940.7438516496336;3975.3241948868763;5534.557235421156;5539.944600553983;5552.805651802208;5558.998760446236;5571.693556854371;4007.913906292197;4011.438398624195;4030.2544029354663;4031.455753473302;4065.0853557949226;3963.36586146221;4104.651104656078;4110.301248787713;4119.114390406077;4169.437125988014;4578.977874602746;4592.724436533818;4654.418197725285;4674.527523829983;4695.319178719066;5388.521280211068;5391.56867450603;5401.837944861661;5403.540699040547;5408.91886621701;1329.7074643578396;1349.466960550577;1359.9932000339934;1382.523029554802;1385.3835043405588;976.2580438866513;979.294907666479;988.9653862114935;1008.5325850886942;1009.8384258518602;5028.396592408934;5036.899262014739;5072.047261804232;5095.668781529189;5110.514501122388;5297.437256009486;5329.760160792774;5334.75993580282;5335.733213339395;5344.465553444625;4907.1903135982875;5048.974755126274;5049.84850454487;5073.974630126826;5074.5686616637995;2807.1157585360547;2851.201663534214;2858.2139911524496;2878.654561452597;2883.8990635327664;5471.662286005533;5494.406622079552;5502.752376143083;5504.394516603171;5537.2524709163745;5351.411344752074;5452.318460192476;5475.288212532345;5480.205370221295;5536.446355364431;5385.38068122171;5397.622166448311;5472.589555783253;5476.424975377608;5483.4516548344845;5210.426853046238;5296.285001524745;5324.361076670824;5358.303420555303;5391.29913111293;5281.55106815925;5305.965336759295;5309.203619456958;5322.54758345545;5340.465953404629;5381.48875856793;5382.461753824587;5389.784408623611;5392.838214853404;5434.174229400768;3728.217074414403;3913.434626149563;3923.7242399407705;3929.9607003929596;3943.6845052395165;5285.709285989307;5296.848375216894;5302.39022512416;5318.680879147263;5333.679979201261;5271.4960393812635;5330.067238233216;5421.484958928895;5433.42430695094;5474.562035037267;5413.593980451561;5413.675179489243;5417.049862049737;5431.701256430776;5434.64687283018;5185.377754669464;5296.735163241746;5321.255024296679;5347;5365.195220716923;5401.189821526646;5421.644588852787;5426.755795989111;5440.836774896759;5448.700321482198;5312.7343632818975;5350.5184533392185;5356.812511562077;5358.48151368856;5381.865453363697 06:11:45 INFO - PROCESS | 7143 | |5;yui.html;674.2717864706117;699.7410957945561;723.5188599581279;736.473421503625;742.0353540397485;13545.322733863304;14526.78209826852;14535.78196327056;14609.780853287197;14624.049436786601;13146.934265328684;13459.46162153515;13476.932615336935;13489.595312140627;13508.324583770796;658.5850913924221;668.4218151299116;750.6959681329071;770.5261264322429;772.97681069568;776.8718161503346;777.0364747712852;783.9059312882462;784.19228194959;785.579714852554;826.5247482697444;827.606886728802;827.6896163938524;827.7144385187131;828.1470085811624;690.689189864563;700.9719611215545;701.5124488480508;713.7858642407257;827.1149869639488;592.3927973826819;602.340437221242;606.1362558354372;612.4671535763914;612.770211170811;13472.663183420394;13501.59495215145;13554.796678049837;13561.796573051313;13565.25391103489;12300.507979680802;12616.306103164323;12664.240145591293;12818.423170957329;12964.286964216964;11344.659660210207;11354.60258890943;11405.600803971822;11417;11499.965003149673;4103.261412945669;4107.630313271819;4149.066460046495;4210.85262015831;4223.324268117117;52227.47772522302;56899.14651280234;57280.42719572793;57818;59577.40422595805;10390.896091039143;10397.84403233952;10689.732756681145;10732.624358147428;10773.78452430947;18633.627327453374;18635;18649.90675046616;18747.718784218247;19187.616247674967;7891.171427000198;8082.434229603989;8095;8205.58972051395;8318;4344.218040752695;4403.405540252089;4407.933880991788;4548.909021819545;4564.79458424365;3197.5043868200464;3245.1724810173255;3294.8797408881096;3333.0500807269814;3335.7331413486863;643.1542521584101;643.7231990244146;652.292262894755;659.4098282037645;668.8628831089615;682.6040896280145;717.6626985316892;736.8157960509873;744.7765670298888;767.5816679909462;8759.474431534129;8771.605277762515;9139.680111196076;9142.63429462814;9241.630334786667;606.263389981175;614.8893199224183;677.0994577212296;723.2044750774106;743.2604558464362;3720.296549700906;4139.130782535702;4141.159702873766;4169.374593810952;4194.580541945842;58995;70768;71911;73464.63267683628;81696;45203.32195017077;55123;68426.315736843;72592.63703681447;72831;66499.33500664931;68137.65931170313;68793.65603171852;68796.6560167196;69136.65431672809;8941;9066.909330906607;9246.768830779285;9264.39781414206;9281.443113413217;32603.85886493961;36576.08559786026;42985.785071074446;44872.77563612161;47014.76492617515;39465.60534394734;39622.80188599038;48704.51295487;59870;60213.096803548855;11779.705507362041;11792.23350482216;12157.574484892986;12374.752504950031;12712.872871271538;11953.163278570417;12965.22208667483;12967.740645187232;12967.935160324138;12980.675483112998;10236.795264094826;10524.105451036748;10825.458727063773;12011.339376334385;12013;11947.969163961003;12414.379281036092;12448.439820208294;12609.43257553394;12707.618771436872;11270.718232044264;11716.648500544998;11803.428662344555;11910.166288359731;12156.452959617016;9618.711438656852;9939.403635781877;10035.799284014132;10292.279540432397;10368.170546356425;9937.503124843584;10091.848622270818;10336.431496267778;10416.114630256514;10535.20985926074 06:11:45 INFO - PROCESS | 7143 | __end_tp_report 06:11:45 INFO - PROCESS | 7143 | __start_cc_report 06:11:45 INFO - PROCESS | 7143 | _x_x_mozilla_cycle_collect,1223 06:11:45 INFO - PROCESS | 7143 | __end_cc_report 06:11:45 INFO - PROCESS | 7143 | __startTimestamp1478873505172__endTimestamp 06:11:45 INFO - PROCESS | 7143 | 06:11:45 INFO - PROCESS | 7143 | ------- Summary: start ------- 06:11:45 INFO - PROCESS | 7143 | Number of tests: 6 06:11:45 INFO - PROCESS | 7143 | 06:11:45 INFO - PROCESS | 7143 | [#0] dojo.html Cycles:165 Average:5289.02 Median:5533.23 stddev:609.52 (11.0%) stddev-sans-first:583.60 06:11:45 INFO - PROCESS | 7143 | Values: 2969.7 2984.8 3018.7 3030.4 3034.8 5212.3 5252.3 5266.2 5328.1 5344.3 5270.9 5322.7 5376.7 5387.9 5426.8 4731.9 4759.4 4778.1 4791.9 4826.6 4867.0 4912.4 4915.8 4916.7 4957.8 4694.2 4841.6 4847.3 4864.3 4937.5 4728.3 4777.9 4788.1 4821.1 4821.4 4821.2 4823.2 4827.8 4865.8 4887.6 5372.9 5401.6 5409.9 5416.1 5417.2 5547.9 5570.9 5586.5 5615.2 5780.0 5662.2 5689.2 5728.9 5730.2 5740.9 5277.7 5279.9 5285.5 5285.8 5333.5 5590.3 5694.5 5752.9 5790.5 5796.1 5626.2 5648.2 5650.5 5686.5 5695.7 5676.7 5685.1 5713.3 5723.0 5730.0 5489.4 5498.9 5666.3 5717.8 5731.7 5573.7 5591.0 5594.2 5707.2 5794.9 4321.3 4336.0 4337.0 4339.4 4372.5 3820.3 3832.9 3864.4 3875.9 3885.9 5409.7 5471.6 5478.1 5483.6 5529.4 5774.3 5783.1 5788.6 5810.3 5811.2 5289.9 5341.2 5346.5 5488.0 5493.1 4910.0 4938.6 4940.9 4947.0 4950.9 5806.4 5820.1 5821.8 5822.6 5824.9 5631.9 5672.0 5702.1 5703.9 5706.4 5748.2 5794.4 5797.4 5799.2 5803.6 5537.5 5582.1 5602.9 5606.4 5613.5 5667.4 5667.6 5670.2 5697.8 5709.9 5619.7 5626.2 5636.9 5636.9 5638.1 5446.8 5489.6 5590.2 5596.7 5599.4 5516.1 5518.4 5569.6 5616.0 5665.5 5691.5 5706.5 5707.6 5718.6 5720.6 5381.1 5533.2 5544.1 5570.2 5578.7 06:11:45 INFO - PROCESS | 7143 | 06:11:45 INFO - PROCESS | 7143 | [#1] ext.html Cycles:180 Average:52584.58 Median:20799.95 stddev:98866.28 (475.3%) stddev-sans-first:99066.45 06:11:45 INFO - PROCESS | 7143 | Values: 556.3 590.6 611.9 628.4 631.2 31650.7 33608.7 33794.0 33810.8 40577.2 42583.1 42586.4 42613.4 42621.6 42699.6 8527.6 8663.4 8673.2 8677.2 8678.0 8010.4 8193.3 8502.1 8603.5 8609.9 10001.7 10218.4 10226.4 10531.7 10548.6 10341.3 10368.0 10402.9 10411.0 10418.1 9932.0 9962.9 9970.6 9981.0 9982.1 38967.2 39219.6 39280.8 39292.6 39324.6 3646.3 3889.4 3912.4 3975.3 4100.4 29799.4 30343.7 30669.0 30683.0 30734.0 4103.0 4171.6 4340.1 4340.7 4379.4 310070.0 310932.0 311162.0 312883.0 313625.0 34058.7 35114.6 54546.7 54831.0 54863.0 35929.6 36110.1 36117.5 36125.8 36186.3 14734.3 14824.0 14824.4 14826.4 14830.6 12881.4 12955.4 12958.2 12960.2 12969.0 8142.2 8190.9 8225.4 8502.3 8519.4 3262.5 3293.9 3303.4 3319.4 3319.8 974.9 1016.1 1018.1 1053.1 1081.8 31558.7 33148.8 34267.7 34450.8 36236.5 1071.0 1095.5 1108.3 1113.1 1117.7 15619.8 16820.9 16870.7 16873.6 17020.3 431466.0 442941.0 444280.0 444965.0 445563.0 50572.5 51073.5 54580.5 55503.6 56111.0 1364.6 1372.4 1399.8 1414.2 1422.5 30074.7 32564.5 32707.8 32742.0 32788.8 48725.8 49384.8 49551.0 49555.3 49563.0 356347.0 359029.0 359181.0 360232.0 360669.0 40381.6 40873.4 41898.0 41898.8 41919.4 44517.0 44949.3 45284.8 45444.3 45867.0 37953.6 38282.8 38643.0 40197.2 40220.0 37961.4 38360.8 38461.0 39477.6 39697.4 39138.5 39153.0 39607.0 39785.8 39824.8 32345.7 34332.3 34415.3 35084.5 35178.5 26508.2 26889.6 27250.9 27409.9 28779.0 06:11:45 INFO - PROCESS | 7143 | 06:11:45 INFO - PROCESS | 7143 | [#2] jquery.html Cycles:180 Average:26873.84 Median:12820.98 stddev:69796.29 (544.4%) stddev-sans-first:69963.71 06:11:45 INFO - PROCESS | 7143 | Values: 369.2 377.5 390.4 400.7 414.4 14069.3 15474.8 17804.3 18494.9 18538.4 18821.9 18886.4 18919.9 19014.8 19208.7 4113.0 5365.4 5588.6 5600.3 5662.5 4249.6 6011.2 6260.3 6330.9 6434.2 6174.8 6330.7 6354.4 6384.5 6396.7 6345.2 6384.7 6387.9 6391.4 6392.7 5431.2 5622.7 5662.1 5664.9 5674.3 22222.2 22878.5 22989.9 23015.5 23312.5 2312.0 2329.4 2344.0 2454.0 2512.4 13606.7 13886.9 13966.8 14305.1 14774.9 1778.1 1825.5 1834.9 1879.5 1883.6 75674.6 76670.2 78715.2 79175.0 80091.0 10238.1 10461.7 10555.0 10767.6 10971.4 15072.5 15093.0 15095.8 15104.7 15114.5 7767.8 8136.4 8157.3 8300.1 8335.2 7800.4 7826.5 7839.6 8075.5 8086.0 6537.8 6573.5 6583.8 6627.5 6759.9 1847.2 1863.5 1893.5 1917.6 1931.9 878.5 983.2 1026.6 1052.0 1068.8 18583.5 19079.0 19258.7 19631.8 19669.8 978.8 1011.1 1044.4 1046.3 1050.3 10252.3 11097.4 11110.8 11129.8 11145.7 338233.0 340569.0 465223.0 465511.0 470304.0 89857.6 91832.0 94934.0 96112.0 96751.0 1025.9 1040.0 1057.1 1104.4 1105.7 16799.9 16839.8 17866.6 18011.6 18141.5 39000.4 39185.0 39619.6 39892.6 39893.6 55316.2 56733.0 57068.0 57820.4 59591.0 8213.7 8367.9 8389.4 8577.1 8603.7 11350.7 12949.4 13054.7 13265.3 13364.1 11168.4 11242.0 11513.8 11742.8 11972.3 11102.3 11244.5 11285.4 11350.4 11716.6 8477.5 11575.9 11642.4 11716.2 11976.1 8324.6 8575.4 8643.3 8659.2 8686.4 8913.4 11109.2 11408.7 11433.3 11964.2 06:11:45 INFO - PROCESS | 7143 | 06:11:45 INFO - PROCESS | 7143 | [#3] mootools.html Cycles:180 Average:5534.76 Median:5192.73 stddev:3061.76 (59.0%) stddev-sans-first:3053.94 06:11:45 INFO - PROCESS | 7143 | Values: 1317.7 1422.0 1469.0 1536.8 1689.3 7144.1 8094.8 8306.5 8321.5 8584.1 8421.9 8493.2 8507.4 8510.4 8517.1 2259.8 2266.3 2274.5 2303.1 2303.6 2283.5 2317.5 2344.7 2350.0 2351.0 2191.6 2197.0 2223.6 2270.6 2284.0 2257.9 2272.5 2276.7 2291.7 2295.0 2283.3 2301.6 2302.8 2305.6 2307.2 8334.7 8406.2 8455.8 8463.5 8471.7 5128.5 5251.9 5255.9 5278.6 5318.2 3341.4 3397.7 3459.5 3463.2 3503.9 1132.7 1135.5 1152.2 1155.3 1156.1 11424.7 11431.0 11531.9 11539.9 11546.7 4246.3 4389.5 4432.1 4441.2 4477.4 9170.3 9177.8 9207.1 9210.7 9234.0 5188.5 5190.7 5193.1 5196.9 5198.0 4182.5 4278.7 4739.1 4824.6 4831.9 3549.2 3623.3 3641.1 3713.5 3716.8 1123.9 1130.0 1132.2 1134.1 1138.0 799.0 838.0 939.4 963.3 969.2 5306.5 5453.5 5529.8 5601.5 5900.1 924.5 959.9 960.6 968.9 971.5 3982.5 4026.5 4199.9 4297.0 4329.1 9913.1 10215.5 10379.1 10397.4 10414.2 10063.7 10160.3 10354.6 10359.7 10453.7 7711.7 7930.2 7931.2 7932.0 7934.4 5578.4 5652.7 5686.7 5722.5 5943.3 9284.9 9323.3 9410.7 9415.6 9417.7 9324.3 9387.2 9423.4 9485.9 9529.8 7879.3 8046.8 8161.3 8175.0 8179.2 7740.5 7892.4 7905.4 7906.4 7953.1 7230.9 7311.3 7319.6 7327.3 7415.9 6936.8 7008.2 7121.6 7196.5 7243.7 6642.0 6756.6 6768.6 6832.0 6835.9 4946.9 4966.5 5005.4 5053.2 5192.3 5050.1 5104.4 5128.4 5180.8 5284.3 06:11:45 INFO - PROCESS | 7143 | 06:11:45 INFO - PROCESS | 7143 | [#4] prototype.html Cycles:180 Average:4501.44 Median:5133.22 stddev:1290.31 (25.1%) stddev-sans-first:1255.32 06:11:45 INFO - PROCESS | 7143 | Values: 327.6 332.0 341.6 344.4 348.8 5075.8 5188.0 5209.8 5274.1 5274.4 5025.6 5094.2 5132.2 5134.2 5180.4 4000.3 4009.2 4022.4 4080.4 4091.4 3944.8 4018.2 4029.6 4056.2 4074.8 3963.3 3983.8 4000.2 4006.4 4014.5 3977.9 3985.4 3995.3 4007.7 4013.8 3601.2 3608.3 3609.7 3616.2 3641.8 4897.1 5004.4 5012.2 5016.0 5046.9 4584.6 4599.6 4600.9 4622.7 4626.7 5322.3 5331.8 5349.9 5364.6 5366.7 3837.5 3872.3 3923.9 3940.7 3975.3 5534.6 5539.9 5552.8 5559.0 5571.7 4007.9 4011.4 4030.3 4031.5 4065.1 3963.4 4104.7 4110.3 4119.1 4169.4 4579.0 4592.7 4654.4 4674.5 4695.3 5388.5 5391.6 5401.8 5403.5 5408.9 1329.7 1349.5 1360.0 1382.5 1385.4 976.3 979.3 989.0 1008.5 1009.8 5028.4 5036.9 5072.0 5095.7 5110.5 5297.4 5329.8 5334.8 5335.7 5344.5 4907.2 5049.0 5049.8 5074.0 5074.6 2807.1 2851.2 2858.2 2878.7 2883.9 5471.7 5494.4 5502.8 5504.4 5537.3 5351.4 5452.3 5475.3 5480.2 5536.4 5385.4 5397.6 5472.6 5476.4 5483.5 5210.4 5296.3 5324.4 5358.3 5391.3 5281.6 5306.0 5309.2 5322.5 5340.5 5381.5 5382.5 5389.8 5392.8 5434.2 3728.2 3913.4 3923.7 3930.0 3943.7 5285.7 5296.8 5302.4 5318.7 5333.7 5271.5 5330.1 5421.5 5433.4 5474.6 5413.6 5413.7 5417.0 5431.7 5434.6 5185.4 5296.7 5321.3 5347.0 5365.2 5401.2 5421.6 5426.8 5440.8 5448.7 5312.7 5350.5 5356.8 5358.5 5381.9 06:11:45 INFO - PROCESS | 7143 | 06:11:45 INFO - PROCESS | 7143 | [#5] yui.html Cycles:180 Average:15934.42 Median:45038.05 stddev:20304.92 (45.1%) stddev-sans-first:20329.54 06:11:45 INFO - PROCESS | 7143 | Values: 674.3 699.7 723.5 736.5 742.0 13545.3 14526.8 14535.8 14609.8 14624.0 13146.9 13459.5 13476.9 13489.6 13508.3 658.6 668.4 750.7 770.5 773.0 776.9 777.0 783.9 784.2 785.6 826.5 827.6 827.7 827.7 828.1 690.7 701.0 701.5 713.8 827.1 592.4 602.3 606.1 612.5 612.8 13472.7 13501.6 13554.8 13561.8 13565.3 12300.5 12616.3 12664.2 12818.4 12964.3 11344.7 11354.6 11405.6 11417.0 11500.0 4103.3 4107.6 4149.1 4210.9 4223.3 52227.5 56899.1 57280.4 57818.0 59577.4 10390.9 10397.8 10689.7 10732.6 10773.8 18633.6 18635.0 18649.9 18747.7 19187.6 7891.2 8082.4 8095.0 8205.6 8318.0 4344.2 4403.4 4407.9 4548.9 4564.8 3197.5 3245.2 3294.9 3333.1 3335.7 643.2 643.7 652.3 659.4 668.9 682.6 717.7 736.8 744.8 767.6 8759.5 8771.6 9139.7 9142.6 9241.6 606.3 614.9 677.1 723.2 743.3 3720.3 4139.1 4141.2 4169.4 4194.6 58995.0 70768.0 71911.0 73464.6 81696.0 45203.3 55123.0 68426.3 72592.6 72831.0 66499.3 68137.7 68793.7 68796.7 69136.7 8941.0 9066.9 9246.8 9264.4 9281.4 32603.9 36576.1 42985.8 44872.8 47014.8 39465.6 39622.8 48704.5 59870.0 60213.1 11779.7 11792.2 12157.6 12374.8 12712.9 11953.2 12965.2 12967.7 12967.9 12980.7 10236.8 10524.1 10825.5 12011.3 12013.0 11948.0 12414.4 12448.4 12609.4 12707.6 11270.7 11716.6 11803.4 11910.2 12156.5 9618.7 9939.4 10035.8 10292.3 10368.2 9937.5 10091.8 10336.4 10416.1 10535.2 06:11:45 INFO - PROCESS | 7143 | -------- Summary: end -------- 06:11:45 INFO - PROCESS | 7143 | 06:11:46 INFO - TEST-INFO | 7143: exit 0 06:11:46 INFO - TEST-OK | dromaeo_css | took 1117906ms 06:11:46 INFO - TEST-START | kraken 06:11:46 INFO - operating with platform_type : linux_ 06:11:46 INFO - Initialising browser for kraken test... 06:11:46 INFO - TEST-INFO | started process 7450 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpS_3TEM/profile http://localhost:40089/getInfo.html) 06:11:50 INFO - PROCESS | 7450 | __metrics Screen width/height:1600/1200 06:11:50 INFO - PROCESS | 7450 | colorDepth:24 06:11:50 INFO - PROCESS | 7450 | Browser inner width/height: 1024/697 06:11:50 INFO - PROCESS | 7450 | __metrics 06:11:50 INFO - PROCESS | 7450 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 06:11:50 INFO - PROCESS | 7450 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:11:51 INFO - PROCESS | 7450 | console.error: PushService: 06:11:51 INFO - PROCESS | 7450 | stateChangeProcessEnqueue: Error transitioning state 06:11:51 INFO - PROCESS | 7450 | UnknownError 06:11:52 INFO - TEST-INFO | 7450: exit 0 06:11:52 INFO - Browser initialized. 06:11:52 INFO - Running cycle 1/1 for kraken test... 06:11:52 INFO - TEST-INFO | started process 7533 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpS_3TEM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:12:04 INFO - PROCESS | 7533 | RSS: Main: 173391872 06:12:04 INFO - PROCESS | 7533 | 06:12:07 INFO - PROCESS | 7533 | Cycle 1(1): loaded http://localhost:40089/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40089/tests/kraken/driver.html?testName=audio-beat-detection) 06:12:07 INFO - PROCESS | 7533 | RSS: Main: 229904384 06:12:07 INFO - PROCESS | 7533 | 06:12:10 INFO - PROCESS | 7533 | Cycle 1(1): loaded http://localhost:40089/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40089/tests/kraken/driver.html?testName=audio-dft) 06:12:11 INFO - PROCESS | 7533 | RSS: Main: 216707072 06:12:11 INFO - PROCESS | 7533 | 06:12:14 INFO - PROCESS | 7533 | Cycle 1(1): loaded http://localhost:40089/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40089/tests/kraken/driver.html?testName=audio-fft) 06:12:14 INFO - PROCESS | 7533 | RSS: Main: 297181184 06:12:14 INFO - PROCESS | 7533 | 06:12:17 INFO - PROCESS | 7533 | Cycle 1(1): loaded http://localhost:40089/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40089/tests/kraken/driver.html?testName=audio-oscillator) 06:12:17 INFO - PROCESS | 7533 | RSS: Main: 207233024 06:12:17 INFO - PROCESS | 7533 | 06:12:19 INFO - PROCESS | 7533 | Cycle 1(1): loaded http://localhost:40089/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40089/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:12:20 INFO - PROCESS | 7533 | RSS: Main: 213061632 06:12:20 INFO - PROCESS | 7533 | 06:12:23 INFO - PROCESS | 7533 | Cycle 1(1): loaded http://localhost:40089/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40089/tests/kraken/driver.html?testName=imaging-darkroom) 06:12:23 INFO - PROCESS | 7533 | RSS: Main: 248016896 06:12:23 INFO - PROCESS | 7533 | 06:12:27 INFO - PROCESS | 7533 | Cycle 1(1): loaded http://localhost:40089/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40089/tests/kraken/driver.html?testName=imaging-desaturate) 06:12:27 INFO - PROCESS | 7533 | RSS: Main: 247111680 06:12:27 INFO - PROCESS | 7533 | 06:12:30 INFO - PROCESS | 7533 | Cycle 1(1): loaded http://localhost:40089/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40089/tests/kraken/driver.html?testName=json-parse-financial) 06:12:31 INFO - PROCESS | 7533 | RSS: Main: 246427648 06:12:31 INFO - PROCESS | 7533 | 06:12:32 INFO - PROCESS | 7533 | Cycle 1(1): loaded http://localhost:40089/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40089/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:12:33 INFO - PROCESS | 7533 | RSS: Main: 209162240 06:12:33 INFO - PROCESS | 7533 | 06:12:34 INFO - PROCESS | 7533 | Cycle 1(1): loaded http://localhost:40089/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40089/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:12:35 INFO - PROCESS | 7533 | RSS: Main: 216231936 06:12:35 INFO - PROCESS | 7533 | 06:12:37 INFO - PROCESS | 7533 | Cycle 1(1): loaded http://localhost:40089/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40089/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:12:38 INFO - PROCESS | 7533 | RSS: Main: 225378304 06:12:38 INFO - PROCESS | 7533 | 06:12:40 INFO - PROCESS | 7533 | Cycle 1(1): loaded http://localhost:40089/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40089/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:12:41 INFO - PROCESS | 7533 | RSS: Main: 234631168 06:12:41 INFO - PROCESS | 7533 | 06:12:44 INFO - PROCESS | 7533 | Cycle 1(1): loaded http://localhost:40089/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40089/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:12:44 INFO - PROCESS | 7533 | RSS: Main: 230834176 06:12:44 INFO - PROCESS | 7533 | 06:12:46 INFO - PROCESS | 7533 | Cycle 1(1): loaded http://localhost:40089/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40089/tests/kraken/driver.html?testName=ai-astar) 06:12:46 INFO - PROCESS | 7533 | RSS: Main: 282132480 06:12:46 INFO - PROCESS | 7533 | 06:12:46 INFO - PROCESS | 7533 | __start_tp_report 06:12:46 INFO - PROCESS | 7533 | _x_x_mozilla_page_load 06:12:46 INFO - PROCESS | 7533 | _x_x_mozilla_page_load_details 06:12:46 INFO - PROCESS | 7533 | |i|pagename|runs| 06:12:46 INFO - PROCESS | 7533 | |0;ai-astar;104;115;115;113;113;112;112;112;111;112 06:12:46 INFO - PROCESS | 7533 | |1;audio-beat-detection;149;128;131;188;124;127;131;121;153;127 06:12:46 INFO - PROCESS | 7533 | |2;audio-dft;163;160;160;161;161;161;162;162;160;162 06:12:46 INFO - PROCESS | 7533 | |3;audio-fft;75;75;75;124;75;75;76;75;98;76 06:12:46 INFO - PROCESS | 7533 | |4;audio-oscillator;83;83;123;83;83;85;101;82;82;108 06:12:46 INFO - PROCESS | 7533 | |5;imaging-gaussian-blur;117;117;117;117;117;116;116;117;117;117 06:12:46 INFO - PROCESS | 7533 | |6;imaging-darkroom;146;145;146;145;146;147;148;147;145;147 06:12:46 INFO - PROCESS | 7533 | |7;imaging-desaturate;85;85;85;85;85;85;85;85;85;84 06:12:46 INFO - PROCESS | 7533 | |8;json-parse-financial;51;49;50;49;50;52;52;51;50;50 06:12:46 INFO - PROCESS | 7533 | |9;json-stringify-tinderbox;63;63;63;63;63;63;63;63;62;63 06:12:46 INFO - PROCESS | 7533 | |10;stanford-crypto-aes;80;81;86;85;80;79;81;80;80;80 06:12:46 INFO - PROCESS | 7533 | |11;stanford-crypto-ccm;134;148;130;134;141;131;132;129;191;132 06:12:46 INFO - PROCESS | 7533 | |12;stanford-crypto-pbkdf2;165;162;163;167;168;164;164;165;164;164 06:12:46 INFO - PROCESS | 7533 | |13;stanford-crypto-sha256-iterative;66;64;66;65;64;65;67;65;63;64 06:12:46 INFO - PROCESS | 7533 | __end_tp_report 06:12:46 INFO - PROCESS | 7533 | __start_cc_report 06:12:46 INFO - PROCESS | 7533 | _x_x_mozilla_cycle_collect,1648 06:12:46 INFO - PROCESS | 7533 | __end_cc_report 06:12:46 INFO - PROCESS | 7533 | __startTimestamp1478873566769__endTimestamp 06:12:46 INFO - PROCESS | 7533 | 06:12:46 INFO - PROCESS | 7533 | ------- Summary: start ------- 06:12:46 INFO - PROCESS | 7533 | Number of tests: 14 06:12:46 INFO - PROCESS | 7533 | 06:12:46 INFO - PROCESS | 7533 | [#0] ai-astar Cycles:10 Average:111.90 Median:112.50 stddev:3.07 (2.7%) stddev-sans-first:1.39 06:12:46 INFO - PROCESS | 7533 | Values: 104.0 115.0 115.0 113.0 113.0 112.0 112.0 112.0 111.0 112.0 06:12:46 INFO - PROCESS | 7533 | 06:12:46 INFO - PROCESS | 7533 | [#1] audio-beat-detection Cycles:10 Average:137.90 Median:131.00 stddev:20.47 (15.6%) stddev-sans-first:21.31 06:12:46 INFO - PROCESS | 7533 | Values: 149.0 128.0 131.0 188.0 124.0 127.0 131.0 121.0 153.0 127.0 06:12:46 INFO - PROCESS | 7533 | 06:12:46 INFO - PROCESS | 7533 | [#2] audio-dft Cycles:10 Average:161.20 Median:161.50 stddev:1.03 (0.6%) stddev-sans-first:0.87 06:12:46 INFO - PROCESS | 7533 | Values: 163.0 160.0 160.0 161.0 161.0 161.0 162.0 162.0 160.0 162.0 06:12:46 INFO - PROCESS | 7533 | 06:12:46 INFO - PROCESS | 7533 | [#3] audio-fft Cycles:10 Average:82.40 Median:75.00 stddev:16.28 (21.7%) stddev-sans-first:17.04 06:12:46 INFO - PROCESS | 7533 | Values: 75.0 75.0 75.0 124.0 75.0 75.0 76.0 75.0 98.0 76.0 06:12:46 INFO - PROCESS | 7533 | 06:12:46 INFO - PROCESS | 7533 | [#4] audio-oscillator Cycles:10 Average:91.30 Median:83.00 stddev:14.40 (17.3%) stddev-sans-first:14.96 06:12:46 INFO - PROCESS | 7533 | Values: 83.0 83.0 123.0 83.0 83.0 85.0 101.0 82.0 82.0 108.0 06:12:46 INFO - PROCESS | 7533 | 06:12:46 INFO - PROCESS | 7533 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 06:12:46 INFO - PROCESS | 7533 | Values: 117.0 117.0 117.0 117.0 117.0 116.0 116.0 117.0 117.0 117.0 06:12:46 INFO - PROCESS | 7533 | 06:12:46 INFO - PROCESS | 7533 | [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.50 stddev:1.03 (0.7%) stddev-sans-first:1.09 06:12:46 INFO - PROCESS | 7533 | Values: 146.0 145.0 146.0 145.0 146.0 147.0 148.0 147.0 145.0 147.0 06:12:46 INFO - PROCESS | 7533 | 06:12:46 INFO - PROCESS | 7533 | [#7] imaging-desaturate Cycles:10 Average:84.90 Median:85.00 stddev:0.32 (0.4%) stddev-sans-first:0.33 06:12:46 INFO - PROCESS | 7533 | Values: 85.0 85.0 85.0 85.0 85.0 85.0 85.0 85.0 85.0 84.0 06:12:46 INFO - PROCESS | 7533 | 06:12:46 INFO - PROCESS | 7533 | [#8] json-parse-financial Cycles:10 Average:50.40 Median:50.50 stddev:1.07 (2.1%) stddev-sans-first:1.12 06:12:46 INFO - PROCESS | 7533 | Values: 51.0 49.0 50.0 49.0 50.0 52.0 52.0 51.0 50.0 50.0 06:12:46 INFO - PROCESS | 7533 | 06:12:46 INFO - PROCESS | 7533 | [#9] json-stringify-tinderbox Cycles:10 Average:62.90 Median:63.00 stddev:0.32 (0.5%) stddev-sans-first:0.33 06:12:46 INFO - PROCESS | 7533 | Values: 63.0 63.0 63.0 63.0 63.0 63.0 63.0 63.0 62.0 63.0 06:12:46 INFO - PROCESS | 7533 | 06:12:46 INFO - PROCESS | 7533 | [#10] stanford-crypto-aes Cycles:10 Average:81.20 Median:80.50 stddev:2.35 (2.9%) stddev-sans-first:2.45 06:12:46 INFO - PROCESS | 7533 | Values: 80.0 81.0 86.0 85.0 80.0 79.0 81.0 80.0 80.0 80.0 06:12:46 INFO - PROCESS | 7533 | 06:12:46 INFO - PROCESS | 7533 | [#11] stanford-crypto-ccm Cycles:10 Average:140.20 Median:134.00 stddev:18.76 (14.0%) stddev-sans-first:19.76 06:12:46 INFO - PROCESS | 7533 | Values: 134.0 148.0 130.0 134.0 141.0 131.0 132.0 129.0 191.0 132.0 06:12:46 INFO - PROCESS | 7533 | 06:12:46 INFO - PROCESS | 7533 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.60 Median:164.50 stddev:1.78 (1.1%) stddev-sans-first:1.88 06:12:46 INFO - PROCESS | 7533 | Values: 165.0 162.0 163.0 167.0 168.0 164.0 164.0 165.0 164.0 164.0 06:12:46 INFO - PROCESS | 7533 | 06:12:46 INFO - PROCESS | 7533 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.90 Median:65.00 stddev:1.20 (1.8%) stddev-sans-first:1.20 06:12:46 INFO - PROCESS | 7533 | Values: 66.0 64.0 66.0 65.0 64.0 65.0 67.0 65.0 63.0 64.0 06:12:46 INFO - PROCESS | 7533 | -------- Summary: end -------- 06:12:46 INFO - PROCESS | 7533 | 06:12:47 INFO - TEST-INFO | 7533: exit 0 06:12:47 INFO - TEST-OK | kraken | took 61884ms 06:12:47 INFO - SUITE-END | took 1179s 06:12:48 INFO - Completed test suite (00:19:40) 06:12:48 INFO - javascript benchmark 06:12:48 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2969.6584892737333, 2984.8209107453567, 3018.652854921684, 3030.378772351668, 3034.7572194224463, 5212.270282160496, 5252.343457067866, 5266.157414813631, 5328.120860058096, 5344.305240318753, 5270.868228294285, 5322.733863306838, 5376.704281264529, 5387.865303367418, 5426.8371948841495, 4731.8817029574275, 4759.357486739281, 4778.116048531033, 4791.928121078186, 4826.589739872115, 4866.975665121669, 4912.361393018902, 4915.82794602189, 4916.655834091615, 4957.82647607332, 4694.178518759238, 4841.588464980481, 4847.345608342864, 4864.270359446076, 4937.530934561229, 4728.338032675429, 4777.856664300077, 4788.090262850047, 4821.059893320804, 4821.445533763627, 4821.22860342347, 4823.20417131173, 4827.806887724522, 4865.829695960624, 4887.608991280689, 5372.892542149174, 5401.567874570025, 5409.891802163974, 5416.052190866582, 5417.214503896913, 5547.916781248285, 5570.944290557083, 5586.525145362649, 5615.241942337814, 5779.971100144515, 5662.178984047331, 5689.203511508392, 5728.8854222915725, 5730.19777231188, 5740.942590574083, 5277.70972596507, 5279.868003299872, 5285.471452854761, 5285.762140703678, 5333.546648534841, 5590.273264475592, 5694.515966142924, 5752.9424705753245, 5790.536757059425, 5796.101604251264, 5626.212330273765, 5648.15277708347, 5650.5479561634975, 5686.516646085046, 5695.686737229409, 5676.744546495418, 5685.061964775766, 5713.314402271754, 5723.0, 5730.0, 5489.39616642169, 5498.890022199534, 5666.348369937427, 5717.799877004368, 5731.713414329267, 5573.749181286852, 5591.04952158126, 5594.244776955059, 5707.200991861143, 5794.942050579524, 4321.2653848845775, 4336.0243945112725, 4337.0458499130145, 4339.370791235253, 4372.519022907478, 3820.331441997639, 3832.9425058624142, 3864.401017842239, 3875.9224815504094, 3885.941710874339, 5409.675419474844, 5471.6169868108855, 5478.096114141202, 5483.588730845203, 5529.391766905637, 5774.307083150049, 5783.074708046693, 5788.565857560699, 5810.331811841608, 5811.186433899257, 5289.867753306198, 5341.225522299244, 5346.518813306821, 5487.972560137174, 5493.093639549509, 4909.95090049095, 4938.580220681282, 4940.876478088005, 4946.975265123723, 4950.851474455772, 5806.390329015477, 5820.126980952721, 5821.767129314865, 5822.563307751935, 5824.854378640568, 5631.8592035199445, 5671.971640141773, 5702.144678298288, 5703.914441283467, 5706.372299047019, 5748.223989761496, 5794.449527294901, 5797.391273916178, 5799.246098007232, 5803.593748437569, 5537.529310008695, 5582.134769110794, 5602.887942241214, 5606.355269144101, 5613.46672066153, 5667.404922483245, 5667.603267771381, 5670.234518340137, 5697.800576979786, 5709.857253568694, 5619.747111380079, 5626.212330273846, 5636.915446268227, 5636.915446268391, 5638.097904335451, 5446.809361672323, 5489.58828087903, 5590.217369568345, 5596.692181930033, 5599.384067752625, 5516.089845175501, 5518.420565840529, 5569.610127291051, 5615.971920140537, 5665.461781130786, 5691.4877661010705, 5706.4864162225595, 5707.600467967202, 5718.599698021098, 5720.599558031065, 5381.13901775714, 5533.2253484513, 5544.057510223352, 5570.164475328571, 5578.693171875586], "value": 5246.561550888106, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [556.3433517957636, 590.6279044202153, 611.947984421324, 628.4187126907609, 631.1700114349627, 31650.683493165063, 33608.66391336086, 33794.0, 33810.830945845264, 40577.18845623093, 42583.148337033315, 42586.361204581954, 42613.36079958803, 42621.573784262146, 42699.57300426995, 8527.616257268422, 8663.39356245063, 8673.219410253076, 8677.219050285474, 8677.95661021694, 8010.359171266314, 8193.303569196625, 8502.107278735737, 8603.48379097253, 8609.913900861005, 10001.749956251115, 10218.386896786216, 10226.43754593497, 10531.73670658232, 10548.630797922075, 10341.276110672256, 10368.01503857136, 10402.895971040269, 10411.0, 10418.114460270886, 9931.950340248324, 9962.850557241647, 9970.601175952954, 9981.0, 9982.051705088004, 38967.22065558673, 39219.60780392188, 39280.80359598212, 39292.60707392947, 39324.60675393267, 3646.288973650113, 3889.3971434427426, 3912.3615038014636, 3975.3043217436834, 4100.425940368351, 29799.40401191964, 30343.69656303453, 30669.0, 30683.0, 30734.0, 4103.0, 4171.582841715835, 4340.110277393158, 4340.739555626673, 4379.408779814716, 310070.0, 310932.0, 311162.0, 312883.0, 313624.99999999773, 34058.65941340555, 35114.648853511135, 54546.727266363414, 54831.0, 54863.0, 35929.640703593155, 36110.09724756902, 36117.45823812645, 36125.81937090298, 36186.27627447489, 14734.336954837057, 14824.0, 14824.40702371893, 14826.406943722346, 14830.62923426923, 12881.420336084899, 12955.352232388343, 12958.157719748375, 12960.222386656831, 12969.0, 8142.226488483585, 8190.918090819016, 8225.383096267804, 8502.277306429023, 8519.446235994641, 3262.4503360903855, 3293.91765205867, 3303.4219011672863, 3319.3859136059423, 3319.751018673609, 974.8878878928872, 1016.0601443664581, 1018.0735530667057, 1053.1153830782027, 1081.799867024603, 31558.684413156032, 33148.834255829046, 34267.657323426945, 34450.827745861614, 36236.45645315322, 1070.983935240972, 1095.5015467962057, 1108.2851560743275, 1113.1373185780922, 1117.6758739965483, 15619.794316266254, 16820.915895420443, 16870.746938795928, 16873.578160546083, 17020.319187232373, 431466.0, 442941.0, 444280.0, 444965.0, 445563.0, 50572.494275057514, 51073.489265107615, 54580.45419545754, 55503.612409689275, 56111.0, 1364.5565191312862, 1372.378756574957, 1399.7900314952635, 1414.1656422710444, 1422.530564913576, 30074.656579733924, 32564.51153232751, 32707.836460817543, 32742.0, 32788.83605581957, 48725.75637121792, 49384.75307623439, 49551.0, 49555.25667115068, 49563.0, 356347.0, 359029.0, 359181.0, 360232.0, 360669.0, 40381.596184037786, 40873.38689919713, 41898.0, 41898.79050604849, 41919.37120943127, 44517.0, 44949.325760114276, 45284.77357613323, 45444.318335224336, 45867.0, 37953.62046379501, 38282.80858595689, 38643.03392415212, 40197.1960560793, 40220.0, 37961.43057854079, 38360.80819595884, 38461.0, 39477.60522394854, 39697.40453893252, 39138.533873908156, 39153.0, 39607.0, 39785.80107099446, 39824.80087599543, 32345.676543235208, 34332.31335373229, 34415.32268097143, 35084.473732893515, 35178.47232291466, 26508.204753857415, 26889.596656050566, 27250.863745681145, 27409.862950685118, 28779.0], "value": 18576.876114089097, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [369.17489411166054, 377.52431935760933, 390.36760448074114, 400.6894656641103, 414.3908454571778, 14069.296535173238, 15474.767878481818, 17804.28782848688, 18494.907525462353, 18538.351157709483, 18821.905890470527, 18886.433406997778, 18919.905400473013, 19014.80985190148, 19208.711869321938, 4112.958870411302, 5365.436629153932, 5588.608797384185, 5600.327960644729, 5662.462066103713, 4249.638780703628, 6011.188489553898, 6260.280067792217, 6330.873382532347, 6434.195725534309, 6174.783882564111, 6330.65181415022, 6354.428101470867, 6384.457321127709, 6396.744130234785, 6345.175127233476, 6384.7126879290545, 6387.936120638804, 6391.360863913595, 6392.744290228386, 5431.212474191259, 5622.662640241599, 5662.09406494963, 5664.858378540528, 5674.290713660793, 22222.222222222146, 22878.54242915149, 22989.88505057464, 23015.53968920629, 23312.533749324917, 2311.9884400578057, 2329.4176455886027, 2344.0389440329554, 2453.987730061356, 2512.371907023244, 13606.727865442635, 13886.93056534721, 13966.790498142536, 14305.070170438888, 14774.852251477563, 1778.1376032624166, 1825.525363405511, 1834.8899066056078, 1879.5489082620209, 1883.6138591588692, 75674.62162689152, 76670.23329766742, 78715.21284787136, 79175.0, 80091.0, 10238.129758970423, 10461.68614941553, 10555.0, 10767.6231331903, 10971.396573188551, 15072.472463463726, 15093.0, 15095.773563396559, 15104.697906041818, 15114.470993515175, 7767.844643107106, 8136.389770767216, 8157.265846073763, 8300.128486508951, 8335.208155225366, 7800.414968877357, 7826.530408175528, 7839.628065088701, 8075.475094118863, 8086.029676438865, 6537.771178008747, 6573.469214352509, 6583.769568065095, 6627.5029372797235, 6759.932400675931, 1847.2426305215065, 1863.506170864722, 1893.4792931943825, 1917.5589614388768, 1931.9323823666105, 878.5212059427499, 983.1986930651497, 1026.5996261458038, 1051.9579216831394, 1068.7915856407926, 18583.53541161482, 19079.0, 19258.71111933322, 19631.803681962996, 19669.803301966796, 978.8433850583872, 1011.1051719228535, 1044.4099084017505, 1046.2989796836139, 1050.2910535388583, 10252.313161928909, 11097.38964356968, 11110.833337499944, 11129.777404452028, 11145.72135696614, 338233.0, 340569.0, 465223.0, 465511.0, 470304.0, 89857.55071224603, 91832.0, 94934.0, 96112.0, 96751.0, 1025.8666373371414, 1040.0483557544762, 1057.0909018244304, 1104.4146602300793, 1105.745678493951, 16799.91600041992, 16839.831601683825, 17866.5533361667, 18011.639767204844, 18141.45575632733, 39000.414993774546, 39185.0, 39619.60380396159, 39892.60107399005, 39893.60106398899, 55316.17025744537, 56733.0, 57068.0, 57820.421795781505, 59591.0, 8213.685810270328, 8367.916320836714, 8389.370797190113, 8577.142285771373, 8603.741887743377, 11350.659480215607, 12949.352532373532, 13054.673633159247, 13265.270410127536, 13364.131331463424, 11168.38573878412, 11242.0, 11513.769724605294, 11742.823857641972, 11972.341521216069, 11102.2783519071, 11244.493997770283, 11285.37930413835, 11350.375729334966, 11716.589919352782, 8477.533735644598, 11575.88424115748, 11642.417879105842, 11716.23844450108, 11976.101792365782, 8324.583770811556, 8575.442596231225, 8643.308535317034, 8659.177378149066, 8686.438560190292, 8913.37606367548, 11109.222354435113, 11408.657740267805, 11433.256838305817, 11964.222325548812], "value": 9273.547903955396, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1317.6508225320297, 1422.0330175480676, 1469.0, 1536.761801920702, 1689.2820551265718, 7144.106986626672, 8094.838103237932, 8306.54314012729, 8321.459105158168, 8584.098669639692, 8421.915780842204, 8493.150684931505, 8507.404481686284, 8510.446820956633, 8517.06312305646, 2259.751427342991, 2266.3427605994243, 2274.5109801392696, 2303.0787684925995, 2303.6429353450244, 2283.5318759654233, 2317.5249073939885, 2344.7303560090554, 2349.9647505287435, 2350.976490235093, 2191.6493361062235, 2197.0113448948036, 2223.6108680980765, 2270.648049552322, 2284.017872314904, 2257.920972765962, 2272.545490901818, 2276.7381751098587, 2291.6562515622622, 2294.9541009179807, 2283.303592404316, 2301.608726516496, 2302.82728795341, 2305.5734689082406, 2307.1924826310824, 8334.749957501284, 8406.159384061606, 8455.788605284917, 8463.534505602189, 8471.661133554651, 5128.487151284841, 5251.947480525184, 5255.921161182585, 5278.551323137538, 5318.228856815779, 3341.3818443588016, 3397.7281817454545, 3459.498372735939, 3463.2034632034774, 3503.8948831535095, 1132.722482991664, 1135.528755566439, 1152.1992215410294, 1155.2952698853692, 1156.1097954575014, 11424.657260282205, 11430.971212590906, 11531.884681153166, 11539.884601153964, 11546.711332216677, 4246.278132717445, 4389.539098394686, 4432.113577284556, 4441.244988351923, 4477.350784136347, 9170.312226583033, 9177.77055573616, 9207.125323094295, 9210.677626283048, 9234.0, 5188.507091826346, 5190.714510701872, 5193.143131383355, 5196.92204616931, 5198.038362902875, 4182.456280683492, 4278.679099067583, 4739.075880203327, 4824.614030877521, 4831.855044348676, 3549.2369140634887, 3623.3296840084668, 3641.071526760712, 3713.517242758424, 3716.7955762433326, 1123.9325640461598, 1129.9548018079186, 1132.213111887247, 1134.0643968725835, 1137.9829302560468, 798.972035978738, 837.9874301885477, 939.4222553129913, 963.3016063354012, 969.2100937735722, 5306.54894333986, 5453.536449401766, 5529.778808847682, 5601.5238704709745, 5900.144479050514, 924.5007695844304, 959.8848138223458, 960.6493629825063, 968.9127978481971, 971.5336638413601, 3982.4623675803396, 4026.516817981861, 4199.940552858465, 4296.957030429656, 4329.112531930947, 9913.107820296207, 10215.540300686487, 10379.11777498906, 10397.428141452292, 10414.218933580012, 10063.748406289755, 10160.33957792741, 10354.637587684394, 10359.741006474747, 10453.738656533647, 7711.652975616111, 7930.246626570582, 7931.246531579491, 7932.0169957510625, 7934.365250779923, 5578.442155784389, 5652.689102099424, 5686.744096515749, 5722.484976352148, 5943.257092863392, 9284.860727088964, 9323.300752443729, 9410.717678469657, 9415.623375065195, 9417.717468475958, 9324.300677449353, 9387.202087822612, 9423.434593924387, 9485.857712134186, 9529.761755956157, 7879.290863822283, 8046.83906321882, 8161.347092232489, 8174.959125204336, 8179.182081791773, 7740.496867703581, 7892.382061677457, 7905.367570594453, 7906.446548741533, 7953.085395179628, 7230.891536626849, 7311.268873112646, 7319.560826350436, 7327.34053935127, 7415.925840741739, 6936.7572134975035, 7008.159020917523, 7121.608311542707, 7196.532225405332, 7243.746468873775, 6642.036904648896, 6756.594604323756, 6768.627725475146, 6832.0, 6835.93164068353, 4946.851594452172, 4966.528179822911, 5005.399352077774, 5053.191489361684, 5192.324997750268, 5050.123319277494, 5104.4129925057605, 5128.410232823273, 5180.818671346636, 5284.286621306074], "value": 4464.645981310823, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [327.5610681686541, 331.9651436599157, 341.60715177545814, 344.3973047167457, 348.78549691939463, 5075.822346217874, 5187.974060129694, 5209.84370468886, 5274.103402421588, 5274.4461831507715, 5025.632826006576, 5094.184930411135, 5132.20450830121, 5134.229865520174, 5180.352455943007, 4000.2599519088917, 4009.1781184857036, 4022.3966405039187, 4080.4287399764057, 4091.4067460218325, 3944.777119093076, 4018.236535058344, 4029.556748757649, 4056.2495938251373, 4074.775887326196, 3963.326234540135, 3983.8008099594904, 4000.219957108365, 4006.3589825627905, 4014.487323591857, 3977.880663580097, 3985.362342025262, 3995.2808494470983, 4007.7156021068004, 4013.8394464221396, 3601.2077342984503, 3608.3144202601684, 3609.675129238355, 3616.2405894762132, 3641.7632853864416, 4897.118518666639, 5004.374453193351, 5012.248162775576, 5015.974920125376, 5046.873828154289, 4584.5873871351405, 4599.632029437637, 4600.895785011607, 4622.745748983804, 4626.653001024936, 5322.2548843161985, 5331.760070796785, 5349.919751203735, 5364.624476286662, 5366.6511676741275, 3837.539495260559, 3872.341701910682, 3923.901902452433, 3940.7438516496336, 3975.3241948868763, 5534.557235421156, 5539.944600553983, 5552.805651802208, 5558.998760446236, 5571.693556854371, 4007.913906292197, 4011.438398624195, 4030.2544029354663, 4031.455753473302, 4065.0853557949226, 3963.36586146221, 4104.651104656078, 4110.301248787713, 4119.114390406077, 4169.437125988014, 4578.977874602746, 4592.724436533818, 4654.418197725285, 4674.527523829983, 4695.319178719066, 5388.521280211068, 5391.56867450603, 5401.837944861661, 5403.540699040547, 5408.91886621701, 1329.7074643578396, 1349.466960550577, 1359.9932000339934, 1382.523029554802, 1385.3835043405588, 976.2580438866513, 979.294907666479, 988.9653862114935, 1008.5325850886942, 1009.8384258518602, 5028.396592408934, 5036.899262014739, 5072.047261804232, 5095.668781529189, 5110.514501122388, 5297.437256009486, 5329.760160792774, 5334.75993580282, 5335.733213339395, 5344.465553444625, 4907.1903135982875, 5048.974755126274, 5049.84850454487, 5073.974630126826, 5074.5686616637995, 2807.1157585360547, 2851.201663534214, 2858.2139911524496, 2878.654561452597, 2883.8990635327664, 5471.662286005533, 5494.406622079552, 5502.752376143083, 5504.394516603171, 5537.2524709163745, 5351.411344752074, 5452.318460192476, 5475.288212532345, 5480.205370221295, 5536.446355364431, 5385.38068122171, 5397.622166448311, 5472.589555783253, 5476.424975377608, 5483.4516548344845, 5210.426853046238, 5296.285001524745, 5324.361076670824, 5358.303420555303, 5391.29913111293, 5281.55106815925, 5305.965336759295, 5309.203619456958, 5322.54758345545, 5340.465953404629, 5381.48875856793, 5382.461753824587, 5389.784408623611, 5392.838214853404, 5434.174229400768, 3728.217074414403, 3913.434626149563, 3923.7242399407705, 3929.9607003929596, 3943.6845052395165, 5285.709285989307, 5296.848375216894, 5302.39022512416, 5318.680879147263, 5333.679979201261, 5271.4960393812635, 5330.067238233216, 5421.484958928895, 5433.42430695094, 5474.562035037267, 5413.593980451561, 5413.675179489243, 5417.049862049737, 5431.701256430776, 5434.64687283018, 5185.377754669464, 5296.735163241746, 5321.255024296679, 5347.0, 5365.195220716923, 5401.189821526646, 5421.644588852787, 5426.755795989111, 5440.836774896759, 5448.700321482198, 5312.7343632818975, 5350.5184533392185, 5356.812511562077, 5358.48151368856, 5381.865453363697], "value": 4098.69260259795, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [674.2717864706117, 699.7410957945561, 723.5188599581279, 736.473421503625, 742.0353540397485, 13545.322733863304, 14526.78209826852, 14535.78196327056, 14609.780853287197, 14624.049436786601, 13146.934265328684, 13459.46162153515, 13476.932615336935, 13489.595312140627, 13508.324583770796, 658.5850913924221, 668.4218151299116, 750.6959681329071, 770.5261264322429, 772.97681069568, 776.8718161503346, 777.0364747712852, 783.9059312882462, 784.19228194959, 785.579714852554, 826.5247482697444, 827.606886728802, 827.6896163938524, 827.7144385187131, 828.1470085811624, 690.689189864563, 700.9719611215545, 701.5124488480508, 713.7858642407257, 827.1149869639488, 592.3927973826819, 602.340437221242, 606.1362558354372, 612.4671535763914, 612.770211170811, 13472.663183420394, 13501.59495215145, 13554.796678049837, 13561.796573051313, 13565.25391103489, 12300.507979680802, 12616.306103164323, 12664.240145591293, 12818.423170957329, 12964.286964216964, 11344.659660210207, 11354.60258890943, 11405.600803971822, 11417.0, 11499.965003149673, 4103.261412945669, 4107.630313271819, 4149.066460046495, 4210.85262015831, 4223.324268117117, 52227.47772522302, 56899.14651280234, 57280.42719572793, 57818.0, 59577.40422595805, 10390.896091039143, 10397.84403233952, 10689.732756681145, 10732.624358147428, 10773.78452430947, 18633.627327453374, 18635.0, 18649.90675046616, 18747.718784218247, 19187.616247674967, 7891.171427000198, 8082.434229603989, 8095.0, 8205.58972051395, 8318.0, 4344.218040752695, 4403.405540252089, 4407.933880991788, 4548.909021819545, 4564.79458424365, 3197.5043868200464, 3245.1724810173255, 3294.8797408881096, 3333.0500807269814, 3335.7331413486863, 643.1542521584101, 643.7231990244146, 652.292262894755, 659.4098282037645, 668.8628831089615, 682.6040896280145, 717.6626985316892, 736.8157960509873, 744.7765670298888, 767.5816679909462, 8759.474431534129, 8771.605277762515, 9139.680111196076, 9142.63429462814, 9241.630334786667, 606.263389981175, 614.8893199224183, 677.0994577212296, 723.2044750774106, 743.2604558464362, 3720.296549700906, 4139.130782535702, 4141.159702873766, 4169.374593810952, 4194.580541945842, 58995.0, 70768.0, 71911.0, 73464.63267683628, 81696.0, 45203.32195017077, 55123.0, 68426.315736843, 72592.63703681447, 72831.0, 66499.33500664931, 68137.65931170313, 68793.65603171852, 68796.6560167196, 69136.65431672809, 8941.0, 9066.909330906607, 9246.768830779285, 9264.39781414206, 9281.443113413217, 32603.85886493961, 36576.08559786026, 42985.785071074446, 44872.77563612161, 47014.76492617515, 39465.60534394734, 39622.80188599038, 48704.51295487, 59870.0, 60213.096803548855, 11779.705507362041, 11792.23350482216, 12157.574484892986, 12374.752504950031, 12712.872871271538, 11953.163278570417, 12965.22208667483, 12967.740645187232, 12967.935160324138, 12980.675483112998, 10236.795264094826, 10524.105451036748, 10825.458727063773, 12011.339376334385, 12013.0, 11947.969163961003, 12414.379281036092, 12448.439820208294, 12609.43257553394, 12707.618771436872, 11270.718232044264, 11716.648500544998, 11803.428662344555, 11910.166288359731, 12156.452959617016, 9618.711438656852, 9939.403635781877, 10035.799284014132, 10292.279540432397, 10368.170546356425, 9937.503124843584, 10091.848622270818, 10336.431496267778, 10416.114630256514, 10535.20985926074], "value": 6698.821646680398, "unit": "score"}], "name": "dromaeo_css", "value": 6930.451624244317, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 115.0, 115.0, 113.0, 113.0, 112.0, 112.0, 112.0, 111.0, 112.0], "value": 111.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 128.0, 131.0, 188.0, 124.0, 127.0, 131.0, 121.0, 153.0, 127.0], "value": 137.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 160.0, 160.0, 161.0, 161.0, 161.0, 162.0, 162.0, 160.0, 162.0], "value": 161.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 124.0, 75.0, 75.0, 76.0, 75.0, 98.0, 76.0], "value": 82.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 123.0, 83.0, 83.0, 85.0, 101.0, 82.0, 82.0, 108.0], "value": 91.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 116.0, 117.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 146.0, 145.0, 146.0, 147.0, 148.0, 147.0, 145.0, 147.0], "value": 146.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 85.0, 85.0, 85.0, 85.0, 85.0, 85.0, 85.0, 84.0], "value": 84.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 49.0, 50.0, 49.0, 50.0, 52.0, 52.0, 51.0, 50.0, 50.0], "value": 50.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 63.0, 63.0, 63.0, 63.0, 63.0, 63.0, 62.0, 63.0], "value": 62.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 81.0, 86.0, 85.0, 80.0, 79.0, 81.0, 80.0, 80.0, 80.0], "value": 81.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 148.0, 130.0, 134.0, 141.0, 131.0, 132.0, 129.0, 191.0, 132.0], "value": 140.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 162.0, 163.0, 167.0, 168.0, 164.0, 164.0, 165.0, 164.0, 164.0], "value": 164.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 64.0, 66.0, 65.0, 64.0, 65.0, 67.0, 65.0, 63.0, 64.0], "value": 64.9, "unit": "score"}], "name": "kraken", "value": 1496.8, "alertThreshold": 2.0}]} 06:12:48 INFO - Return code: 0 06:12:48 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:12:48 INFO - # TBPL SUCCESS # 06:12:48 INFO - Running post-action listener: _resource_record_post_action 06:12:48 INFO - [mozharness: 2016-11-11 14:12:48.567350Z] Finished run-tests step (success) 06:12:48 INFO - Running post-run listener: _resource_record_post_run 06:12:48 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 4096; Write bytes: 402624512; Read time: 52; Write time: 303084 06:12:48 INFO - TinderboxPrint: CPU usage
13.1% 06:12:48 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 52 06:12:48 INFO - TinderboxPrint: I/O write bytes / time
402,624,512 / 303,084 06:12:48 INFO - TinderboxPrint: CPU idle
8,300.1 (86.9%) 06:12:48 INFO - TinderboxPrint: CPU user
1,200.4 (12.6%) 06:12:48 INFO - TinderboxPrint: Swap in / out
0 / 0 06:12:48 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 114831360; Read time: 0; Write time: 78072 06:12:48 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 4096; Write bytes: 287350784; Read time: 52; Write time: 224932 06:12:49 INFO - Running post-run listener: _upload_blobber_files 06:12:49 INFO - Blob upload gear active. 06:12:49 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:12:49 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 06:12:49 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', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:12:49 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 -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:12:49 INFO - (blobuploader) - INFO - Open directory for files ... 06:12:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:12:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:12:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:12:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:12:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:12:50 INFO - (blobuploader) - INFO - Done attempting. 06:12:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:12:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:12:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:12:53 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:12:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:12:53 INFO - (blobuploader) - INFO - Done attempting. 06:12:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:12:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:12:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:12:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:12:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:12:54 INFO - (blobuploader) - INFO - Done attempting. 06:12:54 INFO - (blobuploader) - INFO - Iteration through files over. 06:12:54 INFO - Return code: 0 06:12:54 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:12:54 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:12:54 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/aacb9b00bfc88fce69aaa2d240c027dcc06a94805226dadf7bacec28492f0b5b1c3691bbe452b1f87a5b8d875c83245bdf1e1848cb8ffecf4d69bc8959e0831b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/66718fc2de687750d1d3fcb128b41bfa1be6ff03c7e37830f425421c271ae8fe2fc6e135bec430b433354d8a2f2b9c0bc41afca4d26f297f55d48de9fd7ac036", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/aca204480ae449bf55629b3fd41bf97b90b4cc77ecdc9077f6406ceff0483d7fe33cc2987702dee15fe5b4747837d26278bdd52365ad254eec2ff12c04e7f069"} 06:12:54 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:12:54 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:12:54 INFO - Contents: 06:12:54 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/aacb9b00bfc88fce69aaa2d240c027dcc06a94805226dadf7bacec28492f0b5b1c3691bbe452b1f87a5b8d875c83245bdf1e1848cb8ffecf4d69bc8959e0831b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/66718fc2de687750d1d3fcb128b41bfa1be6ff03c7e37830f425421c271ae8fe2fc6e135bec430b433354d8a2f2b9c0bc41afca4d26f297f55d48de9fd7ac036", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/aca204480ae449bf55629b3fd41bf97b90b4cc77ecdc9077f6406ceff0483d7fe33cc2987702dee15fe5b4747837d26278bdd52365ad254eec2ff12c04e7f069"} 06:12:54 INFO - Running post-run listener: copy_logs_to_upload_dir 06:12:54 INFO - Copying logs to upload dir... 06:12:54 INFO - mkdir: /builds/slave/test/build/upload/logs 06:12:54 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1241.288149 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-11-11 06:12:53.127956) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-11 06:12:53.131600) ========= 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-1478868532.594343-1661560718 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/aacb9b00bfc88fce69aaa2d240c027dcc06a94805226dadf7bacec28492f0b5b1c3691bbe452b1f87a5b8d875c83245bdf1e1848cb8ffecf4d69bc8959e0831b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/66718fc2de687750d1d3fcb128b41bfa1be6ff03c7e37830f425421c271ae8fe2fc6e135bec430b433354d8a2f2b9c0bc41afca4d26f297f55d48de9fd7ac036", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/aca204480ae449bf55629b3fd41bf97b90b4cc77ecdc9077f6406ceff0483d7fe33cc2987702dee15fe5b4747837d26278bdd52365ad254eec2ff12c04e7f069"} build_url:https://queue.taskcluster.net/v1/task/didJpmEMRayoj4gBJxkTxw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011519 build_url: 'https://queue.taskcluster.net/v1/task/didJpmEMRayoj4gBJxkTxw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/aacb9b00bfc88fce69aaa2d240c027dcc06a94805226dadf7bacec28492f0b5b1c3691bbe452b1f87a5b8d875c83245bdf1e1848cb8ffecf4d69bc8959e0831b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/66718fc2de687750d1d3fcb128b41bfa1be6ff03c7e37830f425421c271ae8fe2fc6e135bec430b433354d8a2f2b9c0bc41afca4d26f297f55d48de9fd7ac036", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/aca204480ae449bf55629b3fd41bf97b90b4cc77ecdc9077f6406ceff0483d7fe33cc2987702dee15fe5b4747837d26278bdd52365ad254eec2ff12c04e7f069"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-11 06:12:53.157034) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-11 06:12:53.157374) ========= 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-1478868532.594343-1661560718 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004454 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-11 06:12:53.240688) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-11 06:12:53.241141) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-11 06:12:53.241463) ========= ========= Total master_lag: 0.16 =========