builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-018 starttime: 1475975894.93 results: success (0) buildid: 20161008164819 builduid: 2751bb0d23e547aebb7c8693e735a37e revision: 313a2d049350c88515b0b900aaf279a0ae61c7fa ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-08 18:18:14.939096) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-08 18:18:14.939582) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-08 18:18:14.939863) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-08 18:18:14.954598) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-08 18:18:14.954857) ========= 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=62c568580acbfdaac3eec7be000001dc-1475961404.388074-116307990 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-08 18:18:15-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 56.2K=0.2s 2016-10-08 18:18:15 (56.2 KB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.326033 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-08 18:18:15.306140) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-08 18:18:15.306410) ========= 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=62c568580acbfdaac3eec7be000001dc-1475961404.388074-116307990 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020441 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-08 18:18:15.371611) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-08 18:18:15.372099) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 313a2d049350c88515b0b900aaf279a0ae61c7fa --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 313a2d049350c88515b0b900aaf279a0ae61c7fa --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=62c568580acbfdaac3eec7be000001dc-1475961404.388074-116307990 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-08 18:18:15,711 truncating revision to first 12 chars 2016-10-08 18:18:15,711 Setting DEBUG logging. 2016-10-08 18:18:15,711 attempt 1/10 2016-10-08 18:18:15,711 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/313a2d049350?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-08 18:18:16,145 unpacking tar archive at: mozilla-central-313a2d049350/testing/mozharness/ program finished with exit code 0 elapsedTime=0.815997 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-08 18:18:16.207481) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-08 18:18:16.207898) ========= script_repo_revision: 313a2d049350c88515b0b900aaf279a0ae61c7fa ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-08 18:18:16.208450) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-08 18:18:16.208783) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-08 18:18:16.217686) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-10-08 18:18:16.218033) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=62c568580acbfdaac3eec7be000001dc-1475961404.388074-116307990 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:18:16 INFO - MultiFileLogger online at 20161008 18:18:16 in /builds/slave/test 18:18:16 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 18:18:16 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:18:16 INFO - {'append_to_log': False, 18:18:16 INFO - 'base_work_dir': '/builds/slave/test', 18:18:16 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 18:18:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:18:16 INFO - 'branch': 'Firefox-Non-PGO', 18:18:16 INFO - 'buildbot_json_path': 'buildprops.json', 18:18:16 INFO - 'config_files': ('talos/linux_config.py',), 18:18:16 INFO - 'default_actions': ('clobber', 18:18:16 INFO - 'read-buildbot-config', 18:18:16 INFO - 'download-and-extract', 18:18:16 INFO - 'populate-webroot', 18:18:16 INFO - 'create-virtualenv', 18:18:16 INFO - 'install', 18:18:16 INFO - 'run-tests'), 18:18:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:18:16 INFO - 'download_minidump_stackwalk': True, 18:18:16 INFO - 'download_symbols': 'ondemand', 18:18:16 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:18:16 INFO - 'tooltool.py': '/tools/tooltool.py', 18:18:16 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:18:16 INFO - '/tools/misc-python/virtualenv.py')}, 18:18:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:18:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:18:16 INFO - 'installer_path': 'installer.exe', 18:18:16 INFO - 'log_level': 'info', 18:18:16 INFO - 'log_name': 'talos', 18:18:16 INFO - 'log_to_console': True, 18:18:16 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:18:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:18:16 INFO - 'opt_config_files': (), 18:18:16 INFO - 'pip_index': False, 18:18:16 INFO - 'sps_profile': False, 18:18:16 INFO - 'sps_profile_interval': 0, 18:18:16 INFO - 'suite': 'dromaeojs', 18:18:16 INFO - 'system_bits': '32', 18:18:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:18:16 INFO - 'title': 'talos-linux64-ix-018', 18:18:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:18:16 INFO - 'use_talos_json': True, 18:18:16 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:18:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:18:16 INFO - 'work_dir': 'build'} 18:18:16 INFO - [mozharness: 2016-10-09 01:18:16.652393Z] Running clobber step. 18:18:16 INFO - Running pre-action listener: _resource_record_pre_action 18:18:16 INFO - Running main action method: clobber 18:18:16 INFO - rmtree: /builds/slave/test/build 18:18:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:18:17 INFO - Running post-action listener: _resource_record_post_action 18:18:17 INFO - [mozharness: 2016-10-09 01:18:17.101262Z] Finished clobber step (success) 18:18:17 INFO - [mozharness: 2016-10-09 01:18:17.101520Z] Running read-buildbot-config step. 18:18:17 INFO - Running pre-action listener: _resource_record_pre_action 18:18:17 INFO - Running main action method: read_buildbot_config 18:18:17 INFO - Using buildbot properties: 18:18:17 INFO - { 18:18:17 INFO - "project": "", 18:18:17 INFO - "product": "firefox", 18:18:17 INFO - "script_repo_revision": "production", 18:18:17 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 18:18:17 INFO - "repository": "", 18:18:17 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 18:18:17 INFO - "buildid": "20161008164819", 18:18:17 INFO - "pgo_build": "False", 18:18:17 INFO - "basedir": "/builds/slave/test", 18:18:17 INFO - "buildnumber": 662, 18:18:17 INFO - "slavename": "talos-linux64-ix-018", 18:18:17 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 18:18:17 INFO - "platform": "ubuntu64_hw", 18:18:17 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 18:18:17 INFO - "branch": "mozilla-central", 18:18:17 INFO - "repo_path": "mozilla-central", 18:18:17 INFO - "revision": "313a2d049350c88515b0b900aaf279a0ae61c7fa", 18:18:17 INFO - "stage_platform": "linux64", 18:18:17 INFO - "builduid": "2751bb0d23e547aebb7c8693e735a37e", 18:18:17 INFO - "slavebuilddir": "test" 18:18:17 INFO - } 18:18:17 INFO - Found installer url https://queue.taskcluster.net/v1/task/NlSVMvtbSEuiNBTYC9r7Bw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 18:18:17 INFO - Running post-action listener: _resource_record_post_action 18:18:17 INFO - [mozharness: 2016-10-09 01:18:17.103920Z] Finished read-buildbot-config step (success) 18:18:17 INFO - [mozharness: 2016-10-09 01:18:17.104008Z] Running download-and-extract step. 18:18:17 INFO - Running pre-action listener: _resource_record_pre_action 18:18:17 INFO - Running main action method: download_and_extract 18:18:17 INFO - mkdir: /builds/slave/test/build/tests 18:18:17 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')]} 18:18:17 INFO - trying https://queue.taskcluster.net/v1/task/NlSVMvtbSEuiNBTYC9r7Bw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 18:18:17 INFO - Downloading https://queue.taskcluster.net/v1/task/NlSVMvtbSEuiNBTYC9r7Bw/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 18:18:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NlSVMvtbSEuiNBTYC9r7Bw/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 18:18:17 INFO - Downloaded 1361 bytes. 18:18:17 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 18:18:17 INFO - Using the following test package requirements: 18:18:17 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 18:18:17 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:18:17 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 18:18:17 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:18:17 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 18:18:17 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:18:17 INFO - u'jsshell-linux-x86_64.zip'], 18:18:17 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:18:17 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 18:18:17 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 18:18:17 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:18:17 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 18:18:17 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:18:17 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 18:18:17 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:18:17 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 18:18:17 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:18:17 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 18:18:17 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:18:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NlSVMvtbSEuiNBTYC9r7Bw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 18:18:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NlSVMvtbSEuiNBTYC9r7Bw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:18:17 INFO - Fetch https://queue.taskcluster.net/v1/task/NlSVMvtbSEuiNBTYC9r7Bw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 18:18:18 INFO - Http code: 200 18:18:18 INFO - via: 1.1 76bce8bb4fbd102fc0b3aa2e41094b79.cloudfront.net (CloudFront) 18:18:18 INFO - x-amz-cf-id: -TazG0AUmA8AJHnugvyhe5rAb3A1mFBEPrxcg7LTkqeZ63w02qP2iw== 18:18:18 INFO - x-amz-version-id: 7w4p2m3tNQexO5e62tKGvlGgwnn3gstx 18:18:18 INFO - Expected file size: 20524367 18:18:18 INFO - Obtained file size: 20524367 18:18:22 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 18:18:22 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NlSVMvtbSEuiNBTYC9r7Bw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 18:18:22 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NlSVMvtbSEuiNBTYC9r7Bw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:18:22 INFO - Fetch https://queue.taskcluster.net/v1/task/NlSVMvtbSEuiNBTYC9r7Bw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 18:18:23 INFO - Http code: 200 18:18:23 INFO - via: 1.1 41b2ee7cbe95749816a7586d9ab4629d.cloudfront.net (CloudFront) 18:18:23 INFO - x-amz-cf-id: E-Ig4HNig1F4sISdIWlyXuoeV0qDbmzzSg2LEc-otW9p1r3yrE9vMQ== 18:18:23 INFO - x-amz-version-id: 7w4p2m3tNQexO5e62tKGvlGgwnn3gstx 18:18:23 INFO - Expected file size: 20524367 18:18:23 INFO - Obtained file size: 20524367 18:18:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NlSVMvtbSEuiNBTYC9r7Bw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 18:18:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NlSVMvtbSEuiNBTYC9r7Bw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 18:18:27 INFO - Fetch https://queue.taskcluster.net/v1/task/NlSVMvtbSEuiNBTYC9r7Bw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 18:18:28 INFO - Http code: 200 18:18:28 INFO - via: 1.1 a75342fa94ff4a9431476624fe74f02e.cloudfront.net (CloudFront) 18:18:28 INFO - x-amz-cf-id: mrIICJMvi757_pQc9dYpMxkd1ej-7V6Lg8IDQ7XOe8WdZMXh8ES5pA== 18:18:28 INFO - x-amz-version-id: Bb0TQddGCcB95xqt6M_BB_iT4QLKk1dV 18:18:28 INFO - Expected file size: 14409006 18:18:28 INFO - Obtained file size: 14409006 18:18:29 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')]} 18:18:29 INFO - trying https://queue.taskcluster.net/v1/task/NlSVMvtbSEuiNBTYC9r7Bw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 18:18:29 INFO - Downloading https://queue.taskcluster.net/v1/task/NlSVMvtbSEuiNBTYC9r7Bw/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 18:18:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NlSVMvtbSEuiNBTYC9r7Bw/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 18:18:30 INFO - Downloaded 55831383 bytes. 18:18:30 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NlSVMvtbSEuiNBTYC9r7Bw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 18:18:30 INFO - mkdir: /builds/slave/test/properties 18:18:30 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:18:30 INFO - Writing to file /builds/slave/test/properties/build_url 18:18:30 INFO - Contents: 18:18:30 INFO - build_url:https://queue.taskcluster.net/v1/task/NlSVMvtbSEuiNBTYC9r7Bw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 18:18:30 INFO - Running post-action listener: _resource_record_post_action 18:18:30 INFO - Running post-action listener: set_extra_try_arguments 18:18:30 INFO - [mozharness: 2016-10-09 01:18:30.936722Z] Finished download-and-extract step (success) 18:18:30 INFO - [mozharness: 2016-10-09 01:18:30.936947Z] Running populate-webroot step. 18:18:30 INFO - Running pre-action listener: _resource_record_pre_action 18:18:30 INFO - Running main action method: populate_webroot 18:18:30 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:18:30 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:18:30 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:18:30 INFO - '--tppagecycles', 18:18:30 INFO - '7'], 18:18:30 INFO - 'tests': ['tsvgm']}}, 18:18:30 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 18:18:30 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:18:30 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:18:30 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:18:30 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:18:30 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:18:30 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:18:30 INFO - 'talos_options': ['--disable-e10s'], 18:18:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:18:30 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:18:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:18:30 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:18:30 INFO - 'talos_options': ['--disable-e10s'], 18:18:30 INFO - 'tests': ['damp', 'tps']}, 18:18:30 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:18:30 INFO - 'tests': ['damp', 'tps']}, 18:18:30 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:18:30 INFO - 'tests': ['dromaeo_dom']}, 18:18:30 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:18:30 INFO - 'g4': {'talos_options': ['--disable-e10s'], 18:18:30 INFO - 'tests': ['basic_compositor_video']}, 18:18:30 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 18:18:30 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:18:30 INFO - 'tests': ['a11yr', 18:18:30 INFO - 'ts_paint', 18:18:30 INFO - 'tpaint', 18:18:30 INFO - 'sessionrestore', 18:18:30 INFO - 'sessionrestore_no_auto_restore', 18:18:30 INFO - 'tabpaint']}, 18:18:30 INFO - 'other-e10s': {'tests': ['a11yr', 18:18:30 INFO - 'ts_paint', 18:18:30 INFO - 'tpaint', 18:18:30 INFO - 'sessionrestore', 18:18:30 INFO - 'sessionrestore_no_auto_restore', 18:18:30 INFO - 'tabpaint']}, 18:18:30 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:18:30 INFO - 'ts_paint', 18:18:30 INFO - 'tpaint', 18:18:30 INFO - 'sessionrestore', 18:18:30 INFO - 'sessionrestore_no_auto_restore', 18:18:30 INFO - 'tabpaint']}, 18:18:30 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:18:30 INFO - 'ts_paint', 18:18:30 INFO - 'tpaint', 18:18:30 INFO - 'sessionrestore', 18:18:30 INFO - 'sessionrestore_no_auto_restore', 18:18:30 INFO - 'tabpaint']}, 18:18:30 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:18:30 INFO - 'tests': ['a11yr', 18:18:30 INFO - 'ts_paint', 18:18:30 INFO - 'tpaint', 18:18:30 INFO - 'sessionrestore', 18:18:30 INFO - 'sessionrestore_no_auto_restore', 18:18:30 INFO - 'tabpaint']}, 18:18:30 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:18:30 INFO - 'tests': ['a11yr', 18:18:30 INFO - 'ts_paint', 18:18:30 INFO - 'tpaint', 18:18:30 INFO - 'sessionrestore', 18:18:30 INFO - 'sessionrestore_no_auto_restore', 18:18:30 INFO - 'tabpaint']}, 18:18:30 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:18:30 INFO - 'tests': ['tsvgx', 18:18:30 INFO - 'tsvgr_opacity', 18:18:30 INFO - 'tart', 18:18:30 INFO - 'tscrollx', 18:18:30 INFO - 'cart']}, 18:18:30 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:18:30 INFO - 'tsvgr_opacity', 18:18:30 INFO - 'tart', 18:18:30 INFO - 'tscrollx', 18:18:30 INFO - 'cart']}, 18:18:30 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:18:30 INFO - 'talos_options': ['--disable-e10s'], 18:18:30 INFO - 'tests': ['tp5o']}, 18:18:30 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:18:30 INFO - 'tests': ['tp5o']}, 18:18:30 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:18:30 INFO - 'talos_options': ['--disable-e10s', 18:18:30 INFO - '--xperf_path', 18:18:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:18:30 INFO - 'tests': ['tp5n']}, 18:18:30 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:18:30 INFO - 'talos_options': ['--xperf_path', 18:18:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:18:30 INFO - 'tests': ['tp5n']}}, 18:18:30 INFO - 'talos.zip': {'path': '', 18:18:30 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:18:30 INFO - Running post-action listener: _resource_record_post_action 18:18:30 INFO - [mozharness: 2016-10-09 01:18:30.953103Z] Finished populate-webroot step (success) 18:18:30 INFO - [mozharness: 2016-10-09 01:18:30.953190Z] Running create-virtualenv step. 18:18:30 INFO - Running pre-action listener: _resource_record_pre_action 18:18:30 INFO - Running main action method: create_virtualenv 18:18:30 INFO - Creating virtualenv /builds/slave/test/build/venv 18:18:30 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 18:18:30 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:18:31 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:18:31 INFO - Using real prefix '/usr' 18:18:31 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:18:31 INFO - Installing distribute.............................................................................................................................................................................................done. 18:18:33 INFO - Installing pip.................done. 18:18:33 INFO - Return code: 0 18:18:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 18:18:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 18:18:33 INFO - Reading from file tmpfile_stdout 18:18:33 INFO - Output received: 18:18:33 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 18:18:33 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:18:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:18:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:18:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:18:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:18:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:18:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:18:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1bdddbef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ade8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1babca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ba8f60>, '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 0x1ba9d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1baa1d0>, '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': '62c568580acbfdaac3eec7be000001dc-1475961404.388074-116307990', '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 18:18:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 18:18:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 18:18:33 INFO - Using env: {'DISPLAY': ':0', 18:18:33 INFO - 'HOME': '/home/cltbld', 18:18:33 INFO - 'LANG': 'en_US.UTF-8', 18:18:33 INFO - 'LANGUAGE': 'en_US:en', 18:18:33 INFO - 'LOGNAME': 'cltbld', 18:18:33 INFO - 'MAIL': '/var/mail/cltbld', 18:18:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:18:33 INFO - 'MOZ_NO_REMOTE': '1', 18:18:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:18:33 INFO - 'NO_EM_RESTART': '1', 18:18:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:18:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:18:33 INFO - 'PWD': '/builds/slave/test', 18:18:33 INFO - 'SHELL': '/bin/bash', 18:18:33 INFO - 'SHLVL': '1', 18:18:33 INFO - 'TERM': 'linux', 18:18:33 INFO - 'TMOUT': '86400', 18:18:33 INFO - 'USER': 'cltbld', 18:18:33 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1475961404.388074-116307990', 18:18:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:18:33 INFO - '_': '/tools/buildbot/bin/python'} 18:18:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:18:33 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 18:18:33 INFO - Cleaning up... 18:18:33 INFO - Return code: 0 18:18:33 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:18:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:18:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:18:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:18:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:18:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:18:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:18:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1bdddbef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ade8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1babca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ba8f60>, '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 0x1ba9d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1baa1d0>, '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': '62c568580acbfdaac3eec7be000001dc-1475961404.388074-116307990', '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 18:18:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 18:18:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 18:18:33 INFO - Using env: {'DISPLAY': ':0', 18:18:33 INFO - 'HOME': '/home/cltbld', 18:18:33 INFO - 'LANG': 'en_US.UTF-8', 18:18:33 INFO - 'LANGUAGE': 'en_US:en', 18:18:33 INFO - 'LOGNAME': 'cltbld', 18:18:33 INFO - 'MAIL': '/var/mail/cltbld', 18:18:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:18:33 INFO - 'MOZ_NO_REMOTE': '1', 18:18:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:18:33 INFO - 'NO_EM_RESTART': '1', 18:18:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:18:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:18:33 INFO - 'PWD': '/builds/slave/test', 18:18:33 INFO - 'SHELL': '/bin/bash', 18:18:33 INFO - 'SHLVL': '1', 18:18:33 INFO - 'TERM': 'linux', 18:18:33 INFO - 'TMOUT': '86400', 18:18:33 INFO - 'USER': 'cltbld', 18:18:33 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1475961404.388074-116307990', 18:18:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:18:33 INFO - '_': '/tools/buildbot/bin/python'} 18:18:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:18:34 INFO - Downloading/unpacking psutil>=3.1.1 18:18: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 18:18: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 18:18: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 18:18: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 18:18: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 18:18: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 18:18:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:18:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:18:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:18:36 INFO - Installing collected packages: psutil 18:18:36 INFO - Running setup.py install for psutil 18:18:36 INFO - building 'psutil._psutil_linux' extension 18:18:36 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 18:18:36 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 18:18:36 INFO - building 'psutil._psutil_posix' extension 18:18:36 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 18:18:36 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 18:18:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:18:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:18:36 INFO - Successfully installed psutil 18:18:36 INFO - Cleaning up... 18:18:36 INFO - Return code: 0 18:18:36 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:18: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')]} 18:18:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:18:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:18: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')]} 18:18:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:18:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:18:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1bdddbef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ade8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1babca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ba8f60>, '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 0x1ba9d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1baa1d0>, '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': '62c568580acbfdaac3eec7be000001dc-1475961404.388074-116307990', '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 18:18:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 18:18:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 18:18:36 INFO - Using env: {'DISPLAY': ':0', 18:18:36 INFO - 'HOME': '/home/cltbld', 18:18:36 INFO - 'LANG': 'en_US.UTF-8', 18:18:36 INFO - 'LANGUAGE': 'en_US:en', 18:18:36 INFO - 'LOGNAME': 'cltbld', 18:18:36 INFO - 'MAIL': '/var/mail/cltbld', 18:18:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:18:36 INFO - 'MOZ_NO_REMOTE': '1', 18:18:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:18:36 INFO - 'NO_EM_RESTART': '1', 18:18:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:18:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:18:36 INFO - 'PWD': '/builds/slave/test', 18:18:36 INFO - 'SHELL': '/bin/bash', 18:18:36 INFO - 'SHLVL': '1', 18:18:36 INFO - 'TERM': 'linux', 18:18:36 INFO - 'TMOUT': '86400', 18:18:36 INFO - 'USER': 'cltbld', 18:18:36 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1475961404.388074-116307990', 18:18:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:18:36 INFO - '_': '/tools/buildbot/bin/python'} 18:18:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:18:36 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:18: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 18:18: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 18:18: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 18:18: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 18:18: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 18:18: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 18:18:38 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:18:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:18:38 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:18:38 INFO - Installing collected packages: mozsystemmonitor 18:18:38 INFO - Running setup.py install for mozsystemmonitor 18:18:39 INFO - Successfully installed mozsystemmonitor 18:18:39 INFO - Cleaning up... 18:18:39 INFO - Return code: 0 18:18:39 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:18: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')]} 18:18:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:18:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:18: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')]} 18:18:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:18:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:18: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', '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 0x7f1bdddbef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ade8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1babca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ba8f60>, '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 0x1ba9d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1baa1d0>, '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': '62c568580acbfdaac3eec7be000001dc-1475961404.388074-116307990', '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 18:18: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 18:18: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 jsonschema==2.5.1 18:18:39 INFO - Using env: {'DISPLAY': ':0', 18:18:39 INFO - 'HOME': '/home/cltbld', 18:18:39 INFO - 'LANG': 'en_US.UTF-8', 18:18:39 INFO - 'LANGUAGE': 'en_US:en', 18:18:39 INFO - 'LOGNAME': 'cltbld', 18:18:39 INFO - 'MAIL': '/var/mail/cltbld', 18:18:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:18:39 INFO - 'MOZ_NO_REMOTE': '1', 18:18:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:18:39 INFO - 'NO_EM_RESTART': '1', 18:18:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:18:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:18:39 INFO - 'PWD': '/builds/slave/test', 18:18:39 INFO - 'SHELL': '/bin/bash', 18:18:39 INFO - 'SHLVL': '1', 18:18:39 INFO - 'TERM': 'linux', 18:18:39 INFO - 'TMOUT': '86400', 18:18:39 INFO - 'USER': 'cltbld', 18:18:39 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1475961404.388074-116307990', 18:18:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:18:39 INFO - '_': '/tools/buildbot/bin/python'} 18:18:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:18:39 INFO - Downloading/unpacking jsonschema==2.5.1 18:18: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 18:18: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 18:18: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 18:18: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 18:18: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 18:18: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 18:18:41 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:18:41 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:18: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 18:18: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 18:18: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 18:18: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 18:18: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 18:18: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 18:18:41 INFO - Downloading functools32-3.2.3-2.tar.gz 18:18:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:18:41 INFO - warning: no files found matching '*.txt' 18:18:41 INFO - no previously-included directories found matching 'build' 18:18:41 INFO - no previously-included directories found matching 'dist' 18:18:41 INFO - no previously-included directories found matching '.git*' 18:18:41 INFO - Installing collected packages: jsonschema, functools32 18:18:41 INFO - Running setup.py install for functools32 18:18:41 INFO - warning: no files found matching '*.txt' 18:18:41 INFO - no previously-included directories found matching 'build' 18:18:41 INFO - no previously-included directories found matching 'dist' 18:18:41 INFO - no previously-included directories found matching '.git*' 18:18:41 INFO - Successfully installed jsonschema functools32 18:18:41 INFO - Cleaning up... 18:18:41 INFO - Return code: 0 18:18:41 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 18:18:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:18:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:18:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:18:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:18:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:18:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:18:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1bdddbef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ade8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1babca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ba8f60>, '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 0x1ba9d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1baa1d0>, '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': '62c568580acbfdaac3eec7be000001dc-1475961404.388074-116307990', '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 18:18:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 18:18:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 18:18:41 INFO - Using env: {'DISPLAY': ':0', 18:18:41 INFO - 'HOME': '/home/cltbld', 18:18:41 INFO - 'LANG': 'en_US.UTF-8', 18:18:41 INFO - 'LANGUAGE': 'en_US:en', 18:18:41 INFO - 'LOGNAME': 'cltbld', 18:18:41 INFO - 'MAIL': '/var/mail/cltbld', 18:18:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:18:41 INFO - 'MOZ_NO_REMOTE': '1', 18:18:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:18:41 INFO - 'NO_EM_RESTART': '1', 18:18:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:18:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:18:41 INFO - 'PWD': '/builds/slave/test', 18:18:41 INFO - 'SHELL': '/bin/bash', 18:18:41 INFO - 'SHLVL': '1', 18:18:41 INFO - 'TERM': 'linux', 18:18:41 INFO - 'TMOUT': '86400', 18:18:41 INFO - 'USER': 'cltbld', 18:18:41 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1475961404.388074-116307990', 18:18:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:18:41 INFO - '_': '/tools/buildbot/bin/python'} 18:18:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:18:41 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 18:18:41 INFO - Cleaning up... 18:18:41 INFO - Return code: 0 18:18:41 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:18:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:18:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:18:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:18:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:18:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:18:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:18:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1bdddbef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ade8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1babca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ba8f60>, '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 0x1ba9d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1baa1d0>, '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': '62c568580acbfdaac3eec7be000001dc-1475961404.388074-116307990', '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 18:18:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 18:18:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 18:18:41 INFO - Using env: {'DISPLAY': ':0', 18:18:41 INFO - 'HOME': '/home/cltbld', 18:18:41 INFO - 'LANG': 'en_US.UTF-8', 18:18:41 INFO - 'LANGUAGE': 'en_US:en', 18:18:41 INFO - 'LOGNAME': 'cltbld', 18:18:41 INFO - 'MAIL': '/var/mail/cltbld', 18:18:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:18:41 INFO - 'MOZ_NO_REMOTE': '1', 18:18:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:18:41 INFO - 'NO_EM_RESTART': '1', 18:18:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:18:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:18:41 INFO - 'PWD': '/builds/slave/test', 18:18:41 INFO - 'SHELL': '/bin/bash', 18:18:41 INFO - 'SHLVL': '1', 18:18:41 INFO - 'TERM': 'linux', 18:18:41 INFO - 'TMOUT': '86400', 18:18:41 INFO - 'USER': 'cltbld', 18:18:41 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1475961404.388074-116307990', 18:18:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:18:41 INFO - '_': '/tools/buildbot/bin/python'} 18:18:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:18:42 INFO - Downloading/unpacking blobuploader==1.2.4 18:18: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 18:18: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 18:18: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 18:18: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 18:18: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 18:18: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 18:18:44 INFO - Downloading blobuploader-1.2.4.tar.gz 18:18:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:18:44 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:18:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:18:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:18:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:18:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:18:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:18:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:18:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:18:44 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:18:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:18:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:18:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:18:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:18:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:18:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:18:44 INFO - Downloading docopt-0.6.1.tar.gz 18:18:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:18:44 INFO - Installing collected packages: blobuploader, requests, docopt 18:18:44 INFO - Running setup.py install for blobuploader 18:18:44 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:18:44 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:18:44 INFO - Running setup.py install for requests 18:18:45 INFO - Running setup.py install for docopt 18:18:45 INFO - Successfully installed blobuploader requests docopt 18:18:45 INFO - Cleaning up... 18:18:45 INFO - Return code: 0 18:18:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:18:45 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')]} 18:18:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:18:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:18:45 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')]} 18:18:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:18:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:18:45 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 0x7f1bdddbef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ade8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1babca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ba8f60>, '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 0x1ba9d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1baa1d0>, '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': '62c568580acbfdaac3eec7be000001dc-1475961404.388074-116307990', '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 18:18:45 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 18:18:45 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 18:18:45 INFO - Using env: {'DISPLAY': ':0', 18:18:45 INFO - 'HOME': '/home/cltbld', 18:18:45 INFO - 'LANG': 'en_US.UTF-8', 18:18:45 INFO - 'LANGUAGE': 'en_US:en', 18:18:45 INFO - 'LOGNAME': 'cltbld', 18:18:45 INFO - 'MAIL': '/var/mail/cltbld', 18:18:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:18:45 INFO - 'MOZ_NO_REMOTE': '1', 18:18:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:18:45 INFO - 'NO_EM_RESTART': '1', 18:18:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:18:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:18:45 INFO - 'PWD': '/builds/slave/test', 18:18:45 INFO - 'SHELL': '/bin/bash', 18:18:45 INFO - 'SHLVL': '1', 18:18:45 INFO - 'TERM': 'linux', 18:18:45 INFO - 'TMOUT': '86400', 18:18:45 INFO - 'USER': 'cltbld', 18:18:45 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1475961404.388074-116307990', 18:18:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:18:45 INFO - '_': '/tools/buildbot/bin/python'} 18:18:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:18:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:18:45 INFO - Running setup.py (path:/tmp/pip-jnOzIJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:18:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:18:45 INFO - Running setup.py (path:/tmp/pip-xgdwd9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:18:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:18:45 INFO - Running setup.py (path:/tmp/pip-xJ9ZP6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:18:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:18:45 INFO - Running setup.py (path:/tmp/pip-E1W0ck-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:18:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:18:45 INFO - Running setup.py (path:/tmp/pip-4zbgXq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:18:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:18:46 INFO - Running setup.py (path:/tmp/pip-561903-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:18:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:18:46 INFO - Running setup.py (path:/tmp/pip-B_Bb_r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:18:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:18:46 INFO - Running setup.py (path:/tmp/pip-E3MJft-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:18:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:18:46 INFO - Running setup.py (path:/tmp/pip-WEw6Al-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:18:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:18:46 INFO - Running setup.py (path:/tmp/pip-BT_wlY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:18:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:18:46 INFO - Running setup.py (path:/tmp/pip-T6D5Sl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:18:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:18:46 INFO - Running setup.py (path:/tmp/pip-hSXuJN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:18:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:18:46 INFO - Running setup.py (path:/tmp/pip-KeHats-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:18:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:18:46 INFO - Running setup.py (path:/tmp/pip-8DXXpY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:18:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:18:46 INFO - Running setup.py (path:/tmp/pip-Pu0sdr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:18:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:18:46 INFO - Running setup.py (path:/tmp/pip-acZhL5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:18:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:18:46 INFO - Running setup.py (path:/tmp/pip-v63UUB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:18:46 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:18:46 INFO - Running setup.py install for manifestparser 18:18:47 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:18:47 INFO - Running setup.py install for mozcrash 18:18:47 INFO - Running setup.py install for mozdebug 18:18:47 INFO - Running setup.py install for mozdevice 18:18:47 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:18:47 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:18:47 INFO - Running setup.py install for mozfile 18:18:47 INFO - Running setup.py install for mozhttpd 18:18:47 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:18:47 INFO - Running setup.py install for mozinfo 18:18:47 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:18:47 INFO - Running setup.py install for mozInstall 18:18:47 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:18:47 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:18:47 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:18:47 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:18:47 INFO - Running setup.py install for mozleak 18:18:47 INFO - Running setup.py install for mozlog 18:18:47 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:18:47 INFO - Running setup.py install for moznetwork 18:18:48 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:18:48 INFO - Running setup.py install for mozprocess 18:18:48 INFO - Running setup.py install for mozprofile 18:18:48 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:18:48 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:18:48 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:18:48 INFO - Running setup.py install for mozrunner 18:18:48 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:18:48 INFO - Running setup.py install for mozscreenshot 18:18:48 INFO - Running setup.py install for moztest 18:18:48 INFO - Running setup.py install for mozversion 18:18:48 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:18:48 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:18:48 INFO - Cleaning up... 18:18:48 INFO - Return code: 0 18:18:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:18:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:18:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:18:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:18:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:18:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:18:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:18:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1bdddbef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ade8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1babca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ba8f60>, '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 0x1ba9d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1baa1d0>, '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': '62c568580acbfdaac3eec7be000001dc-1475961404.388074-116307990', '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 18:18:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 18:18:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:18:48 INFO - Using env: {'DISPLAY': ':0', 18:18:48 INFO - 'HOME': '/home/cltbld', 18:18:48 INFO - 'LANG': 'en_US.UTF-8', 18:18:48 INFO - 'LANGUAGE': 'en_US:en', 18:18:48 INFO - 'LOGNAME': 'cltbld', 18:18:48 INFO - 'MAIL': '/var/mail/cltbld', 18:18:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:18:48 INFO - 'MOZ_NO_REMOTE': '1', 18:18:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:18:48 INFO - 'NO_EM_RESTART': '1', 18:18:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:18:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:18:48 INFO - 'PWD': '/builds/slave/test', 18:18:48 INFO - 'SHELL': '/bin/bash', 18:18:48 INFO - 'SHLVL': '1', 18:18:48 INFO - 'TERM': 'linux', 18:18:48 INFO - 'TMOUT': '86400', 18:18:48 INFO - 'USER': 'cltbld', 18:18:48 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1475961404.388074-116307990', 18:18:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:18:48 INFO - '_': '/tools/buildbot/bin/python'} 18:18:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:18:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:18:48 INFO - Running setup.py (path:/tmp/pip-P1iRwy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:18:49 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)) 18:18:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:18:49 INFO - Running setup.py (path:/tmp/pip-ptJhLF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:18:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:18:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:18:49 INFO - Running setup.py (path:/tmp/pip-6qCTom-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:18:49 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)) 18:18:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:18:49 INFO - Running setup.py (path:/tmp/pip-fVb36h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:18:49 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)) 18:18:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:18:49 INFO - Running setup.py (path:/tmp/pip-pwxAEC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:18:49 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)) 18:18:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:18:49 INFO - Running setup.py (path:/tmp/pip-5Rmaqc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:18:49 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)) 18:18:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:18:49 INFO - Running setup.py (path:/tmp/pip-QN0dnR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:18:49 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)) 18:18:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:18:49 INFO - Running setup.py (path:/tmp/pip-5YIAMH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:18:49 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)) 18:18:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:18:49 INFO - Running setup.py (path:/tmp/pip-Zk8iOB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:18:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 18:18:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:18:49 INFO - Running setup.py (path:/tmp/pip-drcP4V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:18:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:18:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:18:49 INFO - Running setup.py (path:/tmp/pip-mpRVuS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:18:49 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 18:18:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:18:49 INFO - Running setup.py (path:/tmp/pip-tYfevc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:18:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 18:18:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:18:49 INFO - Running setup.py (path:/tmp/pip-AUUBpS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:18:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 18:18:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:18:49 INFO - Running setup.py (path:/tmp/pip-kw5idw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:18:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 18:18:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:18:49 INFO - Running setup.py (path:/tmp/pip-k8Akw_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:18:50 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)) 18:18:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:18:50 INFO - Running setup.py (path:/tmp/pip-rZVfjX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:18:50 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)) 18:18:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:18:50 INFO - Running setup.py (path:/tmp/pip-BMteXH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:18:50 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)) 18:18:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:18:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:18:50 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)) 18:18:50 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)) 18:18:50 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)) 18:18:50 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:18:50 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 18:18:50 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 18:18:50 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 18:18:50 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 18:18:50 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 18:18:50 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 18:18:52 INFO - Downloading blessings-1.6.tar.gz 18:18:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:18:52 INFO - Installing collected packages: blessings 18:18:52 INFO - Running setup.py install for blessings 18:18:52 INFO - Successfully installed blessings 18:18:52 INFO - Cleaning up... 18:18:52 INFO - Return code: 0 18:18:52 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:18:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:18:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:18:52 INFO - Reading from file tmpfile_stdout 18:18:52 INFO - Current package versions: 18:18:52 INFO - argparse == 1.2.1 18:18:52 INFO - blessings == 1.6 18:18:52 INFO - blobuploader == 1.2.4 18:18:52 INFO - docopt == 0.6.1 18:18:52 INFO - functools32 == 3.2.3-2 18:18:52 INFO - jsonschema == 2.5.1 18:18:52 INFO - manifestparser == 1.1 18:18:52 INFO - mozInstall == 1.12 18:18:52 INFO - mozcrash == 0.17 18:18:52 INFO - mozdebug == 0.1 18:18:52 INFO - mozdevice == 0.48 18:18:52 INFO - mozfile == 1.2 18:18:52 INFO - mozhttpd == 0.7 18:18:52 INFO - mozinfo == 0.9 18:18:52 INFO - mozleak == 0.1 18:18:52 INFO - mozlog == 3.4 18:18:52 INFO - moznetwork == 0.27 18:18:52 INFO - mozprocess == 0.23 18:18:52 INFO - mozprofile == 0.28 18:18:52 INFO - mozrunner == 6.12 18:18:52 INFO - mozscreenshot == 0.1 18:18:52 INFO - mozsystemmonitor == 0.3 18:18:52 INFO - moztest == 0.7 18:18:52 INFO - mozversion == 1.4 18:18:52 INFO - psutil == 3.1.1 18:18:52 INFO - requests == 1.2.3 18:18:52 INFO - wsgiref == 0.1.2 18:18:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:18:52 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')]} 18:18:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:18:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:18:52 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')]} 18:18:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:18:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:18:52 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 0x7f1bdddbef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ade8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1babca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ba8f60>, '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 0x1ba9d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1baa1d0>, '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': '62c568580acbfdaac3eec7be000001dc-1475961404.388074-116307990', '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 18:18:52 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 18:18:52 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 18:18:52 INFO - Using env: {'DISPLAY': ':0', 18:18:52 INFO - 'HOME': '/home/cltbld', 18:18:52 INFO - 'LANG': 'en_US.UTF-8', 18:18:52 INFO - 'LANGUAGE': 'en_US:en', 18:18:52 INFO - 'LOGNAME': 'cltbld', 18:18:52 INFO - 'MAIL': '/var/mail/cltbld', 18:18:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:18:52 INFO - 'MOZ_NO_REMOTE': '1', 18:18:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:18:52 INFO - 'NO_EM_RESTART': '1', 18:18:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:18:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:18:52 INFO - 'PWD': '/builds/slave/test', 18:18:52 INFO - 'SHELL': '/bin/bash', 18:18:52 INFO - 'SHLVL': '1', 18:18:52 INFO - 'TERM': 'linux', 18:18:52 INFO - 'TMOUT': '86400', 18:18:52 INFO - 'USER': 'cltbld', 18:18:52 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1475961404.388074-116307990', 18:18:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:18:52 INFO - '_': '/tools/buildbot/bin/python'} 18:18:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:18:52 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)) 18:18:52 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)) 18:18:52 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)) 18:18:52 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)) 18:18:52 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)) 18:18:52 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)) 18:18:52 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)) 18:18:52 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)) 18:18:52 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)) 18:18:52 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)) 18:18:52 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)) 18:18:52 INFO - Cleaning up... 18:18:52 INFO - Return code: 0 18:18:52 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:18:52 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')]} 18:18:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:18:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:18:52 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')]} 18:18:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:18:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:18:52 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 0x7f1bdddbef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ade8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1babca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ba8f60>, '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 0x1ba9d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1baa1d0>, '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': '62c568580acbfdaac3eec7be000001dc-1475961404.388074-116307990', '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 18:18:52 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 18:18:52 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 18:18:52 INFO - Using env: {'DISPLAY': ':0', 18:18:52 INFO - 'HOME': '/home/cltbld', 18:18:52 INFO - 'LANG': 'en_US.UTF-8', 18:18:52 INFO - 'LANGUAGE': 'en_US:en', 18:18:52 INFO - 'LOGNAME': 'cltbld', 18:18:52 INFO - 'MAIL': '/var/mail/cltbld', 18:18:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:18:52 INFO - 'MOZ_NO_REMOTE': '1', 18:18:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:18:52 INFO - 'NO_EM_RESTART': '1', 18:18:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:18:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:18:52 INFO - 'PWD': '/builds/slave/test', 18:18:52 INFO - 'SHELL': '/bin/bash', 18:18:52 INFO - 'SHLVL': '1', 18:18:52 INFO - 'TERM': 'linux', 18:18:52 INFO - 'TMOUT': '86400', 18:18:52 INFO - 'USER': 'cltbld', 18:18:52 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1475961404.388074-116307990', 18:18:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:18:52 INFO - '_': '/tools/buildbot/bin/python'} 18:18:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:18:53 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:18:53 INFO - Cleaning up... 18:18:53 INFO - Return code: 0 18:18:53 INFO - Running post-action listener: _resource_record_post_action 18:18:53 INFO - Running post-action listener: _start_resource_monitoring 18:18:53 INFO - Starting resource monitoring. 18:18:53 INFO - [mozharness: 2016-10-09 01:18:53.120441Z] Finished create-virtualenv step (success) 18:18:53 INFO - [mozharness: 2016-10-09 01:18:53.120898Z] Running install step. 18:18:53 INFO - Running pre-action listener: _resource_record_pre_action 18:18:53 INFO - Running main action method: install 18:18:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:18:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:18:53 INFO - Reading from file tmpfile_stdout 18:18:53 INFO - Detecting whether we're running mozinstall >=1.0... 18:18:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:18:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:18:53 INFO - Reading from file tmpfile_stdout 18:18:53 INFO - Output received: 18:18:53 INFO - Usage: mozinstall [options] installer 18:18:53 INFO - Options: 18:18:53 INFO - -h, --help show this help message and exit 18:18:53 INFO - -d DEST, --destination=DEST 18:18:53 INFO - Directory to install application into. [default: 18:18:53 INFO - "/builds/slave/test"] 18:18:53 INFO - --app=APP Application being installed. [default: firefox] 18:18:53 INFO - mkdir: /builds/slave/test/build/application 18:18:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 18:18:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 18:19:09 INFO - Reading from file tmpfile_stdout 18:19:09 INFO - Output received: 18:19:09 INFO - /builds/slave/test/build/application/firefox/firefox 18:19:09 INFO - Running post-action listener: _resource_record_post_action 18:19:09 INFO - [mozharness: 2016-10-09 01:19:09.558815Z] Finished install step (success) 18:19:09 INFO - [mozharness: 2016-10-09 01:19:09.559029Z] Running run-tests step. 18:19:09 INFO - Running pre-action listener: _resource_record_pre_action 18:19:09 INFO - Running main action method: run_tests 18:19:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:19:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:19:09 INFO - Python 2.7.3 18:19:09 INFO - Return code: 0 18:19:09 INFO - grabbing minidump binary from tooltool 18:19:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:19:09 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ba8f60>, '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 0x1ba9d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1baa1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:19:09 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 18:19:09 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 18:19:09 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 18:19:09 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:19:09 INFO - Return code: 0 18:19:09 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:19:09 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:19:09 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:19:09 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:19:09 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:19:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NlSVMvtbSEuiNBTYC9r7Bw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--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 18:19:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/NlSVMvtbSEuiNBTYC9r7Bw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-018 --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 18:19:09 INFO - Using env: {'DISPLAY': ':0', 18:19:09 INFO - 'HOME': '/home/cltbld', 18:19:09 INFO - 'LANG': 'en_US.UTF-8', 18:19:09 INFO - 'LANGUAGE': 'en_US:en', 18:19:09 INFO - 'LOGNAME': 'cltbld', 18:19:09 INFO - 'MAIL': '/var/mail/cltbld', 18:19:09 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:19:09 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:19:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:19:09 INFO - 'MOZ_NO_REMOTE': '1', 18:19:09 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:19:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:19:09 INFO - 'NO_EM_RESTART': '1', 18:19:09 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:19:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:19:09 INFO - 'PWD': '/builds/slave/test', 18:19:09 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:19:09 INFO - 'SHELL': '/bin/bash', 18:19:09 INFO - 'SHLVL': '1', 18:19:09 INFO - 'TERM': 'linux', 18:19:09 INFO - 'TMOUT': '86400', 18:19:09 INFO - 'USER': 'cltbld', 18:19:09 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1475961404.388074-116307990', 18:19:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:19:09 INFO - '_': '/tools/buildbot/bin/python'} 18:19:09 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NlSVMvtbSEuiNBTYC9r7Bw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--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 18:19:09 INFO - mozversion application_buildid: 20161008164819 18:19:09 INFO - mozversion application_changeset: 313a2d049350c88515b0b900aaf279a0ae61c7fa 18:19:09 INFO - mozversion application_display_name: Nightly 18:19:09 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:19:09 INFO - mozversion application_name: Firefox 18:19:09 INFO - mozversion application_remotingname: firefox 18:19:09 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 18:19:09 INFO - mozversion application_vendor: Mozilla 18:19:09 INFO - mozversion application_version: 52.0a1 18:19:09 INFO - mozversion platform_buildid: 20161008164819 18:19:09 INFO - mozversion platform_changeset: 313a2d049350c88515b0b900aaf279a0ae61c7fa 18:19:09 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 18:19:09 INFO - mozversion platform_version: 52.0a1 18:19:09 INFO - using testdate: 1475975949 18:19:09 INFO - actual date: 1475975949 18:19:09 INFO - starting webserver on 'localhost:37293' 18:19:09 INFO - SUITE-START | Running 2 tests 18:19:09 INFO - TEST-START | dromaeo_css 18:19:09 INFO - operating with platform_type : linux_ 18:19:09 INFO - Initialising browser for dromaeo_css test... 18:19:09 INFO - TEST-INFO | started process 7324 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxaTI0Y/profile http://localhost:37293/getInfo.html) 18:19:14 INFO - PROCESS | 7324 | __metrics Screen width/height:1600/1200 18:19:14 INFO - PROCESS | 7324 | colorDepth:24 18:19:14 INFO - PROCESS | 7324 | Browser inner width/height: 1024/697 18:19:14 INFO - PROCESS | 7324 | __metrics 18:19:14 INFO - PROCESS | 7324 | 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" 18:19:14 INFO - PROCESS | 7324 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:19:14 INFO - PROCESS | 7324 | console.error: PushService: 18:19:14 INFO - PROCESS | 7324 | stateChangeProcessEnqueue: Error transitioning state 18:19:14 INFO - PROCESS | 7324 | UnknownError 18:19:15 INFO - TEST-INFO | 7324: exit 0 18:19:15 INFO - Browser initialized. 18:19:15 INFO - Running cycle 1/1 for dromaeo_css test... 18:19:15 INFO - TEST-INFO | started process 7406 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxaTI0Y/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:19:27 INFO - PROCESS | 7406 | RSS: Main: 174362624 18:19:27 INFO - PROCESS | 7406 | 18:20:19 INFO - PROCESS | 7406 | 1475976019770 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] 18:22:33 INFO - PROCESS | 7406 | Cycle 1(1): loaded http://localhost:37293/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37293/tests/dromaeo/cssquery-ext.html) 18:22:35 INFO - PROCESS | 7406 | RSS: Main: 332525568 18:22:35 INFO - PROCESS | 7406 | 18:25:38 INFO - PROCESS | 7406 | Cycle 1(1): loaded http://localhost:37293/tests/dromaeo/cssquery-ext.html (next: http://localhost:37293/tests/dromaeo/cssquery-jquery.html) 18:25:39 INFO - PROCESS | 7406 | RSS: Main: 273145856 18:25:39 INFO - PROCESS | 7406 | 18:28:41 INFO - PROCESS | 7406 | Cycle 1(1): loaded http://localhost:37293/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37293/tests/dromaeo/cssquery-mootools.html) 18:28:41 INFO - PROCESS | 7406 | RSS: Main: 266153984 18:28:41 INFO - PROCESS | 7406 | 18:31:44 INFO - PROCESS | 7406 | Cycle 1(1): loaded http://localhost:37293/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37293/tests/dromaeo/cssquery-prototype.html) 18:31:44 INFO - PROCESS | 7406 | RSS: Main: 217706496 18:31:44 INFO - PROCESS | 7406 | 18:34:47 INFO - PROCESS | 7406 | Cycle 1(1): loaded http://localhost:37293/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37293/tests/dromaeo/cssquery-yui.html) 18:34:48 INFO - PROCESS | 7406 | RSS: Main: 219471872 18:34:48 INFO - PROCESS | 7406 | 18:37:51 INFO - PROCESS | 7406 | Cycle 1(1): loaded http://localhost:37293/tests/dromaeo/cssquery-yui.html (next: http://localhost:37293/tests/dromaeo/cssquery-dojo.html) 18:37:51 INFO - PROCESS | 7406 | RSS: Main: 311070720 18:37:51 INFO - PROCESS | 7406 | 18:37:51 INFO - PROCESS | 7406 | __start_tp_report 18:37:51 INFO - PROCESS | 7406 | _x_x_mozilla_page_load 18:37:51 INFO - PROCESS | 7406 | _x_x_mozilla_page_load_details 18:37:51 INFO - PROCESS | 7406 | |i|pagename|runs| 18:37:51 INFO - PROCESS | 7406 | |0;dojo.html;2582.005927717828;2587.495438389514;2600.7399260073994;2615.7384261573834;2630.3950091478973;4552;4625.352450656911;4648.907506735919;4670.065986802636;4671.065786842632;4663.207254766689;4666.8366607168755;4684.929726054112;4687.039156972821;4689.413823272091;4283.186194623027;4300.118475712487;4321.675874309423;4341.066670665807;4368.672349573794;4361.040571074374;4402.537733537981;4413.293872980324;4420.1159768046355;4463.375127482155;4366.4978527469275;4372.366006928994;4427.2695005324085;4433;4491.865244042684;3996.4205190247544;4334.371516130143;4421.425214722081;4445.533219012022;4458.576435238647;4405.669574781872;4419.270820314644;4441.644668426518;4471.128130014648;4482.103579284156;4624.791884365211;4670.929936050962;4678;4755.453122890877;4812.975935120302;5006.374203224597;5011.523905228997;5070.264811602297;5072.2391641253735;5074.31496747938;5013.273075404082;5049.4950504949575;5160;5160.845174644766;5167.044096842096;4642.76786160694;4717.669763116549;4717.693349932243;4720.693154944917;4776;5174.8965020700125;5185.170372740344;5189.532942035235;5190.403103643054;5256.421793602701;4818.71087734737;4857.587105096107;4882.902341953141;4913.1893237615395;4919.434265059564;4977.701337919736;5008.5993120550265;5019.52314530119;5028.19548872186;5086.338775959101;4950.2822090796635;4961.8511444656715;4965.33661223487;4968.975155124202;5030.748462576929;4819.927701084486;4864.878378040577;4867.318575399447;4930.901381972412;4958.454569997298;4258.659307255412;4263.16868210696;4305.590968857953;4308.009157893702;4312.9137417252105;3717.628237176315;3727.5340582427198;3732.533433320835;3774.981125094357;3789.0906182515996;4268.722533035405;4301.591348821857;4304.246756817544;4394.868153955386;4395.714278571946;4987.127252730757;5014.824481143142;5034.672746271481;5066.771995260222;5140.56305214061;4363.629091527192;4374.147041326974;4376.168527979674;4380.3210502372185;4432.15789000089;4423.358613001161;4545.749983750926;4549.613282870927;4554.066416384633;4591.540845915381;4674.322223277538;4712.481627021093;4743.952560474351;4748.976255118702;4750.07373562152;5089.821856235014;5146.176611742103;5158.3552055993005;5162.148245539444;5162.251473536391;4741.2651039089;4764.784979830121;4766.856994290177;4796.712197268175;4868.853934381974;4777.163996300564;5008.874778130576;5012.949870501248;5019.924701129559;5076.568491678101;4895.4370247420575;4973.079980203674;4990.750462476934;5029.1953287473825;5100.744962751922;4919.262110683426;4922.138625740409;4926.5073492650445;4931.137051015986;4989.376327959005;4875.1712208923855;4915.483874193301;4919.286703428054;4920.163572192808;4976.626752993468;4744.288356746516;4779.283107533898;4809.134355815987;4862.659613826998;4865.124277629919;4769.260764581495;4813.989062296957;4929.975350123226;4996.200607902863;5006.974965125297;4771.1888978872985;4778.617710583215;4778.976105119452;4782.0914026334885;4783.904321913612 18:37:51 INFO - PROCESS | 7406 | |1;ext.html;564.3679079431038;570.5464155995983;571.4799532425494;572.0503963420722;575.1947273816656;27905.581416278746;38621.22757544847;40138.5778275476;40202.59797402025;44198;40744.092106644515;41161.794191029076;41253.58746412535;41301.793491032506;41326.58673413265;7568.659410326521;7757.030371203599;7758.379329653614;7761;7761.573113478757;7629.465937384385;7722.729704460345;7724.266194711493;7724.575148366837;7728.536287822721;7738.7678369649;7792.10390805059;7801.648925798353;7806.336461400788;7808.453408261424;7701.576413297266;7717.961410192913;7743.651535680908;7749.690012399497;7751.57366344848;7654.808629784245;7717.305442510201;7720.34377077949;7722.575258360788;7727.884081738778;37898.24203515942;38336.80831595852;38343.80828095869;38344.42483362752;38363;3073.339232065094;3107.844607769625;3152.9684703152902;3226.1611980884904;3291.7202037826814;28737.42525149506;28800.711992880013;29272;29798;29902.700972990428;3344.4816053511745;3370.224848284908;3490.6858382745677;3567.94648080279;3591.191981804099;250499;250658;253554;253752;253839;31556.526652100238;53709;54305.72847135739;54328;54332;31682.841585792383;33535.83232083824;33647.49528757071;33653.831730841186;33674.663253367646;11736.765264694659;11852.466639001266;11864.940675296568;11876.821847672292;11877.643670689893;10461.68614941553;10524.579016839394;10528.36829790215;10528.894711052944;10540.683779486628;7827.882581761278;7853.057633084067;7857.921420785833;7945.205479452008;7987.8402431951035;3108.953365699471;3124.250179956794;3139.152428844245;3153.1644114309725;3165.4776961801504;829.9875501867476;874.7900503879023;883.6730409748434;944.4050248343636;953.4374718915873;27180;27558.173254802387;27684.584731229046;27870.16389508318;28307.292317692223;963.942163470194;969.6703120938914;1000.1248907206194;1040.5837664934088;1052.8210204265292;13995.440182392795;14868.925655371653;14894.106353618818;15023.399064037534;15136.318865651072;366401;367240;368019;368036;369160;47850;48296;48356.7582162094;48422;48537.75731121392;1041.9479026048666;1065.5098654618962;1066.3335415365398;1156.4969238381332;1173;26355.341116472242;28389;29141;31144.377112457172;31404.371912562077;46664;47282;47289.29066064081;47382.52617473781;47406.28890566575;319868;322673;323390;323721;323837;24451;24931.252062438154;25422;25624.743752562237;25647.487050259264;40837.38743918903;41206.9698257546;41640.79179604204;41919.37120943127;42229;34741.47887781736;35140;35749.28501429905;35859.82070089633;36357.63642363543;34463.65536344604;34501.827490862386;34640.653593464755;35195;35380.46929296114;27546.44907101887;29241.415171696874;29903.55144672788;34659.65340346564;34898.65101348954;28968.95935353792;32648.673513265512;32736;33021.50467742938;33169.33661326808;24708.629370559098;24897.626535602343;25019.249422517354;25043.624345634467;25455 18:37:51 INFO - PROCESS | 7406 | |2;jquery.html;360.40173312301584;360.6483678413547;366.9614690457503;371.233403022758;382.1935715640001;15353.92323038386;15652.452164174256;16970.15149242539;17038.48884533463;17047;16525.504234872973;16829.242684079214;17059.57351066224;17444;17559.73660395095;4969.801207951687;5261.394939581959;5263.710495922742;5264.868378290555;5270.077736396134;4983.775730092137;5087.6184286178495;5155.432902380735;5182.818601348954;5184.481551844823;5114.820981265657;5128.179491281396;5134.974325128369;5161.225816127573;5162.277281180619;4854.757262136879;5088.567471764867;5102.1836506159025;5103.438621751604;5107.642465027449;4432.3794668746405;4460.977695111504;4461.776911154429;4467.15124126415;4471.530489298641;20346.389608311776;20740.896295518425;20766.896165519076;21034;21068.262610808702;1885.849132069431;1940.3402843033296;2125.978740212609;2175.282156888223;2377.9286621401384;11340;12399.566015189515;12531.74936501274;12941.417636206394;13090.672733181651;1447.0449503327752;1467.259034187739;1482.7479328514178;1547.667251540913;1624.4558073045544;72398.63800681016;76143.61928190323;76325.23674763237;76843.23156768417;78080.60959695221;9710.902890971141;9870.407775533491;9926.76647754264;10193.898061019443;10202.38785672862;14077.366518506691;14080.507182248572;14092.647683807987;14103.85896141046;14113;7114.517853752103;7162.498625096193;7189.964050179716;7345.375643070399;7373.410127189812;6912.205096413876;6927.411170050501;7144.214136444987;7153.570785752768;7183.60490173035;4218.915621687611;4297.441332626801;4302.65578753699;4444.355568442557;4456.844010459618;1776.546980519959;1830.8352248297717;1834.339637730416;1847.8521718262507;1893.6591413545693;818.3943881527746;823.880537322097;873.4584557574218;896.3859756067114;934.6962237272913;16475.423360182336;16862.24119914607;17156;17290.394836180672;17871.195796189204;842.6123982967904;853.4665833853842;864.3517361978517;870.851955167623;880.4145243413059;8847.11528847123;9846.409215447096;9867.753306167404;9986.750331241632;10013.749656258506;161708;347577;347690;347747;359081;78434.43131137459;81911.5904420486;84122.57938710267;84387.5780621093;87322;402.89121937077414;428.5799916082195;428.93137098064784;431.42620314981;432.2069003378835;9968.152707019985;10399.168066554808;10426.530806113895;10505.474726263808;10594.205434592282;36110.819445902605;36205;37140.257194856495;37708;38541;44741;48483.27275090947;49580.50419495903;49830.50169498259;50277;7165.211826698955;7554.4334174936;7610.695572177051;7705.075390953121;8305.709300174465;11170.547828782206;11491.74789405837;11522.711932201762;12416;12478.126531142732;9675.371100878421;10031.648892288735;10088.596456141966;10210.540525676512;10275.332103413255;9635.470049147365;10157.746056348651;10237.692869213935;10425.218108642033;10669;10342.844857326996;10361.792764144826;10482.109020733324;10664.360138391721;10788.352698838095;7718.652660630173;7730.961345193238;7746.767596972099;7758.495697779626;7809.882851757115;7883.054033516015;9338.252939764938;9909.45497997617;10825;11021 18:37:51 INFO - PROCESS | 7406 | |3;mootools.html;1208.2327721896604;1332.5269529317095;1384.3562743324353;1425.2944792327798;1680.008794811062;6751.156105486814;7358.852822943538;7699.884501732478;7708.306252437286;7966.283034526891;7787.64955576999;7847.92152078479;7856.4107691923045;7864.724734634289;7870.842583148334;2158.589867925093;2178.433607262107;2185.1477923609805;2189.9781002189934;2191.7698641642555;2117.7458704955425;2160.2223199648192;2170.5007848194846;2173.098164261837;2179.3353027326657;2121.4378189779723;2126.26643807886;2132.2856842957626;2134.295682424804;2177.901994410255;2088.0395018291606;2092.0585736418598;2093.654546999743;2096.0986775686524;2096.1091536097097;2048.8424040417117;2105.9368218953455;2108.1883474862134;2110.0926601561323;2113.281484295347;7542.962285188539;7595.430342724262;7624.35193008595;7784.844303113962;7832.686692532292;4419.955800441987;4540.977295113504;4550.249208880564;4550.522195169526;4550.68145229834;2747.4230411613585;2870.5550639650887;2904.099729083991;2918.4454953558757;2923.400702855931;917.8302014127407;921.3780698028871;940.3981451870808;954.7994921066585;955.6177528988391;10404.063634272876;10471.267011309212;10475.895241047645;10506.317089389242;10507.579696812118;3733.794641294755;3799.3920972644796;3872.1481274119647;3915.941260881089;3927.155661532784;8267.710630128036;8336.62485188168;8337.749867503984;8344.8331033379;8347.123552027071;4390.363397307373;4390.495093064338;4396.736195828261;4397.186520493655;4407.867763967086;3571.8035508046787;3692.8707495238077;4003.5796241394232;4089.1412803311637;4104.856330028435;3404.69357757803;3431.8627254910025;3529.505869178317;3532.5760908691122;3553.680168784822;1023.7133602591286;1027.799579082072;1040.77623310987;1043.608646757466;1049.1344640671477;774.4849674966084;790.1190172957226;793.9682412703543;809.7813590330695;817.852786498436;4646.279826626878;4656.371389862393;4732.574068333866;4867.269909513601;4973.2540118981715;393.83065281928475;395.6043956043956;397.6639739420185;398.23737542605585;410.3721306401211;3276.0990727550115;3411.422324499412;3423.691867731916;3453.430184019659;3453.533772940621;8882.200601945726;8917.777055573662;9282.257419406431;9310.255179585616;9624.711258662252;9518.333716639769;9545.61817527305;9563.378380405251;9565;9567.61729530811;6754.493412994045;7228.927710722825;7291.671874765649;7307.525010874276;7313.524620899624;5106.514881086291;5141.71720555373;5185.11852985001;5204.401493828107;5252.317198764136;8735.475871447734;8777.6927807529;8803.911960880308;8838.116188381367;8931.73204803857;8764.956175219084;8873.378863479753;8946.463212207029;8990.190882820578;9068.773280668036;5808.07070868659;5850.882982340415;6455.4512866406885;6563;6571.244306904576;7196.712131514681;7442.181360050282;7453.2546745325035;7458.664360103917;7465.664045117874;6500.317466666121;6599.637019963756;6610.272869984202;6791.286914873867;6824.078749368771;6583.934160658332;6584.76953306632;6593.967030164818;6622.602643841385;6647.069410282661;6205.906911396423;6343.841403964753;6363.522735794926;6366.427021567896;6368.42684158428;4361.8037188327235;4411.316245981878;4492.483364413004;4504.887377815449;4518.548145185455;4295.24833154203;4335.783210839382;4370.759608221579;4399.450068741407;4411.117776444659 18:37:51 INFO - PROCESS | 7406 | |4;prototype.html;273.0620319203536;276.41676063506;277.8646104685491;278.86056971514245;279.27388789148216;4816.133096042711;4854.296127061574;4865.635077369194;4866.610671146304;4886.193778026626;4759.976200118995;4765.166095933207;4770.761461926907;4791.736454495001;4793.233082706767;3743.4010558310674;3746.1758413149064;3753.568339640942;3755.324041672498;3760;3745.325841348556;3761.7742935423826;3771.8491260349692;3774.962250377502;3782.375907975181;3589.964100358989;3690.114372550582;3729.1982223821874;3731.8320675569666;3754.080250338671;3741.6904083570803;3742.644448777362;3744.756590821615;3752.3996160614306;3762.6049264827075;3300.488424294238;3306.371789360038;3308.4210263203845;3309.3712194682935;3313.6686331366673;4406.669499787528;4517.706349087299;4555;4653.883652908705;4667.486576476619;4227.471566054243;4259.424977628042;4263.552327005682;4266.957330426687;4268.274393353137;4926.926096108561;4965.386249468937;4970.676906001098;4971.45314015458;4971.751412429364;3466.670666286724;3543.2204914918675;3561.2521370511963;3567.6432356764376;3592.892213233607;5119.283300337956;5124.205748109011;5154.5103215194495;5167.586593072545;5168.250603662485;3563.1982803868923;3565.860483709805;3583.0863129902227;3604.5314109166166;3614.566252049771;3570.250247448065;3648.4527320901548;3658.213484100931;3658.957197198839;3659.249853779969;4156.58434156588;4167.8332866685;4169.228692691801;4191.119864828359;4215.220184265921;4977.527134922249;4982.402111746614;4984.626153038536;4992.600591952635;4993.350864387607;1294.8057791331375;1304.9151805132635;1307.2613973105165;1312.704641455684;1313.5862203406089;790.1584812175015;832.3590835057093;835.1272919798824;838.2037064788475;844.7085755414372;3988.504310883419;3992.321305378093;4024.8591299304385;4027.4160246764054;4029.979850100731;4564.863054108382;4567.566081222279;4568.771561421916;4585.449746030497;4645.814167433333;3866.2074274773604;4057.4928133983253;4075.9388609170887;4082.591740825894;4090.6318431341324;2451.656768052474;2455.8457524963237;2462.4459496613117;2464.642626819101;2471.3195027381194;4353.25994580922;4358.280883654162;4371.366151908019;4601.792919318638;4785.473597904228;5058.949410505921;5270.235815806764;5291.3121294231505;5293.75596734767;5302.310699609026;4865.983090483923;4875.806346842824;4880.267959806058;4885.7801398937845;4893.266010098514;4938.481459446706;5166.8966620668125;5171.663841850418;5189.247559103985;5190.584753219658;5043.344365232643;5051.974740126276;5056.494350564914;5066.518680725325;5084.51697088776;4848.903021939471;4862.878428039327;4871.585915197248;4876.366072410564;4877.878088039842;3373.1904342957023;3607.458881167846;3623.836927338223;3785.432185172246;3791.4691943128537;5172.456892026283;5172.9741351293005;5180.378354597472;5188.896222075613;5190.5742210141125;5034.244863270539;5034.949650503448;5039.647224694236;5039.874003149804;5051.484554633668;4849.199882019428;5033.6476446648385;5038.546530812245;5055.646104772778;5079.847604571869;4971.353724015855;4978.452370239198;4983.27742477346;4985.227289770091;4996.275540046746;5077.517635824591;5085.64400491962;5096.490350964874;5096.980603879165;5100.903305789125;4756.286557016475;4948.233023881304;4954.99322774277;4969.47820478859;4974.602031837372 18:37:51 INFO - PROCESS | 7406 | |5;yui.html;628.8050704281673;677.1941389746202;708.6138054760155;734.3867870328276;735.2941176470588;12505.43725532352;13358.732825343488;13384.063115581914;13423.73152536951;13468.932655336734;13481.460741570325;13597.932010339935;13602.115862468932;13609.591712248648;13621.182729036265;588.6497533967304;605.5186127029023;726.0887586079489;733.1422235983898;752.0674363788917;737.8561180569791;747.3274053352;747.4170147285126;747.7083937264445;748.2367984655648;791;792.3423558446476;793.2820797178563;793.623029061197;793.8213901872061;608.388569487662;627.1408170805979;753.2091304130696;784.8508783331177;786.0802860653021;567.1351189436143;574.196125424405;575.1889835332204;575.3469811763637;575.3699698829774;13052.15161014531;13151.473941042346;13185;13194.604161875159;13197.076204665676;12515;12587.496500139983;12640.810387844189;13019.414126364336;13536.323183840768;11540.526566974206;11983.580574679845;12097.334646594434;12311.56909508163;13223.867761322455;4305.31115021595;4326.545712700153;4353.869383918487;4394.868153955386;4530.365748795171;63151;64916.67541662309;65013.3498665012;65132.3486765131;65155.674221628586;10457.633982810565;10566.762728146143;10948.39783811882;11047.226694131334;11242.213045086928;19928.3025094121;20035.39893803188;20169.899150504152;20176.192952281745;20239.392818215478;6846.383825455733;6891.310868913069;6938.306169383122;6971.128608923885;6971.477139214579;3499.825008749603;3519.260955199437;3554.0937061049267;3571.1250743567994;3607;2758.6206896551726;2846.174609363303;2862.527682932293;2866.441043996442;2874.037197538848;473.684999475345;482.57051224410304;492.38206051405257;503.4210657743551;503.66757939759583;476.2665495137519;504.7905119375418;535.3522238091953;563.7181409295353;578.4967078641608;7420.220876807965;7720.806979825437;7721.806954826175;7769.689212431553;7846.9215307847335;479.74093989246114;507.91813437378147;538.1953978801716;581.6771691711141;587.6797145555682;3559.4126969049817;3623.0942264433893;3656.597774244831;3687.082716987152;3715.888523344304;94446;100875.49562252141;101635.49182254041;101692;102430;86387.13612863916;86415;87580.12419875847;88370.55814721013;89726.55136724275;73159.63420182865;75415;75582.24417755862;76110;77806.2219377799;6751.72993080291;6891.173059232924;6917.412019978358;7180.31786980236;7283.708651653875;45560.54439455563;46304;46474.535254647024;46497.53502464932;46886.76556617195;38585;47268.7636561815;51193.23210151776;54240.72879635577;60159;11409.512559496938;11431.657050288504;11527.308361498002;11553.94223028913;11599.362035087814;12432.81350779721;12977.416016279101;12977.610671679864;13362.465501379836;13423.060385772902;11769.588064417705;11975.580854670394;12415.62753117408;12482.063845211464;12649.93675031619;11498;11884;12009.459574319002;12026.819597705866;12565.057620678303;11042.171837112088;11404.771904562029;11502.654920352403;11709.707257318636;11723.296602203554;9389.765255868659;9600.32797704154;9633.9036609633;9694.127528522467;9958.402495850272;9721.416714997124;9726.70819875405;10699.625513107005;10849.728756781144;10952.616658416917 18:37:51 INFO - PROCESS | 7406 | __end_tp_report 18:37:51 INFO - PROCESS | 7406 | __start_cc_report 18:37:51 INFO - PROCESS | 7406 | _x_x_mozilla_cycle_collect,1671 18:37:51 INFO - PROCESS | 7406 | __end_cc_report 18:37:51 INFO - PROCESS | 7406 | __startTimestamp1475977071457__endTimestamp 18:37:51 INFO - PROCESS | 7406 | 18:37:51 INFO - PROCESS | 7406 | ------- Summary: start ------- 18:37:51 INFO - PROCESS | 7406 | Number of tests: 6 18:37:51 INFO - PROCESS | 7406 | 18:37:51 INFO - PROCESS | 7406 | [#0] dojo.html Cycles:165 Average:4658.03 Median:4769.26 stddev:485.41 (10.2%) stddev-sans-first:458.77 18:37:51 INFO - PROCESS | 7406 | Values: 2582.0 2587.5 2600.7 2615.7 2630.4 4552.0 4625.4 4648.9 4670.1 4671.1 4663.2 4666.8 4684.9 4687.0 4689.4 4283.2 4300.1 4321.7 4341.1 4368.7 4361.0 4402.5 4413.3 4420.1 4463.4 4366.5 4372.4 4427.3 4433.0 4491.9 3996.4 4334.4 4421.4 4445.5 4458.6 4405.7 4419.3 4441.6 4471.1 4482.1 4624.8 4670.9 4678.0 4755.5 4813.0 5006.4 5011.5 5070.3 5072.2 5074.3 5013.3 5049.5 5160.0 5160.8 5167.0 4642.8 4717.7 4717.7 4720.7 4776.0 5174.9 5185.2 5189.5 5190.4 5256.4 4818.7 4857.6 4882.9 4913.2 4919.4 4977.7 5008.6 5019.5 5028.2 5086.3 4950.3 4961.9 4965.3 4969.0 5030.7 4819.9 4864.9 4867.3 4930.9 4958.5 4258.7 4263.2 4305.6 4308.0 4312.9 3717.6 3727.5 3732.5 3775.0 3789.1 4268.7 4301.6 4304.2 4394.9 4395.7 4987.1 5014.8 5034.7 5066.8 5140.6 4363.6 4374.1 4376.2 4380.3 4432.2 4423.4 4545.7 4549.6 4554.1 4591.5 4674.3 4712.5 4744.0 4749.0 4750.1 5089.8 5146.2 5158.4 5162.1 5162.3 4741.3 4764.8 4766.9 4796.7 4868.9 4777.2 5008.9 5012.9 5019.9 5076.6 4895.4 4973.1 4990.8 5029.2 5100.7 4919.3 4922.1 4926.5 4931.1 4989.4 4875.2 4915.5 4919.3 4920.2 4976.6 4744.3 4779.3 4809.1 4862.7 4865.1 4769.3 4814.0 4930.0 4996.2 5007.0 4771.2 4778.6 4779.0 4782.1 4783.9 18:37:51 INFO - PROCESS | 7406 | 18:37:51 INFO - PROCESS | 7406 | [#1] ext.html Cycles:180 Average:45774.19 Median:19194.67 stddev:83800.27 (436.6%) stddev-sans-first:83966.60 18:37:51 INFO - PROCESS | 7406 | Values: 564.4 570.5 571.5 572.1 575.2 27905.6 38621.2 40138.6 40202.6 44198.0 40744.1 41161.8 41253.6 41301.8 41326.6 7568.7 7757.0 7758.4 7761.0 7761.6 7629.5 7722.7 7724.3 7724.6 7728.5 7738.8 7792.1 7801.6 7806.3 7808.5 7701.6 7718.0 7743.7 7749.7 7751.6 7654.8 7717.3 7720.3 7722.6 7727.9 37898.2 38336.8 38343.8 38344.4 38363.0 3073.3 3107.8 3153.0 3226.2 3291.7 28737.4 28800.7 29272.0 29798.0 29902.7 3344.5 3370.2 3490.7 3567.9 3591.2 250499.0 250658.0 253554.0 253752.0 253839.0 31556.5 53709.0 54305.7 54328.0 54332.0 31682.8 33535.8 33647.5 33653.8 33674.7 11736.8 11852.5 11864.9 11876.8 11877.6 10461.7 10524.6 10528.4 10528.9 10540.7 7827.9 7853.1 7857.9 7945.2 7987.8 3109.0 3124.3 3139.2 3153.2 3165.5 830.0 874.8 883.7 944.4 953.4 27180.0 27558.2 27684.6 27870.2 28307.3 963.9 969.7 1000.1 1040.6 1052.8 13995.4 14868.9 14894.1 15023.4 15136.3 366401.0 367240.0 368019.0 368036.0 369160.0 47850.0 48296.0 48356.8 48422.0 48537.8 1041.9 1065.5 1066.3 1156.5 1173.0 26355.3 28389.0 29141.0 31144.4 31404.4 46664.0 47282.0 47289.3 47382.5 47406.3 319868.0 322673.0 323390.0 323721.0 323837.0 24451.0 24931.3 25422.0 25624.7 25647.5 40837.4 41207.0 41640.8 41919.4 42229.0 34741.5 35140.0 35749.3 35859.8 36357.6 34463.7 34501.8 34640.7 35195.0 35380.5 27546.4 29241.4 29903.6 34659.7 34898.7 28969.0 32648.7 32736.0 33021.5 33169.3 24708.6 24897.6 25019.2 25043.6 25455.0 18:37:51 INFO - PROCESS | 7406 | 18:37:51 INFO - PROCESS | 7406 | [#2] jquery.html Cycles:180 Average:22365.58 Median:2363.19 stddev:54122.03 (2290.2%) stddev-sans-first:54248.64 18:37:51 INFO - PROCESS | 7406 | Values: 360.4 360.6 367.0 371.2 382.2 15353.9 15652.5 16970.2 17038.5 17047.0 16525.5 16829.2 17059.6 17444.0 17559.7 4969.8 5261.4 5263.7 5264.9 5270.1 4983.8 5087.6 5155.4 5182.8 5184.5 5114.8 5128.2 5135.0 5161.2 5162.3 4854.8 5088.6 5102.2 5103.4 5107.6 4432.4 4461.0 4461.8 4467.2 4471.5 20346.4 20740.9 20766.9 21034.0 21068.3 1885.8 1940.3 2126.0 2175.3 2377.9 11340.0 12399.6 12531.7 12941.4 13090.7 1447.0 1467.3 1482.7 1547.7 1624.5 72398.6 76143.6 76325.2 76843.2 78080.6 9710.9 9870.4 9926.8 10193.9 10202.4 14077.4 14080.5 14092.6 14103.9 14113.0 7114.5 7162.5 7190.0 7345.4 7373.4 6912.2 6927.4 7144.2 7153.6 7183.6 4218.9 4297.4 4302.7 4444.4 4456.8 1776.5 1830.8 1834.3 1847.9 1893.7 818.4 823.9 873.5 896.4 934.7 16475.4 16862.2 17156.0 17290.4 17871.2 842.6 853.5 864.4 870.9 880.4 8847.1 9846.4 9867.8 9986.8 10013.7 161708.0 347577.0 347690.0 347747.0 359081.0 78434.4 81911.6 84122.6 84387.6 87322.0 402.9 428.6 428.9 431.4 432.2 9968.2 10399.2 10426.5 10505.5 10594.2 36110.8 36205.0 37140.3 37708.0 38541.0 44741.0 48483.3 49580.5 49830.5 50277.0 7165.2 7554.4 7610.7 7705.1 8305.7 11170.5 11491.7 11522.7 12416.0 12478.1 9675.4 10031.6 10088.6 10210.5 10275.3 9635.5 10157.7 10237.7 10425.2 10669.0 10342.8 10361.8 10482.1 10664.4 10788.4 7718.7 7731.0 7746.8 7758.5 7809.9 7883.1 9338.3 9909.5 10825.0 11021.0 18:37:51 INFO - PROCESS | 7406 | 18:37:51 INFO - PROCESS | 7406 | [#3] mootools.html Cycles:180 Average:4977.84 Median:4651.33 stddev:2841.26 (61.1%) stddev-sans-first:2835.11 18:37:51 INFO - PROCESS | 7406 | Values: 1208.2 1332.5 1384.4 1425.3 1680.0 6751.2 7358.9 7699.9 7708.3 7966.3 7787.6 7847.9 7856.4 7864.7 7870.8 2158.6 2178.4 2185.1 2190.0 2191.8 2117.7 2160.2 2170.5 2173.1 2179.3 2121.4 2126.3 2132.3 2134.3 2177.9 2088.0 2092.1 2093.7 2096.1 2096.1 2048.8 2105.9 2108.2 2110.1 2113.3 7543.0 7595.4 7624.4 7784.8 7832.7 4420.0 4541.0 4550.2 4550.5 4550.7 2747.4 2870.6 2904.1 2918.4 2923.4 917.8 921.4 940.4 954.8 955.6 10404.1 10471.3 10475.9 10506.3 10507.6 3733.8 3799.4 3872.1 3915.9 3927.2 8267.7 8336.6 8337.7 8344.8 8347.1 4390.4 4390.5 4396.7 4397.2 4407.9 3571.8 3692.9 4003.6 4089.1 4104.9 3404.7 3431.9 3529.5 3532.6 3553.7 1023.7 1027.8 1040.8 1043.6 1049.1 774.5 790.1 794.0 809.8 817.9 4646.3 4656.4 4732.6 4867.3 4973.3 393.8 395.6 397.7 398.2 410.4 3276.1 3411.4 3423.7 3453.4 3453.5 8882.2 8917.8 9282.3 9310.3 9624.7 9518.3 9545.6 9563.4 9565.0 9567.6 6754.5 7228.9 7291.7 7307.5 7313.5 5106.5 5141.7 5185.1 5204.4 5252.3 8735.5 8777.7 8803.9 8838.1 8931.7 8765.0 8873.4 8946.5 8990.2 9068.8 5808.1 5850.9 6455.5 6563.0 6571.2 7196.7 7442.2 7453.3 7458.7 7465.7 6500.3 6599.6 6610.3 6791.3 6824.1 6583.9 6584.8 6594.0 6622.6 6647.1 6205.9 6343.8 6363.5 6366.4 6368.4 4361.8 4411.3 4492.5 4504.9 4518.5 4295.2 4335.8 4370.8 4399.5 4411.1 18:37:51 INFO - PROCESS | 7406 | 18:37:51 INFO - PROCESS | 7406 | [#4] prototype.html Cycles:180 Average:4106.09 Median:4623.80 stddev:1207.21 (26.1%) stddev-sans-first:1175.82 18:37:51 INFO - PROCESS | 7406 | Values: 273.1 276.4 277.9 278.9 279.3 4816.1 4854.3 4865.6 4866.6 4886.2 4760.0 4765.2 4770.8 4791.7 4793.2 3743.4 3746.2 3753.6 3755.3 3760.0 3745.3 3761.8 3771.8 3775.0 3782.4 3590.0 3690.1 3729.2 3731.8 3754.1 3741.7 3742.6 3744.8 3752.4 3762.6 3300.5 3306.4 3308.4 3309.4 3313.7 4406.7 4517.7 4555.0 4653.9 4667.5 4227.5 4259.4 4263.6 4267.0 4268.3 4926.9 4965.4 4970.7 4971.5 4971.8 3466.7 3543.2 3561.3 3567.6 3592.9 5119.3 5124.2 5154.5 5167.6 5168.3 3563.2 3565.9 3583.1 3604.5 3614.6 3570.3 3648.5 3658.2 3659.0 3659.2 4156.6 4167.8 4169.2 4191.1 4215.2 4977.5 4982.4 4984.6 4992.6 4993.4 1294.8 1304.9 1307.3 1312.7 1313.6 790.2 832.4 835.1 838.2 844.7 3988.5 3992.3 4024.9 4027.4 4030.0 4564.9 4567.6 4568.8 4585.4 4645.8 3866.2 4057.5 4075.9 4082.6 4090.6 2451.7 2455.8 2462.4 2464.6 2471.3 4353.3 4358.3 4371.4 4601.8 4785.5 5058.9 5270.2 5291.3 5293.8 5302.3 4866.0 4875.8 4880.3 4885.8 4893.3 4938.5 5166.9 5171.7 5189.2 5190.6 5043.3 5052.0 5056.5 5066.5 5084.5 4848.9 4862.9 4871.6 4876.4 4877.9 3373.2 3607.5 3623.8 3785.4 3791.5 5172.5 5173.0 5180.4 5188.9 5190.6 5034.2 5034.9 5039.6 5039.9 5051.5 4849.2 5033.6 5038.5 5055.6 5079.8 4971.4 4978.5 4983.3 4985.2 4996.3 5077.5 5085.6 5096.5 5097.0 5100.9 4756.3 4948.2 4955.0 4969.5 4974.6 18:37:51 INFO - PROCESS | 7406 | 18:37:51 INFO - PROCESS | 7406 | [#5] yui.html Cycles:180 Average:17860.59 Median:46486.04 stddev:25569.39 (55.0%) stddev-sans-first:25608.38 18:37:51 INFO - PROCESS | 7406 | Values: 628.8 677.2 708.6 734.4 735.3 12505.4 13358.7 13384.1 13423.7 13468.9 13481.5 13597.9 13602.1 13609.6 13621.2 588.6 605.5 726.1 733.1 752.1 737.9 747.3 747.4 747.7 748.2 791.0 792.3 793.3 793.6 793.8 608.4 627.1 753.2 784.9 786.1 567.1 574.2 575.2 575.3 575.4 13052.2 13151.5 13185.0 13194.6 13197.1 12515.0 12587.5 12640.8 13019.4 13536.3 11540.5 11983.6 12097.3 12311.6 13223.9 4305.3 4326.5 4353.9 4394.9 4530.4 63151.0 64916.7 65013.3 65132.3 65155.7 10457.6 10566.8 10948.4 11047.2 11242.2 19928.3 20035.4 20169.9 20176.2 20239.4 6846.4 6891.3 6938.3 6971.1 6971.5 3499.8 3519.3 3554.1 3571.1 3607.0 2758.6 2846.2 2862.5 2866.4 2874.0 473.7 482.6 492.4 503.4 503.7 476.3 504.8 535.4 563.7 578.5 7420.2 7720.8 7721.8 7769.7 7846.9 479.7 507.9 538.2 581.7 587.7 3559.4 3623.1 3656.6 3687.1 3715.9 94446.0 100875.5 101635.5 101692.0 102430.0 86387.1 86415.0 87580.1 88370.6 89726.6 73159.6 75415.0 75582.2 76110.0 77806.2 6751.7 6891.2 6917.4 7180.3 7283.7 45560.5 46304.0 46474.5 46497.5 46886.8 38585.0 47268.8 51193.2 54240.7 60159.0 11409.5 11431.7 11527.3 11553.9 11599.4 12432.8 12977.4 12977.6 13362.5 13423.1 11769.6 11975.6 12415.6 12482.1 12649.9 11498.0 11884.0 12009.5 12026.8 12565.1 11042.2 11404.8 11502.7 11709.7 11723.3 9389.8 9600.3 9633.9 9694.1 9958.4 9721.4 9726.7 10699.6 10849.7 10952.6 18:37:51 INFO - PROCESS | 7406 | -------- Summary: end -------- 18:37:51 INFO - PROCESS | 7406 | 18:37:52 INFO - TEST-INFO | 7406: exit 0 18:37:52 INFO - TEST-OK | dromaeo_css | took 1122597ms 18:37:52 INFO - TEST-START | kraken 18:37:52 INFO - operating with platform_type : linux_ 18:37:52 INFO - Initialising browser for kraken test... 18:37:52 INFO - TEST-INFO | started process 7715 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5O6W4F/profile http://localhost:37293/getInfo.html) 18:37:56 INFO - PROCESS | 7715 | __metrics Screen width/height:1600/1200 18:37:56 INFO - PROCESS | 7715 | colorDepth:24 18:37:56 INFO - PROCESS | 7715 | Browser inner width/height: 1024/697 18:37:56 INFO - PROCESS | 7715 | __metrics 18:37:57 INFO - PROCESS | 7715 | 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" 18:37:57 INFO - PROCESS | 7715 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:37:58 INFO - TEST-INFO | 7715: exit 0 18:37:58 INFO - Browser initialized. 18:37:58 INFO - Running cycle 1/1 for kraken test... 18:37:58 INFO - TEST-INFO | started process 7797 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5O6W4F/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:38:10 INFO - PROCESS | 7797 | RSS: Main: 174858240 18:38:10 INFO - PROCESS | 7797 | 18:38:13 INFO - PROCESS | 7797 | Cycle 1(1): loaded http://localhost:37293/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37293/tests/kraken/driver.html?testName=audio-beat-detection) 18:38:14 INFO - PROCESS | 7797 | RSS: Main: 232988672 18:38:14 INFO - PROCESS | 7797 | 18:38:17 INFO - PROCESS | 7797 | Cycle 1(1): loaded http://localhost:37293/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37293/tests/kraken/driver.html?testName=audio-dft) 18:38:17 INFO - PROCESS | 7797 | RSS: Main: 217456640 18:38:17 INFO - PROCESS | 7797 | 18:38:21 INFO - PROCESS | 7797 | Cycle 1(1): loaded http://localhost:37293/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37293/tests/kraken/driver.html?testName=audio-fft) 18:38:21 INFO - PROCESS | 7797 | RSS: Main: 300552192 18:38:21 INFO - PROCESS | 7797 | 18:38:24 INFO - PROCESS | 7797 | Cycle 1(1): loaded http://localhost:37293/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37293/tests/kraken/driver.html?testName=audio-oscillator) 18:38:24 INFO - PROCESS | 7797 | RSS: Main: 209338368 18:38:24 INFO - PROCESS | 7797 | 18:38:26 INFO - PROCESS | 7797 | Cycle 1(1): loaded http://localhost:37293/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37293/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:38:27 INFO - PROCESS | 7797 | RSS: Main: 214183936 18:38:27 INFO - PROCESS | 7797 | 18:38:30 INFO - PROCESS | 7797 | Cycle 1(1): loaded http://localhost:37293/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37293/tests/kraken/driver.html?testName=imaging-darkroom) 18:38:31 INFO - PROCESS | 7797 | RSS: Main: 250003456 18:38:31 INFO - PROCESS | 7797 | 18:38:34 INFO - PROCESS | 7797 | Cycle 1(1): loaded http://localhost:37293/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37293/tests/kraken/driver.html?testName=imaging-desaturate) 18:38:35 INFO - PROCESS | 7797 | RSS: Main: 243974144 18:38:35 INFO - PROCESS | 7797 | 18:38:38 INFO - PROCESS | 7797 | Cycle 1(1): loaded http://localhost:37293/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37293/tests/kraken/driver.html?testName=json-parse-financial) 18:38:38 INFO - PROCESS | 7797 | RSS: Main: 247062528 18:38:38 INFO - PROCESS | 7797 | 18:38:40 INFO - PROCESS | 7797 | Cycle 1(1): loaded http://localhost:37293/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37293/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:38:41 INFO - PROCESS | 7797 | RSS: Main: 210419712 18:38:41 INFO - PROCESS | 7797 | 18:38:43 INFO - PROCESS | 7797 | Cycle 1(1): loaded http://localhost:37293/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37293/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:38:43 INFO - PROCESS | 7797 | RSS: Main: 217939968 18:38:43 INFO - PROCESS | 7797 | 18:38:45 INFO - PROCESS | 7797 | Cycle 1(1): loaded http://localhost:37293/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37293/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:38:46 INFO - PROCESS | 7797 | RSS: Main: 226721792 18:38:46 INFO - PROCESS | 7797 | 18:38:49 INFO - PROCESS | 7797 | Cycle 1(1): loaded http://localhost:37293/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37293/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:38:50 INFO - PROCESS | 7797 | RSS: Main: 235954176 18:38:50 INFO - PROCESS | 7797 | 18:38:53 INFO - PROCESS | 7797 | Cycle 1(1): loaded http://localhost:37293/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37293/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:38:53 INFO - PROCESS | 7797 | RSS: Main: 232353792 18:38:53 INFO - PROCESS | 7797 | 18:38:55 INFO - PROCESS | 7797 | Cycle 1(1): loaded http://localhost:37293/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37293/tests/kraken/driver.html?testName=ai-astar) 18:38:55 INFO - PROCESS | 7797 | RSS: Main: 282918912 18:38:55 INFO - PROCESS | 7797 | 18:38:55 INFO - PROCESS | 7797 | __start_tp_report 18:38:55 INFO - PROCESS | 7797 | _x_x_mozilla_page_load 18:38:55 INFO - PROCESS | 7797 | _x_x_mozilla_page_load_details 18:38:55 INFO - PROCESS | 7797 | |i|pagename|runs| 18:38:55 INFO - PROCESS | 7797 | |0;ai-astar;113;116;113;115;114;115;113;115;113;114 18:38:55 INFO - PROCESS | 7797 | |1;audio-beat-detection;157;127;125;175;135;134;128;125;164;126 18:38:55 INFO - PROCESS | 7797 | |2;audio-dft;161;162;161;161;160;163;161;161;160;160 18:38:55 INFO - PROCESS | 7797 | |3;audio-fft;78;77;76;109;78;77;75;76;105;75 18:38:55 INFO - PROCESS | 7797 | |4;audio-oscillator;84;83;111;83;84;83;105;83;83;114 18:38:55 INFO - PROCESS | 7797 | |5;imaging-gaussian-blur;117;116;116;117;117;117;117;117;116;116 18:38:55 INFO - PROCESS | 7797 | |6;imaging-darkroom;147;147;146;146;146;146;146;146;145;145 18:38:55 INFO - PROCESS | 7797 | |7;imaging-desaturate;95;95;94;95;95;95;95;95;95;95 18:38:55 INFO - PROCESS | 7797 | |8;json-parse-financial;66;64;65;64;65;66;64;65;65;65 18:38:55 INFO - PROCESS | 7797 | |9;json-stringify-tinderbox;67;67;67;67;66;67;67;67;67;66 18:38:55 INFO - PROCESS | 7797 | |10;stanford-crypto-aes;82;82;83;83;88;83;84;82;82;82 18:38:55 INFO - PROCESS | 7797 | |11;stanford-crypto-ccm;142;140;140;138;137;139;137;138;172;139 18:38:55 INFO - PROCESS | 7797 | |12;stanford-crypto-pbkdf2;175;177;173;172;171;172;178;173;172;173 18:38:55 INFO - PROCESS | 7797 | |13;stanford-crypto-sha256-iterative;69;71;70;69;70;68;69;70;68;68 18:38:55 INFO - PROCESS | 7797 | __end_tp_report 18:38:55 INFO - PROCESS | 7797 | __start_cc_report 18:38:55 INFO - PROCESS | 7797 | _x_x_mozilla_cycle_collect,1921 18:38:55 INFO - PROCESS | 7797 | __end_cc_report 18:38:55 INFO - PROCESS | 7797 | __startTimestamp1475977135646__endTimestamp 18:38:55 INFO - PROCESS | 7797 | 18:38:55 INFO - PROCESS | 7797 | ------- Summary: start ------- 18:38:55 INFO - PROCESS | 7797 | Number of tests: 14 18:38:55 INFO - PROCESS | 7797 | 18:38:55 INFO - PROCESS | 7797 | [#0] ai-astar Cycles:10 Average:114.10 Median:114.50 stddev:1.10 (1.0%) stddev-sans-first:1.09 18:38:55 INFO - PROCESS | 7797 | Values: 113.0 116.0 113.0 115.0 114.0 115.0 113.0 115.0 113.0 114.0 18:38:55 INFO - PROCESS | 7797 | 18:38:55 INFO - PROCESS | 7797 | [#1] audio-beat-detection Cycles:10 Average:139.60 Median:134.50 stddev:18.58 (13.8%) stddev-sans-first:18.61 18:38:55 INFO - PROCESS | 7797 | Values: 157.0 127.0 125.0 175.0 135.0 134.0 128.0 125.0 164.0 126.0 18:38:55 INFO - PROCESS | 7797 | 18:38:55 INFO - PROCESS | 7797 | [#2] audio-dft Cycles:10 Average:161.00 Median:161.00 stddev:0.94 (0.6%) stddev-sans-first:1.00 18:38:55 INFO - PROCESS | 7797 | Values: 161.0 162.0 161.0 161.0 160.0 163.0 161.0 161.0 160.0 160.0 18:38:55 INFO - PROCESS | 7797 | 18:38:55 INFO - PROCESS | 7797 | [#3] audio-fft Cycles:10 Average:82.60 Median:76.50 stddev:12.94 (16.9%) stddev-sans-first:13.61 18:38:55 INFO - PROCESS | 7797 | Values: 78.0 77.0 76.0 109.0 78.0 77.0 75.0 76.0 105.0 75.0 18:38:55 INFO - PROCESS | 7797 | 18:38:55 INFO - PROCESS | 7797 | [#4] audio-oscillator Cycles:10 Average:91.30 Median:83.00 stddev:13.09 (15.8%) stddev-sans-first:13.61 18:38:55 INFO - PROCESS | 7797 | Values: 84.0 83.0 111.0 83.0 84.0 83.0 105.0 83.0 83.0 114.0 18:38:55 INFO - PROCESS | 7797 | 18:38:55 INFO - PROCESS | 7797 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 18:38:55 INFO - PROCESS | 7797 | Values: 117.0 116.0 116.0 117.0 117.0 117.0 117.0 117.0 116.0 116.0 18:38:55 INFO - PROCESS | 7797 | 18:38:55 INFO - PROCESS | 7797 | [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:0.67 (0.5%) stddev-sans-first:0.60 18:38:55 INFO - PROCESS | 7797 | Values: 147.0 147.0 146.0 146.0 146.0 146.0 146.0 146.0 145.0 145.0 18:38:55 INFO - PROCESS | 7797 | 18:38:55 INFO - PROCESS | 7797 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 18:38:55 INFO - PROCESS | 7797 | Values: 95.0 95.0 94.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 18:38:55 INFO - PROCESS | 7797 | 18:38:55 INFO - PROCESS | 7797 | [#8] json-parse-financial Cycles:10 Average:64.90 Median:65.00 stddev:0.74 (1.1%) stddev-sans-first:0.67 18:38:55 INFO - PROCESS | 7797 | Values: 66.0 64.0 65.0 64.0 65.0 66.0 64.0 65.0 65.0 65.0 18:38:55 INFO - PROCESS | 7797 | 18:38:55 INFO - PROCESS | 7797 | [#9] json-stringify-tinderbox Cycles:10 Average:66.80 Median:67.00 stddev:0.42 (0.6%) stddev-sans-first:0.44 18:38:55 INFO - PROCESS | 7797 | Values: 67.0 67.0 67.0 67.0 66.0 67.0 67.0 67.0 67.0 66.0 18:38:55 INFO - PROCESS | 7797 | 18:38:55 INFO - PROCESS | 7797 | [#10] stanford-crypto-aes Cycles:10 Average:83.10 Median:83.00 stddev:1.85 (2.2%) stddev-sans-first:1.92 18:38:55 INFO - PROCESS | 7797 | Values: 82.0 82.0 83.0 83.0 88.0 83.0 84.0 82.0 82.0 82.0 18:38:55 INFO - PROCESS | 7797 | 18:38:55 INFO - PROCESS | 7797 | [#11] stanford-crypto-ccm Cycles:10 Average:142.20 Median:139.50 stddev:10.58 (7.6%) stddev-sans-first:11.22 18:38:55 INFO - PROCESS | 7797 | Values: 142.0 140.0 140.0 138.0 137.0 139.0 137.0 138.0 172.0 139.0 18:38:55 INFO - PROCESS | 7797 | 18:38:55 INFO - PROCESS | 7797 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.60 Median:173.00 stddev:2.32 (1.3%) stddev-sans-first:2.40 18:38:55 INFO - PROCESS | 7797 | Values: 175.0 177.0 173.0 172.0 171.0 172.0 178.0 173.0 172.0 173.0 18:38:55 INFO - PROCESS | 7797 | 18:38:55 INFO - PROCESS | 7797 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.20 Median:69.50 stddev:1.03 (1.5%) stddev-sans-first:1.09 18:38:55 INFO - PROCESS | 7797 | Values: 69.0 71.0 70.0 69.0 70.0 68.0 69.0 70.0 68.0 68.0 18:38:55 INFO - PROCESS | 7797 | -------- Summary: end -------- 18:38:55 INFO - PROCESS | 7797 | 18:38:56 INFO - TEST-INFO | 7797: exit 0 18:38:56 INFO - TEST-OK | kraken | took 64528ms 18:38:56 INFO - SUITE-END | took 1187s 18:38:57 INFO - Completed test suite (00:19:47) 18:38:57 INFO - javascript benchmark 18:38:57 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2582.005927717828, 2587.495438389514, 2600.7399260073994, 2615.7384261573834, 2630.3950091478973, 4552.0, 4625.352450656911, 4648.907506735919, 4670.065986802636, 4671.065786842632, 4663.207254766689, 4666.8366607168755, 4684.929726054112, 4687.039156972821, 4689.413823272091, 4283.186194623027, 4300.118475712487, 4321.675874309423, 4341.066670665807, 4368.672349573794, 4361.040571074374, 4402.537733537981, 4413.293872980324, 4420.1159768046355, 4463.375127482155, 4366.4978527469275, 4372.366006928994, 4427.2695005324085, 4433.0, 4491.865244042684, 3996.4205190247544, 4334.371516130143, 4421.425214722081, 4445.533219012022, 4458.576435238647, 4405.669574781872, 4419.270820314644, 4441.644668426518, 4471.128130014648, 4482.103579284156, 4624.791884365211, 4670.929936050962, 4678.0, 4755.453122890877, 4812.975935120302, 5006.374203224597, 5011.523905228997, 5070.264811602297, 5072.2391641253735, 5074.31496747938, 5013.273075404082, 5049.4950504949575, 5160.0, 5160.845174644766, 5167.044096842096, 4642.76786160694, 4717.669763116549, 4717.693349932243, 4720.693154944917, 4776.0, 5174.8965020700125, 5185.170372740344, 5189.532942035235, 5190.403103643054, 5256.421793602701, 4818.71087734737, 4857.587105096107, 4882.902341953141, 4913.1893237615395, 4919.434265059564, 4977.701337919736, 5008.5993120550265, 5019.52314530119, 5028.19548872186, 5086.338775959101, 4950.2822090796635, 4961.8511444656715, 4965.33661223487, 4968.975155124202, 5030.748462576929, 4819.927701084486, 4864.878378040577, 4867.318575399447, 4930.901381972412, 4958.454569997298, 4258.659307255412, 4263.16868210696, 4305.590968857953, 4308.009157893702, 4312.9137417252105, 3717.628237176315, 3727.5340582427198, 3732.533433320835, 3774.981125094357, 3789.0906182515996, 4268.722533035405, 4301.591348821857, 4304.246756817544, 4394.868153955386, 4395.714278571946, 4987.127252730757, 5014.824481143142, 5034.672746271481, 5066.771995260222, 5140.56305214061, 4363.629091527192, 4374.147041326974, 4376.168527979674, 4380.3210502372185, 4432.15789000089, 4423.358613001161, 4545.749983750926, 4549.613282870927, 4554.066416384633, 4591.540845915381, 4674.322223277538, 4712.481627021093, 4743.952560474351, 4748.976255118702, 4750.07373562152, 5089.821856235014, 5146.176611742103, 5158.3552055993005, 5162.148245539444, 5162.251473536391, 4741.2651039089, 4764.784979830121, 4766.856994290177, 4796.712197268175, 4868.853934381974, 4777.163996300564, 5008.874778130576, 5012.949870501248, 5019.924701129559, 5076.568491678101, 4895.4370247420575, 4973.079980203674, 4990.750462476934, 5029.1953287473825, 5100.744962751922, 4919.262110683426, 4922.138625740409, 4926.5073492650445, 4931.137051015986, 4989.376327959005, 4875.1712208923855, 4915.483874193301, 4919.286703428054, 4920.163572192808, 4976.626752993468, 4744.288356746516, 4779.283107533898, 4809.134355815987, 4862.659613826998, 4865.124277629919, 4769.260764581495, 4813.989062296957, 4929.975350123226, 4996.200607902863, 5006.974965125297, 4771.1888978872985, 4778.617710583215, 4778.976105119452, 4782.0914026334885, 4783.904321913612], "value": 4626.997670597343, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [564.3679079431038, 570.5464155995983, 571.4799532425494, 572.0503963420722, 575.1947273816656, 27905.581416278746, 38621.22757544847, 40138.5778275476, 40202.59797402025, 44198.0, 40744.092106644515, 41161.794191029076, 41253.58746412535, 41301.793491032506, 41326.58673413265, 7568.659410326521, 7757.030371203599, 7758.379329653614, 7761.0, 7761.573113478757, 7629.465937384385, 7722.729704460345, 7724.266194711493, 7724.575148366837, 7728.536287822721, 7738.7678369649, 7792.10390805059, 7801.648925798353, 7806.336461400788, 7808.453408261424, 7701.576413297266, 7717.961410192913, 7743.651535680908, 7749.690012399497, 7751.57366344848, 7654.808629784245, 7717.305442510201, 7720.34377077949, 7722.575258360788, 7727.884081738778, 37898.24203515942, 38336.80831595852, 38343.80828095869, 38344.42483362752, 38363.0, 3073.339232065094, 3107.844607769625, 3152.9684703152902, 3226.1611980884904, 3291.7202037826814, 28737.42525149506, 28800.711992880013, 29272.0, 29798.0, 29902.700972990428, 3344.4816053511745, 3370.224848284908, 3490.6858382745677, 3567.94648080279, 3591.191981804099, 250499.0, 250658.0, 253554.0, 253752.0, 253839.0, 31556.526652100238, 53709.0, 54305.72847135739, 54328.0, 54332.0, 31682.841585792383, 33535.83232083824, 33647.49528757071, 33653.831730841186, 33674.663253367646, 11736.765264694659, 11852.466639001266, 11864.940675296568, 11876.821847672292, 11877.643670689893, 10461.68614941553, 10524.579016839394, 10528.36829790215, 10528.894711052944, 10540.683779486628, 7827.882581761278, 7853.057633084067, 7857.921420785833, 7945.205479452008, 7987.8402431951035, 3108.953365699471, 3124.250179956794, 3139.152428844245, 3153.1644114309725, 3165.4776961801504, 829.9875501867476, 874.7900503879023, 883.6730409748434, 944.4050248343636, 953.4374718915873, 27180.0, 27558.173254802387, 27684.584731229046, 27870.16389508318, 28307.292317692223, 963.942163470194, 969.6703120938914, 1000.1248907206194, 1040.5837664934088, 1052.8210204265292, 13995.440182392795, 14868.925655371653, 14894.106353618818, 15023.399064037534, 15136.318865651072, 366401.0, 367240.0, 368019.0, 368036.0, 369160.0, 47850.0, 48296.0, 48356.7582162094, 48422.0, 48537.75731121392, 1041.9479026048666, 1065.5098654618962, 1066.3335415365398, 1156.4969238381332, 1173.0, 26355.341116472242, 28389.0, 29141.0, 31144.377112457172, 31404.371912562077, 46664.0, 47282.0, 47289.29066064081, 47382.52617473781, 47406.28890566575, 319868.0, 322673.0, 323390.0, 323721.0, 323837.0, 24451.0, 24931.252062438154, 25422.0, 25624.743752562237, 25647.487050259264, 40837.38743918903, 41206.9698257546, 41640.79179604204, 41919.37120943127, 42229.0, 34741.47887781736, 35140.0, 35749.28501429905, 35859.82070089633, 36357.63642363543, 34463.65536344604, 34501.827490862386, 34640.653593464755, 35195.0, 35380.46929296114, 27546.44907101887, 29241.415171696874, 29903.55144672788, 34659.65340346564, 34898.65101348954, 28968.95935353792, 32648.673513265512, 32736.0, 33021.50467742938, 33169.33661326808, 24708.629370559098, 24897.626535602343, 25019.249422517354, 25043.624345634467, 25455.0], "value": 16279.24002761671, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [360.40173312301584, 360.6483678413547, 366.9614690457503, 371.233403022758, 382.1935715640001, 15353.92323038386, 15652.452164174256, 16970.15149242539, 17038.48884533463, 17047.0, 16525.504234872973, 16829.242684079214, 17059.57351066224, 17444.0, 17559.73660395095, 4969.801207951687, 5261.394939581959, 5263.710495922742, 5264.868378290555, 5270.077736396134, 4983.775730092137, 5087.6184286178495, 5155.432902380735, 5182.818601348954, 5184.481551844823, 5114.820981265657, 5128.179491281396, 5134.974325128369, 5161.225816127573, 5162.277281180619, 4854.757262136879, 5088.567471764867, 5102.1836506159025, 5103.438621751604, 5107.642465027449, 4432.3794668746405, 4460.977695111504, 4461.776911154429, 4467.15124126415, 4471.530489298641, 20346.389608311776, 20740.896295518425, 20766.896165519076, 21034.0, 21068.262610808702, 1885.849132069431, 1940.3402843033296, 2125.978740212609, 2175.282156888223, 2377.9286621401384, 11340.0, 12399.566015189515, 12531.74936501274, 12941.417636206394, 13090.672733181651, 1447.0449503327752, 1467.259034187739, 1482.7479328514178, 1547.667251540913, 1624.4558073045544, 72398.63800681016, 76143.61928190323, 76325.23674763237, 76843.23156768417, 78080.60959695221, 9710.902890971141, 9870.407775533491, 9926.76647754264, 10193.898061019443, 10202.38785672862, 14077.366518506691, 14080.507182248572, 14092.647683807987, 14103.85896141046, 14113.0, 7114.517853752103, 7162.498625096193, 7189.964050179716, 7345.375643070399, 7373.410127189812, 6912.205096413876, 6927.411170050501, 7144.214136444987, 7153.570785752768, 7183.60490173035, 4218.915621687611, 4297.441332626801, 4302.65578753699, 4444.355568442557, 4456.844010459618, 1776.546980519959, 1830.8352248297717, 1834.339637730416, 1847.8521718262507, 1893.6591413545693, 818.3943881527746, 823.880537322097, 873.4584557574218, 896.3859756067114, 934.6962237272913, 16475.423360182336, 16862.24119914607, 17156.0, 17290.394836180672, 17871.195796189204, 842.6123982967904, 853.4665833853842, 864.3517361978517, 870.851955167623, 880.4145243413059, 8847.11528847123, 9846.409215447096, 9867.753306167404, 9986.750331241632, 10013.749656258506, 161708.0, 347577.0, 347690.0, 347747.0, 359081.0, 78434.43131137459, 81911.5904420486, 84122.57938710267, 84387.5780621093, 87322.0, 402.89121937077414, 428.5799916082195, 428.93137098064784, 431.42620314981, 432.2069003378835, 9968.152707019985, 10399.168066554808, 10426.530806113895, 10505.474726263808, 10594.205434592282, 36110.819445902605, 36205.0, 37140.257194856495, 37708.0, 38541.0, 44741.0, 48483.27275090947, 49580.50419495903, 49830.50169498259, 50277.0, 7165.211826698955, 7554.4334174936, 7610.695572177051, 7705.075390953121, 8305.709300174465, 11170.547828782206, 11491.74789405837, 11522.711932201762, 12416.0, 12478.126531142732, 9675.371100878421, 10031.648892288735, 10088.596456141966, 10210.540525676512, 10275.332103413255, 9635.470049147365, 10157.746056348651, 10237.692869213935, 10425.218108642033, 10669.0, 10342.844857326996, 10361.792764144826, 10482.109020733324, 10664.360138391721, 10788.352698838095, 7718.652660630173, 7730.961345193238, 7746.767596972099, 7758.495697779626, 7809.882851757115, 7883.054033516015, 9338.252939764938, 9909.45497997617, 10825.0, 11021.0], "value": 7915.896002575651, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1208.2327721896604, 1332.5269529317095, 1384.3562743324353, 1425.2944792327798, 1680.008794811062, 6751.156105486814, 7358.852822943538, 7699.884501732478, 7708.306252437286, 7966.283034526891, 7787.64955576999, 7847.92152078479, 7856.4107691923045, 7864.724734634289, 7870.842583148334, 2158.589867925093, 2178.433607262107, 2185.1477923609805, 2189.9781002189934, 2191.7698641642555, 2117.7458704955425, 2160.2223199648192, 2170.5007848194846, 2173.098164261837, 2179.3353027326657, 2121.4378189779723, 2126.26643807886, 2132.2856842957626, 2134.295682424804, 2177.901994410255, 2088.0395018291606, 2092.0585736418598, 2093.654546999743, 2096.0986775686524, 2096.1091536097097, 2048.8424040417117, 2105.9368218953455, 2108.1883474862134, 2110.0926601561323, 2113.281484295347, 7542.962285188539, 7595.430342724262, 7624.35193008595, 7784.844303113962, 7832.686692532292, 4419.955800441987, 4540.977295113504, 4550.249208880564, 4550.522195169526, 4550.68145229834, 2747.4230411613585, 2870.5550639650887, 2904.099729083991, 2918.4454953558757, 2923.400702855931, 917.8302014127407, 921.3780698028871, 940.3981451870808, 954.7994921066585, 955.6177528988391, 10404.063634272876, 10471.267011309212, 10475.895241047645, 10506.317089389242, 10507.579696812118, 3733.794641294755, 3799.3920972644796, 3872.1481274119647, 3915.941260881089, 3927.155661532784, 8267.710630128036, 8336.62485188168, 8337.749867503984, 8344.8331033379, 8347.123552027071, 4390.363397307373, 4390.495093064338, 4396.736195828261, 4397.186520493655, 4407.867763967086, 3571.8035508046787, 3692.8707495238077, 4003.5796241394232, 4089.1412803311637, 4104.856330028435, 3404.69357757803, 3431.8627254910025, 3529.505869178317, 3532.5760908691122, 3553.680168784822, 1023.7133602591286, 1027.799579082072, 1040.77623310987, 1043.608646757466, 1049.1344640671477, 774.4849674966084, 790.1190172957226, 793.9682412703543, 809.7813590330695, 817.852786498436, 4646.279826626878, 4656.371389862393, 4732.574068333866, 4867.269909513601, 4973.2540118981715, 393.83065281928475, 395.6043956043956, 397.6639739420185, 398.23737542605585, 410.3721306401211, 3276.0990727550115, 3411.422324499412, 3423.691867731916, 3453.430184019659, 3453.533772940621, 8882.200601945726, 8917.777055573662, 9282.257419406431, 9310.255179585616, 9624.711258662252, 9518.333716639769, 9545.61817527305, 9563.378380405251, 9565.0, 9567.61729530811, 6754.493412994045, 7228.927710722825, 7291.671874765649, 7307.525010874276, 7313.524620899624, 5106.514881086291, 5141.71720555373, 5185.11852985001, 5204.401493828107, 5252.317198764136, 8735.475871447734, 8777.6927807529, 8803.911960880308, 8838.116188381367, 8931.73204803857, 8764.956175219084, 8873.378863479753, 8946.463212207029, 8990.190882820578, 9068.773280668036, 5808.07070868659, 5850.882982340415, 6455.4512866406885, 6563.0, 6571.244306904576, 7196.712131514681, 7442.181360050282, 7453.2546745325035, 7458.664360103917, 7465.664045117874, 6500.317466666121, 6599.637019963756, 6610.272869984202, 6791.286914873867, 6824.078749368771, 6583.934160658332, 6584.76953306632, 6593.967030164818, 6622.602643841385, 6647.069410282661, 6205.906911396423, 6343.841403964753, 6363.522735794926, 6366.427021567896, 6368.42684158428, 4361.8037188327235, 4411.316245981878, 4492.483364413004, 4504.887377815449, 4518.548145185455, 4295.24833154203, 4335.783210839382, 4370.759608221579, 4399.450068741407, 4411.117776444659], "value": 3924.7978619276064, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [273.0620319203536, 276.41676063506, 277.8646104685491, 278.86056971514245, 279.27388789148216, 4816.133096042711, 4854.296127061574, 4865.635077369194, 4866.610671146304, 4886.193778026626, 4759.976200118995, 4765.166095933207, 4770.761461926907, 4791.736454495001, 4793.233082706767, 3743.4010558310674, 3746.1758413149064, 3753.568339640942, 3755.324041672498, 3760.0, 3745.325841348556, 3761.7742935423826, 3771.8491260349692, 3774.962250377502, 3782.375907975181, 3589.964100358989, 3690.114372550582, 3729.1982223821874, 3731.8320675569666, 3754.080250338671, 3741.6904083570803, 3742.644448777362, 3744.756590821615, 3752.3996160614306, 3762.6049264827075, 3300.488424294238, 3306.371789360038, 3308.4210263203845, 3309.3712194682935, 3313.6686331366673, 4406.669499787528, 4517.706349087299, 4555.0, 4653.883652908705, 4667.486576476619, 4227.471566054243, 4259.424977628042, 4263.552327005682, 4266.957330426687, 4268.274393353137, 4926.926096108561, 4965.386249468937, 4970.676906001098, 4971.45314015458, 4971.751412429364, 3466.670666286724, 3543.2204914918675, 3561.2521370511963, 3567.6432356764376, 3592.892213233607, 5119.283300337956, 5124.205748109011, 5154.5103215194495, 5167.586593072545, 5168.250603662485, 3563.1982803868923, 3565.860483709805, 3583.0863129902227, 3604.5314109166166, 3614.566252049771, 3570.250247448065, 3648.4527320901548, 3658.213484100931, 3658.957197198839, 3659.249853779969, 4156.58434156588, 4167.8332866685, 4169.228692691801, 4191.119864828359, 4215.220184265921, 4977.527134922249, 4982.402111746614, 4984.626153038536, 4992.600591952635, 4993.350864387607, 1294.8057791331375, 1304.9151805132635, 1307.2613973105165, 1312.704641455684, 1313.5862203406089, 790.1584812175015, 832.3590835057093, 835.1272919798824, 838.2037064788475, 844.7085755414372, 3988.504310883419, 3992.321305378093, 4024.8591299304385, 4027.4160246764054, 4029.979850100731, 4564.863054108382, 4567.566081222279, 4568.771561421916, 4585.449746030497, 4645.814167433333, 3866.2074274773604, 4057.4928133983253, 4075.9388609170887, 4082.591740825894, 4090.6318431341324, 2451.656768052474, 2455.8457524963237, 2462.4459496613117, 2464.642626819101, 2471.3195027381194, 4353.25994580922, 4358.280883654162, 4371.366151908019, 4601.792919318638, 4785.473597904228, 5058.949410505921, 5270.235815806764, 5291.3121294231505, 5293.75596734767, 5302.310699609026, 4865.983090483923, 4875.806346842824, 4880.267959806058, 4885.7801398937845, 4893.266010098514, 4938.481459446706, 5166.8966620668125, 5171.663841850418, 5189.247559103985, 5190.584753219658, 5043.344365232643, 5051.974740126276, 5056.494350564914, 5066.518680725325, 5084.51697088776, 4848.903021939471, 4862.878428039327, 4871.585915197248, 4876.366072410564, 4877.878088039842, 3373.1904342957023, 3607.458881167846, 3623.836927338223, 3785.432185172246, 3791.4691943128537, 5172.456892026283, 5172.9741351293005, 5180.378354597472, 5188.896222075613, 5190.5742210141125, 5034.244863270539, 5034.949650503448, 5039.647224694236, 5039.874003149804, 5051.484554633668, 4849.199882019428, 5033.6476446648385, 5038.546530812245, 5055.646104772778, 5079.847604571869, 4971.353724015855, 4978.452370239198, 4983.27742477346, 4985.227289770091, 4996.275540046746, 5077.517635824591, 5085.64400491962, 5096.490350964874, 5096.980603879165, 5100.903305789125, 4756.286557016475, 4948.233023881304, 4954.99322774277, 4969.47820478859, 4974.602031837372], "value": 3718.5338176612327, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [628.8050704281673, 677.1941389746202, 708.6138054760155, 734.3867870328276, 735.2941176470588, 12505.43725532352, 13358.732825343488, 13384.063115581914, 13423.73152536951, 13468.932655336734, 13481.460741570325, 13597.932010339935, 13602.115862468932, 13609.591712248648, 13621.182729036265, 588.6497533967304, 605.5186127029023, 726.0887586079489, 733.1422235983898, 752.0674363788917, 737.8561180569791, 747.3274053352, 747.4170147285126, 747.7083937264445, 748.2367984655648, 791.0, 792.3423558446476, 793.2820797178563, 793.623029061197, 793.8213901872061, 608.388569487662, 627.1408170805979, 753.2091304130696, 784.8508783331177, 786.0802860653021, 567.1351189436143, 574.196125424405, 575.1889835332204, 575.3469811763637, 575.3699698829774, 13052.15161014531, 13151.473941042346, 13185.0, 13194.604161875159, 13197.076204665676, 12515.0, 12587.496500139983, 12640.810387844189, 13019.414126364336, 13536.323183840768, 11540.526566974206, 11983.580574679845, 12097.334646594434, 12311.56909508163, 13223.867761322455, 4305.31115021595, 4326.545712700153, 4353.869383918487, 4394.868153955386, 4530.365748795171, 63151.0, 64916.67541662309, 65013.3498665012, 65132.3486765131, 65155.674221628586, 10457.633982810565, 10566.762728146143, 10948.39783811882, 11047.226694131334, 11242.213045086928, 19928.3025094121, 20035.39893803188, 20169.899150504152, 20176.192952281745, 20239.392818215478, 6846.383825455733, 6891.310868913069, 6938.306169383122, 6971.128608923885, 6971.477139214579, 3499.825008749603, 3519.260955199437, 3554.0937061049267, 3571.1250743567994, 3607.0, 2758.6206896551726, 2846.174609363303, 2862.527682932293, 2866.441043996442, 2874.037197538848, 473.684999475345, 482.57051224410304, 492.38206051405257, 503.4210657743551, 503.66757939759583, 476.2665495137519, 504.7905119375418, 535.3522238091953, 563.7181409295353, 578.4967078641608, 7420.220876807965, 7720.806979825437, 7721.806954826175, 7769.689212431553, 7846.9215307847335, 479.74093989246114, 507.91813437378147, 538.1953978801716, 581.6771691711141, 587.6797145555682, 3559.4126969049817, 3623.0942264433893, 3656.597774244831, 3687.082716987152, 3715.888523344304, 94446.0, 100875.49562252141, 101635.49182254041, 101692.0, 102430.0, 86387.13612863916, 86415.0, 87580.12419875847, 88370.55814721013, 89726.55136724275, 73159.63420182865, 75415.0, 75582.24417755862, 76110.0, 77806.2219377799, 6751.72993080291, 6891.173059232924, 6917.412019978358, 7180.31786980236, 7283.708651653875, 45560.54439455563, 46304.0, 46474.535254647024, 46497.53502464932, 46886.76556617195, 38585.0, 47268.7636561815, 51193.23210151776, 54240.72879635577, 60159.0, 11409.512559496938, 11431.657050288504, 11527.308361498002, 11553.94223028913, 11599.362035087814, 12432.81350779721, 12977.416016279101, 12977.610671679864, 13362.465501379836, 13423.060385772902, 11769.588064417705, 11975.580854670394, 12415.62753117408, 12482.063845211464, 12649.93675031619, 11498.0, 11884.0, 12009.459574319002, 12026.819597705866, 12565.057620678303, 11042.171837112088, 11404.771904562029, 11502.654920352403, 11709.707257318636, 11723.296602203554, 9389.765255868659, 9600.32797704154, 9633.9036609633, 9694.127528522467, 9958.402495850272, 9721.416714997124, 9726.70819875405, 10699.625513107005, 10849.728756781144, 10952.616658416917], "value": 6517.475432190432, "unit": "score"}], "name": "dromaeo_css", "value": 6198.574629792637, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 116.0, 113.0, 115.0, 114.0, 115.0, 113.0, 115.0, 113.0, 114.0], "value": 114.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 127.0, 125.0, 175.0, 135.0, 134.0, 128.0, 125.0, 164.0, 126.0], "value": 139.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 161.0, 161.0, 160.0, 163.0, 161.0, 161.0, 160.0, 160.0], "value": 161.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 77.0, 76.0, 109.0, 78.0, 77.0, 75.0, 76.0, 105.0, 75.0], "value": 82.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 111.0, 83.0, 84.0, 83.0, 105.0, 83.0, 83.0, 114.0], "value": 91.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 116.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 145.0, 145.0], "value": 146.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 64.0, 65.0, 64.0, 65.0, 66.0, 64.0, 65.0, 65.0, 65.0], "value": 64.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 67.0, 67.0, 66.0, 67.0, 67.0, 67.0, 67.0, 66.0], "value": 66.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 83.0, 83.0, 88.0, 83.0, 84.0, 82.0, 82.0, 82.0], "value": 83.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 140.0, 140.0, 138.0, 137.0, 139.0, 137.0, 138.0, 172.0, 139.0], "value": 142.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 177.0, 173.0, 172.0, 171.0, 172.0, 178.0, 173.0, 172.0, 173.0], "value": 173.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 71.0, 70.0, 69.0, 70.0, 68.0, 69.0, 70.0, 68.0, 68.0], "value": 69.2, "unit": "score"}], "name": "kraken", "value": 1545.8999999999999, "alertThreshold": 2.0}]} 18:38:57 INFO - Return code: 0 18:38:57 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:38:57 INFO - # TBPL SUCCESS # 18:38:57 INFO - Running post-action listener: _resource_record_post_action 18:38:57 INFO - [mozharness: 2016-10-09 01:38:57.441912Z] Finished run-tests step (success) 18:38:57 INFO - Running post-run listener: _resource_record_post_run 18:38:57 INFO - Total resource usage - Wall time: 1204s; CPU: 13.0%; Read bytes: 3321856; Write bytes: 403841024; Read time: 376; Write time: 279404 18:38:57 INFO - TinderboxPrint: CPU usage
13.0% 18:38:57 INFO - TinderboxPrint: I/O read bytes / time
3,321,856 / 376 18:38:57 INFO - TinderboxPrint: I/O write bytes / time
403,841,024 / 279,404 18:38:57 INFO - TinderboxPrint: CPU idle
8,352.2 (86.9%) 18:38:57 INFO - TinderboxPrint: CPU user
1,205.6 (12.5%) 18:38:57 INFO - TinderboxPrint: Swap in / out
0 / 0 18:38:57 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 4096; Write bytes: 110669824; Read time: 32; Write time: 67728 18:38:57 INFO - run-tests - Wall time: 1188s; CPU: 13.0%; Read bytes: 3313664; Write bytes: 293171200; Read time: 336; Write time: 211676 18:38:58 INFO - Running post-run listener: _upload_blobber_files 18:38:58 INFO - Blob upload gear active. 18:38:58 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:38:58 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 18:38:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 18:38:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 18:38:58 INFO - (blobuploader) - INFO - Open directory for files ... 18:38:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 18:38:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:38:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:38:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 18:38:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:38:59 INFO - (blobuploader) - INFO - Done attempting. 18:38:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 18:38:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:38:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:39:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 18:39:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:39:00 INFO - (blobuploader) - INFO - Done attempting. 18:39:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:39:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:39:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:39:03 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:39:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:39:03 INFO - (blobuploader) - INFO - Done attempting. 18:39:03 INFO - (blobuploader) - INFO - Iteration through files over. 18:39:03 INFO - Return code: 0 18:39:03 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:39:03 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:39:03 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/756d08fd7dc00428c22c0fa6dcc874d51e8b4fd33b630bb0972deef0975247a3bb42e484af49b1ce43a61034d5582401f858860e90ac4ce6a40c9f2361a5fbed", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6ed5b90a6519bb7404637e6b324c1caacb5f9e066d347fd71681f5d3edf51f39a2ff13934f9d9237623c340a77e359430d3936cec75ab3c7eb30f268f3080f42", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1b0d43b20544629a4e6bfa37079c04b8169422e8959313b6bb9b440707da588e6b0173145c886c3f5b1df263ee81112450afcb8aad095b31c920e1055d0effbc"} 18:39:03 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:39:03 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:39:03 INFO - Contents: 18:39:03 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/756d08fd7dc00428c22c0fa6dcc874d51e8b4fd33b630bb0972deef0975247a3bb42e484af49b1ce43a61034d5582401f858860e90ac4ce6a40c9f2361a5fbed", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6ed5b90a6519bb7404637e6b324c1caacb5f9e066d347fd71681f5d3edf51f39a2ff13934f9d9237623c340a77e359430d3936cec75ab3c7eb30f268f3080f42", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1b0d43b20544629a4e6bfa37079c04b8169422e8959313b6bb9b440707da588e6b0173145c886c3f5b1df263ee81112450afcb8aad095b31c920e1055d0effbc"} 18:39:03 INFO - Running post-run listener: copy_logs_to_upload_dir 18:39:03 INFO - Copying logs to upload dir... 18:39:03 INFO - mkdir: /builds/slave/test/build/upload/logs 18:39:03 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.408751 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-10-08 18:39:03.649660) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-08 18:39:03.653124) ========= 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=62c568580acbfdaac3eec7be000001dc-1475961404.388074-116307990 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-Non-PGO/sha512/756d08fd7dc00428c22c0fa6dcc874d51e8b4fd33b630bb0972deef0975247a3bb42e484af49b1ce43a61034d5582401f858860e90ac4ce6a40c9f2361a5fbed", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6ed5b90a6519bb7404637e6b324c1caacb5f9e066d347fd71681f5d3edf51f39a2ff13934f9d9237623c340a77e359430d3936cec75ab3c7eb30f268f3080f42", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1b0d43b20544629a4e6bfa37079c04b8169422e8959313b6bb9b440707da588e6b0173145c886c3f5b1df263ee81112450afcb8aad095b31c920e1055d0effbc"} build_url:https://queue.taskcluster.net/v1/task/NlSVMvtbSEuiNBTYC9r7Bw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011457 build_url: 'https://queue.taskcluster.net/v1/task/NlSVMvtbSEuiNBTYC9r7Bw/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-Non-PGO/sha512/756d08fd7dc00428c22c0fa6dcc874d51e8b4fd33b630bb0972deef0975247a3bb42e484af49b1ce43a61034d5582401f858860e90ac4ce6a40c9f2361a5fbed", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6ed5b90a6519bb7404637e6b324c1caacb5f9e066d347fd71681f5d3edf51f39a2ff13934f9d9237623c340a77e359430d3936cec75ab3c7eb30f268f3080f42", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1b0d43b20544629a4e6bfa37079c04b8169422e8959313b6bb9b440707da588e6b0173145c886c3f5b1df263ee81112450afcb8aad095b31c920e1055d0effbc"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-08 18:39:03.682097) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-08 18:39:03.682756) ========= 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=62c568580acbfdaac3eec7be000001dc-1475961404.388074-116307990 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004429 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-08 18:39:03.765193) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-08 18:39:03.765902) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-08 18:39:03.766476) ========= ========= Total master_lag: 0.21 =========