builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-002 starttime: 1471059270.77 results: success (0) buildid: 20160812173001 builduid: a3f208ba48c746d989153be67641dbaa revision: 1ba6215e84c3b34b928898331c3d444b3dd96ee3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-12 20:34:30.774102) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-12 20:34:30.774609) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-12 20:34:30.774925) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-12 20:34:30.793671) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-12 20:34:30.793974) ========= 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=a0d2d2de893abaa8702a9954000001a7-1471059225.105527-494328540 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-12 20:34:31-- 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% 41.4M=0s 2016-08-12 20:34:31 (41.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.133863 ========= master_lag: 0.22 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-12 20:34:31.146423) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-12 20:34:31.146804) ========= 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=a0d2d2de893abaa8702a9954000001a7-1471059225.105527-494328540 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016403 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-12 20:34:31.176307) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-12 20:34:31.179764) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 1ba6215e84c3b34b928898331c3d444b3dd96ee3 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 1ba6215e84c3b34b928898331c3d444b3dd96ee3 --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=a0d2d2de893abaa8702a9954000001a7-1471059225.105527-494328540 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-12 20:34:31,676 truncating revision to first 12 chars 2016-08-12 20:34:31,676 Setting DEBUG logging. 2016-08-12 20:34:31,676 attempt 1/10 2016-08-12 20:34:31,676 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/1ba6215e84c3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-12 20:34:31,972 unpacking tar archive at: fx-team-1ba6215e84c3/testing/mozharness/ program finished with exit code 0 elapsedTime=0.639713 ========= master_lag: 0.20 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-12 20:34:32.016167) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-12 20:34:32.016696) ========= script_repo_revision: 1ba6215e84c3b34b928898331c3d444b3dd96ee3 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-12 20:34:32.017320) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-12 20:34:32.020837) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-12 20:34:32.032778) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-08-12 20:34:32.033349) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=a0d2d2de893abaa8702a9954000001a7-1471059225.105527-494328540 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:34:32 INFO - MultiFileLogger online at 20160812 20:34:32 in /builds/slave/test 20:34:32 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 20:34:32 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:34:32 INFO - {'append_to_log': False, 20:34:32 INFO - 'base_work_dir': '/builds/slave/test', 20:34:32 INFO - 'blob_upload_branch': 'Fx-Team', 20:34:32 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:34:32 INFO - 'branch': 'Fx-Team', 20:34:32 INFO - 'buildbot_json_path': 'buildprops.json', 20:34:32 INFO - 'config_files': ('talos/linux_config.py',), 20:34:32 INFO - 'default_actions': ('clobber', 20:34:32 INFO - 'read-buildbot-config', 20:34:32 INFO - 'download-and-extract', 20:34:32 INFO - 'populate-webroot', 20:34:32 INFO - 'create-virtualenv', 20:34:32 INFO - 'install', 20:34:32 INFO - 'run-tests'), 20:34:32 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:34:32 INFO - 'download_minidump_stackwalk': True, 20:34:32 INFO - 'download_symbols': 'ondemand', 20:34:32 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:34:32 INFO - 'tooltool.py': '/tools/tooltool.py', 20:34:32 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:34:32 INFO - '/tools/misc-python/virtualenv.py')}, 20:34:32 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:34:32 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:34:32 INFO - 'installer_path': 'installer.exe', 20:34:32 INFO - 'log_level': 'info', 20:34:32 INFO - 'log_name': 'talos', 20:34:32 INFO - 'log_to_console': True, 20:34:32 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:34:32 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:34:32 INFO - 'opt_config_files': (), 20:34:32 INFO - 'pip_index': False, 20:34:32 INFO - 'sps_profile': False, 20:34:32 INFO - 'sps_profile_interval': 0, 20:34:32 INFO - 'suite': 'dromaeojs-e10s', 20:34:32 INFO - 'system_bits': '32', 20:34:32 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:34:32 INFO - 'title': 'talos-linux64-ix-002', 20:34:32 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:34:32 INFO - 'use_talos_json': True, 20:34:32 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:34:32 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:34:32 INFO - 'work_dir': 'build'} 20:34:32 INFO - [mozharness: 2016-08-13 03:34:32.449110Z] Running clobber step. 20:34:32 INFO - Running pre-action listener: _resource_record_pre_action 20:34:32 INFO - Running main action method: clobber 20:34:32 INFO - rmtree: /builds/slave/test/build 20:34:32 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:34:32 INFO - Running post-action listener: _resource_record_post_action 20:34:32 INFO - [mozharness: 2016-08-13 03:34:32.915935Z] Finished clobber step (success) 20:34:32 INFO - [mozharness: 2016-08-13 03:34:32.916037Z] Running read-buildbot-config step. 20:34:32 INFO - Running pre-action listener: _resource_record_pre_action 20:34:32 INFO - Running main action method: read_buildbot_config 20:34:32 INFO - Using buildbot properties: 20:34:32 INFO - { 20:34:32 INFO - "project": "", 20:34:32 INFO - "product": "firefox", 20:34:32 INFO - "script_repo_revision": "production", 20:34:32 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 20:34:32 INFO - "repository": "", 20:34:32 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 20:34:32 INFO - "buildid": "20160812173001", 20:34:32 INFO - "pgo_build": "True", 20:34:32 INFO - "basedir": "/builds/slave/test", 20:34:32 INFO - "buildnumber": 1041, 20:34:32 INFO - "slavename": "talos-linux64-ix-002", 20:34:32 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 20:34:32 INFO - "platform": "ubuntu64_hw", 20:34:32 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 20:34:32 INFO - "branch": "fx-team", 20:34:32 INFO - "repo_path": "integration/fx-team", 20:34:32 INFO - "revision": "1ba6215e84c3b34b928898331c3d444b3dd96ee3", 20:34:32 INFO - "stage_platform": "linux64-pgo", 20:34:32 INFO - "builduid": "a3f208ba48c746d989153be67641dbaa", 20:34:32 INFO - "slavebuilddir": "test" 20:34:32 INFO - } 20:34:32 INFO - Found installer url https://queue.taskcluster.net/v1/task/dEUXn0EdTxmP3attTspuxA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 20:34:32 INFO - Running post-action listener: _resource_record_post_action 20:34:32 INFO - [mozharness: 2016-08-13 03:34:32.918818Z] Finished read-buildbot-config step (success) 20:34:32 INFO - [mozharness: 2016-08-13 03:34:32.918905Z] Running download-and-extract step. 20:34:32 INFO - Running pre-action listener: _resource_record_pre_action 20:34:32 INFO - Running main action method: download_and_extract 20:34:32 INFO - mkdir: /builds/slave/test/build/tests 20:34:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:34:32 INFO - trying https://queue.taskcluster.net/v1/task/dEUXn0EdTxmP3attTspuxA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 20:34:32 INFO - Downloading https://queue.taskcluster.net/v1/task/dEUXn0EdTxmP3attTspuxA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 20:34:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dEUXn0EdTxmP3attTspuxA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 20:34:33 INFO - Downloaded 1361 bytes. 20:34:33 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 20:34:33 INFO - Using the following test package requirements: 20:34:33 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 20:34:33 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 20:34:33 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 20:34:33 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 20:34:33 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 20:34:33 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 20:34:33 INFO - u'jsshell-linux-x86_64.zip'], 20:34:33 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 20:34:33 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 20:34:33 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 20:34:33 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 20:34:33 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 20:34:33 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 20:34:33 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 20:34:33 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 20:34:33 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 20:34:33 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 20:34:33 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 20:34:33 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 20:34:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:34:33 INFO - trying https://queue.taskcluster.net/v1/task/dEUXn0EdTxmP3attTspuxA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 20:34:33 INFO - Downloading https://queue.taskcluster.net/v1/task/dEUXn0EdTxmP3attTspuxA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 20:34:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dEUXn0EdTxmP3attTspuxA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 20:34:34 INFO - Downloaded 21834639 bytes. 20:34:34 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 20:34:38 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 20:34:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:34:38 INFO - trying https://queue.taskcluster.net/v1/task/dEUXn0EdTxmP3attTspuxA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 20:34:38 INFO - Downloading https://queue.taskcluster.net/v1/task/dEUXn0EdTxmP3attTspuxA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 20:34:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dEUXn0EdTxmP3attTspuxA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 20:34:39 INFO - Downloaded 21834639 bytes. 20:34:39 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 20:34:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:34:44 INFO - trying https://queue.taskcluster.net/v1/task/dEUXn0EdTxmP3attTspuxA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 20:34:44 INFO - Downloading https://queue.taskcluster.net/v1/task/dEUXn0EdTxmP3attTspuxA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 20:34:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dEUXn0EdTxmP3attTspuxA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 20:34:44 INFO - Downloaded 14413719 bytes. 20:34:44 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/tests 20:34: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')]} 20:34:45 INFO - trying https://queue.taskcluster.net/v1/task/dEUXn0EdTxmP3attTspuxA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 20:34:45 INFO - Downloading https://queue.taskcluster.net/v1/task/dEUXn0EdTxmP3attTspuxA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 20:34:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dEUXn0EdTxmP3attTspuxA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 20:34:46 INFO - Downloaded 59405109 bytes. 20:34:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dEUXn0EdTxmP3attTspuxA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 20:34:46 INFO - mkdir: /builds/slave/test/properties 20:34:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:34:46 INFO - Writing to file /builds/slave/test/properties/build_url 20:34:46 INFO - Contents: 20:34:46 INFO - build_url:https://queue.taskcluster.net/v1/task/dEUXn0EdTxmP3attTspuxA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 20:34:47 INFO - Running post-action listener: _resource_record_post_action 20:34:47 INFO - Running post-action listener: set_extra_try_arguments 20:34:47 INFO - [mozharness: 2016-08-13 03:34:47.116551Z] Finished download-and-extract step (success) 20:34:47 INFO - [mozharness: 2016-08-13 03:34:47.116774Z] Running populate-webroot step. 20:34:47 INFO - Running pre-action listener: _resource_record_pre_action 20:34:47 INFO - Running main action method: populate_webroot 20:34:47 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:34:47 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:34:47 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:34:47 INFO - '--tppagecycles', 20:34:47 INFO - '7'], 20:34:47 INFO - 'tests': ['tsvgm']}}, 20:34:47 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:34:47 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:34:47 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:34:47 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:34:47 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:34:47 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:34:47 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:34:47 INFO - 'talos_options': ['--disable-e10s'], 20:34:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:34:47 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:34:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:34:47 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:34:47 INFO - 'talos_options': ['--disable-e10s'], 20:34:47 INFO - 'tests': ['damp', 'tps']}, 20:34:47 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:34:47 INFO - 'tests': ['damp', 'tps']}, 20:34:47 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:34:47 INFO - 'tests': ['dromaeo_dom']}, 20:34:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:34:47 INFO - 'g4': {'talos_options': ['--disable-e10s'], 20:34:47 INFO - 'tests': ['basic_compositor_video']}, 20:34:47 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 20:34:47 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:34:47 INFO - 'tests': ['a11yr', 20:34:47 INFO - 'ts_paint', 20:34:47 INFO - 'tpaint', 20:34:47 INFO - 'sessionrestore', 20:34:47 INFO - 'sessionrestore_no_auto_restore', 20:34:47 INFO - 'tabpaint']}, 20:34:47 INFO - 'other-e10s': {'tests': ['a11yr', 20:34:47 INFO - 'ts_paint', 20:34:47 INFO - 'tpaint', 20:34:47 INFO - 'sessionrestore', 20:34:47 INFO - 'sessionrestore_no_auto_restore', 20:34:47 INFO - 'tabpaint']}, 20:34:47 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:34:47 INFO - 'ts_paint', 20:34:47 INFO - 'tpaint', 20:34:47 INFO - 'sessionrestore', 20:34:47 INFO - 'sessionrestore_no_auto_restore', 20:34:47 INFO - 'tabpaint']}, 20:34:47 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:34:47 INFO - 'ts_paint', 20:34:47 INFO - 'tpaint', 20:34:47 INFO - 'sessionrestore', 20:34:47 INFO - 'sessionrestore_no_auto_restore', 20:34:47 INFO - 'tabpaint']}, 20:34:47 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:34:47 INFO - 'tests': ['a11yr', 20:34:47 INFO - 'ts_paint', 20:34:47 INFO - 'tpaint', 20:34:47 INFO - 'sessionrestore', 20:34:47 INFO - 'sessionrestore_no_auto_restore', 20:34:47 INFO - 'tabpaint']}, 20:34:47 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:34:47 INFO - 'tests': ['a11yr', 20:34:47 INFO - 'ts_paint', 20:34:47 INFO - 'tpaint', 20:34:47 INFO - 'sessionrestore', 20:34:47 INFO - 'sessionrestore_no_auto_restore', 20:34:47 INFO - 'tabpaint']}, 20:34:47 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:34:47 INFO - 'tests': ['tsvgx', 20:34:47 INFO - 'tsvgr_opacity', 20:34:47 INFO - 'tart', 20:34:47 INFO - 'tscrollx', 20:34:47 INFO - 'cart']}, 20:34:47 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:34:47 INFO - 'tsvgr_opacity', 20:34:47 INFO - 'tart', 20:34:47 INFO - 'tscrollx', 20:34:47 INFO - 'cart']}, 20:34:47 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:34:47 INFO - 'talos_options': ['--disable-e10s'], 20:34:47 INFO - 'tests': ['tp5o']}, 20:34:47 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:34:47 INFO - 'tests': ['tp5o']}, 20:34:47 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:34:47 INFO - 'talos_options': ['--disable-e10s', 20:34:47 INFO - '--xperf_path', 20:34:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:34:47 INFO - 'tests': ['tp5n']}, 20:34:47 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:34:47 INFO - 'talos_options': ['--xperf_path', 20:34:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:34:47 INFO - 'tests': ['tp5n']}}, 20:34:47 INFO - 'talos.zip': {'path': '', 20:34:47 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:34:47 INFO - Running post-action listener: _resource_record_post_action 20:34:47 INFO - [mozharness: 2016-08-13 03:34:47.133013Z] Finished populate-webroot step (success) 20:34:47 INFO - [mozharness: 2016-08-13 03:34:47.133101Z] Running create-virtualenv step. 20:34:47 INFO - Running pre-action listener: _resource_record_pre_action 20:34:47 INFO - Running main action method: create_virtualenv 20:34:47 INFO - Creating virtualenv /builds/slave/test/build/venv 20:34:47 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 20:34:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:34:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:34:47 INFO - Using real prefix '/usr' 20:34:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:34:47 INFO - Installing distribute.............................................................................................................................................................................................done. 20:34:49 INFO - Installing pip.................done. 20:34:49 INFO - Return code: 0 20:34:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:34:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:34:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:34:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:34:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:34:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:34:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:34:49 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 0x7f2dc413af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1df5850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1df0370>, '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 0x1df38f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1df3d80>, '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': 'a0d2d2de893abaa8702a9954000001a7-1471059225.105527-494328540', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:34:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 20:34:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 20:34:49 INFO - Using env: {'DISPLAY': ':0', 20:34:49 INFO - 'HOME': '/home/cltbld', 20:34:49 INFO - 'LANG': 'en_US.UTF-8', 20:34:49 INFO - 'LANGUAGE': 'en_US:en', 20:34:49 INFO - 'LOGNAME': 'cltbld', 20:34:49 INFO - 'MAIL': '/var/mail/cltbld', 20:34:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:34:49 INFO - 'MOZ_NO_REMOTE': '1', 20:34:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:34:49 INFO - 'NO_EM_RESTART': '1', 20:34:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:34:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:34:49 INFO - 'PWD': '/builds/slave/test', 20:34:49 INFO - 'SHELL': '/bin/bash', 20:34:49 INFO - 'SHLVL': '1', 20:34:49 INFO - 'TERM': 'linux', 20:34:49 INFO - 'TMOUT': '86400', 20:34:49 INFO - 'USER': 'cltbld', 20:34:49 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1471059225.105527-494328540', 20:34:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:34:49 INFO - '_': '/tools/buildbot/bin/python'} 20:34:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:34:49 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 20:34:49 INFO - Cleaning up... 20:34:49 INFO - Return code: 0 20:34:49 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 20:34:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:34:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:34:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:34:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:34:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:34:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:34:49 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 0x7f2dc413af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1df5850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1df0370>, '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 0x1df38f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1df3d80>, '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': 'a0d2d2de893abaa8702a9954000001a7-1471059225.105527-494328540', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:34:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 20:34:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 20:34:49 INFO - Using env: {'DISPLAY': ':0', 20:34:49 INFO - 'HOME': '/home/cltbld', 20:34:49 INFO - 'LANG': 'en_US.UTF-8', 20:34:49 INFO - 'LANGUAGE': 'en_US:en', 20:34:49 INFO - 'LOGNAME': 'cltbld', 20:34:49 INFO - 'MAIL': '/var/mail/cltbld', 20:34:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:34:49 INFO - 'MOZ_NO_REMOTE': '1', 20:34:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:34:49 INFO - 'NO_EM_RESTART': '1', 20:34:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:34:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:34:49 INFO - 'PWD': '/builds/slave/test', 20:34:49 INFO - 'SHELL': '/bin/bash', 20:34:49 INFO - 'SHLVL': '1', 20:34:49 INFO - 'TERM': 'linux', 20:34:49 INFO - 'TMOUT': '86400', 20:34:49 INFO - 'USER': 'cltbld', 20:34:49 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1471059225.105527-494328540', 20:34:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:34:49 INFO - '_': '/tools/buildbot/bin/python'} 20:34:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:34:50 INFO - Downloading/unpacking psutil>=3.1.1 20:34: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 20:34: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 20:34: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 20:34: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 20:34: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 20:34: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 20:34:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:34:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:34:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:34:52 INFO - Installing collected packages: psutil 20:34:52 INFO - Running setup.py install for psutil 20:34:52 INFO - building 'psutil._psutil_linux' extension 20:34:52 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 20:34:52 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 20:34:52 INFO - building 'psutil._psutil_posix' extension 20:34:52 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 20:34:52 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 20:34:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:34:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:34:52 INFO - Successfully installed psutil 20:34:52 INFO - Cleaning up... 20:34:52 INFO - Return code: 0 20:34:52 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 20:34: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')]} 20:34:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:34:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:34: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')]} 20:34:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:34:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:34: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2dc413af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1df5850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1df0370>, '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 0x1df38f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1df3d80>, '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': 'a0d2d2de893abaa8702a9954000001a7-1471059225.105527-494328540', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:34: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 20:34: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 mozsystemmonitor==0.3 20:34:52 INFO - Using env: {'DISPLAY': ':0', 20:34:52 INFO - 'HOME': '/home/cltbld', 20:34:52 INFO - 'LANG': 'en_US.UTF-8', 20:34:52 INFO - 'LANGUAGE': 'en_US:en', 20:34:52 INFO - 'LOGNAME': 'cltbld', 20:34:52 INFO - 'MAIL': '/var/mail/cltbld', 20:34:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:34:52 INFO - 'MOZ_NO_REMOTE': '1', 20:34:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:34:52 INFO - 'NO_EM_RESTART': '1', 20:34:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:34:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:34:52 INFO - 'PWD': '/builds/slave/test', 20:34:52 INFO - 'SHELL': '/bin/bash', 20:34:52 INFO - 'SHLVL': '1', 20:34:52 INFO - 'TERM': 'linux', 20:34:52 INFO - 'TMOUT': '86400', 20:34:52 INFO - 'USER': 'cltbld', 20:34:52 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1471059225.105527-494328540', 20:34:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:34:52 INFO - '_': '/tools/buildbot/bin/python'} 20:34:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:34:52 INFO - Downloading/unpacking mozsystemmonitor==0.3 20:34:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:34:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:34:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:34:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:34:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:34:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:34:54 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:34:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:34:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 20:34:54 INFO - Installing collected packages: mozsystemmonitor 20:34:54 INFO - Running setup.py install for mozsystemmonitor 20:34:54 INFO - Successfully installed mozsystemmonitor 20:34:54 INFO - Cleaning up... 20:34:55 INFO - Return code: 0 20:34:55 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 20:34:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:34:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:34:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:34:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:34:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:34:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:34:55 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 0x7f2dc413af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1df5850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1df0370>, '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 0x1df38f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1df3d80>, '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': 'a0d2d2de893abaa8702a9954000001a7-1471059225.105527-494328540', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:34:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 20:34:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 20:34:55 INFO - Using env: {'DISPLAY': ':0', 20:34:55 INFO - 'HOME': '/home/cltbld', 20:34:55 INFO - 'LANG': 'en_US.UTF-8', 20:34:55 INFO - 'LANGUAGE': 'en_US:en', 20:34:55 INFO - 'LOGNAME': 'cltbld', 20:34:55 INFO - 'MAIL': '/var/mail/cltbld', 20:34:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:34:55 INFO - 'MOZ_NO_REMOTE': '1', 20:34:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:34:55 INFO - 'NO_EM_RESTART': '1', 20:34:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:34:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:34:55 INFO - 'PWD': '/builds/slave/test', 20:34:55 INFO - 'SHELL': '/bin/bash', 20:34:55 INFO - 'SHLVL': '1', 20:34:55 INFO - 'TERM': 'linux', 20:34:55 INFO - 'TMOUT': '86400', 20:34:55 INFO - 'USER': 'cltbld', 20:34:55 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1471059225.105527-494328540', 20:34:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:34:55 INFO - '_': '/tools/buildbot/bin/python'} 20:34:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:34:55 INFO - Downloading/unpacking jsonschema==2.5.1 20:34:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:34:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:34:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:34:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:34:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:34:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:34:57 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:34:57 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 20:34:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:34:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:34:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:34:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:34:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:34:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:34:57 INFO - Downloading functools32-3.2.3-2.tar.gz 20:34:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:34:57 INFO - warning: no files found matching '*.txt' 20:34:57 INFO - no previously-included directories found matching 'build' 20:34:57 INFO - no previously-included directories found matching 'dist' 20:34:57 INFO - no previously-included directories found matching '.git*' 20:34:57 INFO - Installing collected packages: jsonschema, functools32 20:34:57 INFO - Running setup.py install for functools32 20:34:57 INFO - warning: no files found matching '*.txt' 20:34:57 INFO - no previously-included directories found matching 'build' 20:34:57 INFO - no previously-included directories found matching 'dist' 20:34:57 INFO - no previously-included directories found matching '.git*' 20:34:57 INFO - Successfully installed jsonschema functools32 20:34:57 INFO - Cleaning up... 20:34:57 INFO - Return code: 0 20:34:57 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 20:34:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:34:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:34:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:34:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:34:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:34:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:34:57 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 0x7f2dc413af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1df5850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1df0370>, '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 0x1df38f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1df3d80>, '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': 'a0d2d2de893abaa8702a9954000001a7-1471059225.105527-494328540', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:34:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 20:34:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 20:34:57 INFO - Using env: {'DISPLAY': ':0', 20:34:57 INFO - 'HOME': '/home/cltbld', 20:34:57 INFO - 'LANG': 'en_US.UTF-8', 20:34:57 INFO - 'LANGUAGE': 'en_US:en', 20:34:57 INFO - 'LOGNAME': 'cltbld', 20:34:57 INFO - 'MAIL': '/var/mail/cltbld', 20:34:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:34:57 INFO - 'MOZ_NO_REMOTE': '1', 20:34:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:34:57 INFO - 'NO_EM_RESTART': '1', 20:34:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:34:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:34:57 INFO - 'PWD': '/builds/slave/test', 20:34:57 INFO - 'SHELL': '/bin/bash', 20:34:57 INFO - 'SHLVL': '1', 20:34:57 INFO - 'TERM': 'linux', 20:34:57 INFO - 'TMOUT': '86400', 20:34:57 INFO - 'USER': 'cltbld', 20:34:57 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1471059225.105527-494328540', 20:34:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:34:57 INFO - '_': '/tools/buildbot/bin/python'} 20:34:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:34:57 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 20:34:57 INFO - Cleaning up... 20:34:57 INFO - Return code: 0 20:34:57 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:34:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:34:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:34:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:34:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:34:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:34:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:34:57 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 0x7f2dc413af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1df5850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1df0370>, '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 0x1df38f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1df3d80>, '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': 'a0d2d2de893abaa8702a9954000001a7-1471059225.105527-494328540', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:34:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 20:34:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 20:34:57 INFO - Using env: {'DISPLAY': ':0', 20:34:57 INFO - 'HOME': '/home/cltbld', 20:34:57 INFO - 'LANG': 'en_US.UTF-8', 20:34:57 INFO - 'LANGUAGE': 'en_US:en', 20:34:57 INFO - 'LOGNAME': 'cltbld', 20:34:57 INFO - 'MAIL': '/var/mail/cltbld', 20:34:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:34:57 INFO - 'MOZ_NO_REMOTE': '1', 20:34:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:34:57 INFO - 'NO_EM_RESTART': '1', 20:34:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:34:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:34:57 INFO - 'PWD': '/builds/slave/test', 20:34:57 INFO - 'SHELL': '/bin/bash', 20:34:57 INFO - 'SHLVL': '1', 20:34:57 INFO - 'TERM': 'linux', 20:34:57 INFO - 'TMOUT': '86400', 20:34:57 INFO - 'USER': 'cltbld', 20:34:57 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1471059225.105527-494328540', 20:34:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:34:57 INFO - '_': '/tools/buildbot/bin/python'} 20:34:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:34:58 INFO - Downloading/unpacking blobuploader==1.2.4 20:34:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:34:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:34:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:34:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:34:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:34:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:34:59 INFO - Downloading blobuploader-1.2.4.tar.gz 20:34:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:34:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:34:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:34:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:34:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:34:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:34:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:34:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:35:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:35:00 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:35:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:35:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:35:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:35:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:35:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:35:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:35:00 INFO - Downloading docopt-0.6.1.tar.gz 20:35:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:35:00 INFO - Installing collected packages: blobuploader, requests, docopt 20:35:00 INFO - Running setup.py install for blobuploader 20:35:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:35:00 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:35:00 INFO - Running setup.py install for requests 20:35:01 INFO - Running setup.py install for docopt 20:35:01 INFO - Successfully installed blobuploader requests docopt 20:35:01 INFO - Cleaning up... 20:35:01 INFO - Return code: 0 20:35:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:35:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:35:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:35:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:35:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:35:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:35:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:35:01 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 0x7f2dc413af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1df5850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1df0370>, '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 0x1df38f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1df3d80>, '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': 'a0d2d2de893abaa8702a9954000001a7-1471059225.105527-494328540', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:35:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 20:35:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 20:35:01 INFO - Using env: {'DISPLAY': ':0', 20:35:01 INFO - 'HOME': '/home/cltbld', 20:35:01 INFO - 'LANG': 'en_US.UTF-8', 20:35:01 INFO - 'LANGUAGE': 'en_US:en', 20:35:01 INFO - 'LOGNAME': 'cltbld', 20:35:01 INFO - 'MAIL': '/var/mail/cltbld', 20:35:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:35:01 INFO - 'MOZ_NO_REMOTE': '1', 20:35:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:35:01 INFO - 'NO_EM_RESTART': '1', 20:35:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:35:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:35:01 INFO - 'PWD': '/builds/slave/test', 20:35:01 INFO - 'SHELL': '/bin/bash', 20:35:01 INFO - 'SHLVL': '1', 20:35:01 INFO - 'TERM': 'linux', 20:35:01 INFO - 'TMOUT': '86400', 20:35:01 INFO - 'USER': 'cltbld', 20:35:01 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1471059225.105527-494328540', 20:35:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:35:01 INFO - '_': '/tools/buildbot/bin/python'} 20:35:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:35:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:35:01 INFO - Running setup.py (path:/tmp/pip-0bGm69-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:35:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:35:01 INFO - Running setup.py (path:/tmp/pip-YgwHfK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:35:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:35:01 INFO - Running setup.py (path:/tmp/pip-5rWLed-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:35:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:35:01 INFO - Running setup.py (path:/tmp/pip-EoovpF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:35:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:35:01 INFO - Running setup.py (path:/tmp/pip-sTzbiQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:35:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:35:02 INFO - Running setup.py (path:/tmp/pip-G6I1Nb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:35:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:35:02 INFO - Running setup.py (path:/tmp/pip-HFIbgx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:35:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:35:02 INFO - Running setup.py (path:/tmp/pip-R7aXYO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:35:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:35:02 INFO - Running setup.py (path:/tmp/pip-dHGETr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:35:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:35:02 INFO - Running setup.py (path:/tmp/pip-vhr9jE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:35:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:35:02 INFO - Running setup.py (path:/tmp/pip-AWpWcg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:35:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:35:02 INFO - Running setup.py (path:/tmp/pip-7MDdx1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:35:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:35:02 INFO - Running setup.py (path:/tmp/pip-NmKI4K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:35:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:35:02 INFO - Running setup.py (path:/tmp/pip-njj6aT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:35:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:35:02 INFO - Running setup.py (path:/tmp/pip-_0Z1Sp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:35:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:35:02 INFO - Running setup.py (path:/tmp/pip-rvBjEU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:35:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:35:02 INFO - Running setup.py (path:/tmp/pip-hMWqq7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:35:02 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:35:02 INFO - Running setup.py install for manifestparser 20:35:02 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:35:03 INFO - Running setup.py install for mozcrash 20:35:03 INFO - Running setup.py install for mozdebug 20:35:03 INFO - Running setup.py install for mozdevice 20:35:03 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:35:03 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:35:03 INFO - Running setup.py install for mozfile 20:35:03 INFO - Running setup.py install for mozhttpd 20:35:03 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:35:03 INFO - Running setup.py install for mozinfo 20:35:03 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:35:03 INFO - Running setup.py install for mozInstall 20:35:03 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:35:03 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:35:03 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:35:03 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:35:03 INFO - Running setup.py install for mozleak 20:35:03 INFO - Running setup.py install for mozlog 20:35:03 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:35:03 INFO - Running setup.py install for moznetwork 20:35:04 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:35:04 INFO - Running setup.py install for mozprocess 20:35:04 INFO - Running setup.py install for mozprofile 20:35:04 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:35:04 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:35:04 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:35:04 INFO - Running setup.py install for mozrunner 20:35:04 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:35:04 INFO - Running setup.py install for mozscreenshot 20:35:04 INFO - Running setup.py install for moztest 20:35:04 INFO - Running setup.py install for mozversion 20:35:04 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:35:04 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:35:04 INFO - Cleaning up... 20:35:04 INFO - Return code: 0 20:35:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:35:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:35:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:35:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:35:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:35:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:35:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:35:04 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 0x7f2dc413af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1df5850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1df0370>, '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 0x1df38f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1df3d80>, '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': 'a0d2d2de893abaa8702a9954000001a7-1471059225.105527-494328540', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:35:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 20:35:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 20:35:04 INFO - Using env: {'DISPLAY': ':0', 20:35:04 INFO - 'HOME': '/home/cltbld', 20:35:04 INFO - 'LANG': 'en_US.UTF-8', 20:35:04 INFO - 'LANGUAGE': 'en_US:en', 20:35:04 INFO - 'LOGNAME': 'cltbld', 20:35:04 INFO - 'MAIL': '/var/mail/cltbld', 20:35:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:35:04 INFO - 'MOZ_NO_REMOTE': '1', 20:35:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:35:04 INFO - 'NO_EM_RESTART': '1', 20:35:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:35:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:35:04 INFO - 'PWD': '/builds/slave/test', 20:35:04 INFO - 'SHELL': '/bin/bash', 20:35:04 INFO - 'SHLVL': '1', 20:35:04 INFO - 'TERM': 'linux', 20:35:04 INFO - 'TMOUT': '86400', 20:35:04 INFO - 'USER': 'cltbld', 20:35:04 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1471059225.105527-494328540', 20:35:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:35:04 INFO - '_': '/tools/buildbot/bin/python'} 20:35:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:35:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:35:04 INFO - Running setup.py (path:/tmp/pip-uYz48k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:35:05 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 20:35:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:35:05 INFO - Running setup.py (path:/tmp/pip-Z_C6XD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:35:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 20:35:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:35:05 INFO - Running setup.py (path:/tmp/pip-Md1xqE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:35:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 20:35:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:35:05 INFO - Running setup.py (path:/tmp/pip-7wcKk5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:35:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 20:35:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:35:05 INFO - Running setup.py (path:/tmp/pip-QFYHDe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:35:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 20:35:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:35:05 INFO - Running setup.py (path:/tmp/pip-GP5THd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:35:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 20:35:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:35:05 INFO - Running setup.py (path:/tmp/pip-vL0Bqx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:35:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 20:35:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:35:05 INFO - Running setup.py (path:/tmp/pip-wPTFtX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:35:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 20:35:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:35:05 INFO - Running setup.py (path:/tmp/pip-sE9ZYp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:35:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 20:35:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:35:05 INFO - Running setup.py (path:/tmp/pip-ODjBrw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:35:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:35:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:35:05 INFO - Running setup.py (path:/tmp/pip-xXBJv9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:35:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 20:35:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:35:05 INFO - Running setup.py (path:/tmp/pip-3BcsFF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:35:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 20:35:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:35:05 INFO - Running setup.py (path:/tmp/pip-yuOlFz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:35:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 20:35:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:35:05 INFO - Running setup.py (path:/tmp/pip-f8VDKC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:35:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 20:35:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:35:05 INFO - Running setup.py (path:/tmp/pip-Hdvcur-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:35:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 20:35:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:35:06 INFO - Running setup.py (path:/tmp/pip-Aabhdm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:35:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 20:35:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:35:06 INFO - Running setup.py (path:/tmp/pip-EAlVnx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:35:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 20:35:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 20:35:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 20:35:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 20:35:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 20:35:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 20:35:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:35:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:35:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:35:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:35:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:35:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:35:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:35:08 INFO - Downloading blessings-1.6.tar.gz 20:35:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:35:08 INFO - Installing collected packages: blessings 20:35:08 INFO - Running setup.py install for blessings 20:35:08 INFO - Successfully installed blessings 20:35:08 INFO - Cleaning up... 20:35:08 INFO - Return code: 0 20:35:08 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:35:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:35:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:35:08 INFO - Reading from file tmpfile_stdout 20:35:08 INFO - Current package versions: 20:35:08 INFO - argparse == 1.2.1 20:35:08 INFO - blessings == 1.6 20:35:08 INFO - blobuploader == 1.2.4 20:35:08 INFO - docopt == 0.6.1 20:35:08 INFO - functools32 == 3.2.3-2 20:35:08 INFO - jsonschema == 2.5.1 20:35:08 INFO - manifestparser == 1.1 20:35:08 INFO - mozInstall == 1.12 20:35:08 INFO - mozcrash == 0.17 20:35:08 INFO - mozdebug == 0.1 20:35:08 INFO - mozdevice == 0.48 20:35:08 INFO - mozfile == 1.2 20:35:08 INFO - mozhttpd == 0.7 20:35:08 INFO - mozinfo == 0.9 20:35:08 INFO - mozleak == 0.1 20:35:08 INFO - mozlog == 3.3 20:35:08 INFO - moznetwork == 0.27 20:35:08 INFO - mozprocess == 0.23 20:35:08 INFO - mozprofile == 0.28 20:35:08 INFO - mozrunner == 6.12 20:35:08 INFO - mozscreenshot == 0.1 20:35:08 INFO - mozsystemmonitor == 0.3 20:35:08 INFO - moztest == 0.7 20:35:08 INFO - mozversion == 1.4 20:35:08 INFO - psutil == 3.1.1 20:35:08 INFO - requests == 1.2.3 20:35:08 INFO - wsgiref == 0.1.2 20:35:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:35:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:35:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:35:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:35:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:35:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:35:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:35:08 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 0x7f2dc413af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1df5850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1df0370>, '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 0x1df38f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1df3d80>, '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': 'a0d2d2de893abaa8702a9954000001a7-1471059225.105527-494328540', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:35:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 20:35:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 20:35:08 INFO - Using env: {'DISPLAY': ':0', 20:35:08 INFO - 'HOME': '/home/cltbld', 20:35:08 INFO - 'LANG': 'en_US.UTF-8', 20:35:08 INFO - 'LANGUAGE': 'en_US:en', 20:35:08 INFO - 'LOGNAME': 'cltbld', 20:35:08 INFO - 'MAIL': '/var/mail/cltbld', 20:35:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:35:08 INFO - 'MOZ_NO_REMOTE': '1', 20:35:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:35:08 INFO - 'NO_EM_RESTART': '1', 20:35:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:35:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:35:08 INFO - 'PWD': '/builds/slave/test', 20:35:08 INFO - 'SHELL': '/bin/bash', 20:35:08 INFO - 'SHLVL': '1', 20:35:08 INFO - 'TERM': 'linux', 20:35:08 INFO - 'TMOUT': '86400', 20:35:08 INFO - 'USER': 'cltbld', 20:35:08 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1471059225.105527-494328540', 20:35:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:35:08 INFO - '_': '/tools/buildbot/bin/python'} 20:35:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:35:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 20:35:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 20:35:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 20:35:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 20:35:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 20:35:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 20:35:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 20:35:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 20:35:08 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 20:35:08 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 20:35:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 20:35:08 INFO - Cleaning up... 20:35:08 INFO - Return code: 0 20:35:08 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:35:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:35:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:35:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:35:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:35:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:35:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:35:08 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 0x7f2dc413af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1df5850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1df0370>, '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 0x1df38f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1df3d80>, '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': 'a0d2d2de893abaa8702a9954000001a7-1471059225.105527-494328540', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:35:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 20:35:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 20:35:08 INFO - Using env: {'DISPLAY': ':0', 20:35:08 INFO - 'HOME': '/home/cltbld', 20:35:08 INFO - 'LANG': 'en_US.UTF-8', 20:35:08 INFO - 'LANGUAGE': 'en_US:en', 20:35:08 INFO - 'LOGNAME': 'cltbld', 20:35:08 INFO - 'MAIL': '/var/mail/cltbld', 20:35:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:35:08 INFO - 'MOZ_NO_REMOTE': '1', 20:35:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:35:08 INFO - 'NO_EM_RESTART': '1', 20:35:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:35:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:35:08 INFO - 'PWD': '/builds/slave/test', 20:35:08 INFO - 'SHELL': '/bin/bash', 20:35:08 INFO - 'SHLVL': '1', 20:35:08 INFO - 'TERM': 'linux', 20:35:08 INFO - 'TMOUT': '86400', 20:35:08 INFO - 'USER': 'cltbld', 20:35:08 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1471059225.105527-494328540', 20:35:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:35:08 INFO - '_': '/tools/buildbot/bin/python'} 20:35:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:35:08 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 20:35:08 INFO - Cleaning up... 20:35:08 INFO - Return code: 0 20:35:08 INFO - Running post-action listener: _resource_record_post_action 20:35:08 INFO - Running post-action listener: _start_resource_monitoring 20:35:08 INFO - Starting resource monitoring. 20:35:08 INFO - [mozharness: 2016-08-13 03:35:08.957647Z] Finished create-virtualenv step (success) 20:35:08 INFO - [mozharness: 2016-08-13 03:35:08.958109Z] Running install step. 20:35:08 INFO - Running pre-action listener: _resource_record_pre_action 20:35:08 INFO - Running main action method: install 20:35:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:35:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:35:09 INFO - Reading from file tmpfile_stdout 20:35:09 INFO - Detecting whether we're running mozinstall >=1.0... 20:35:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:35:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:35:09 INFO - Reading from file tmpfile_stdout 20:35:09 INFO - Output received: 20:35:09 INFO - Usage: mozinstall [options] installer 20:35:09 INFO - Options: 20:35:09 INFO - -h, --help show this help message and exit 20:35:09 INFO - -d DEST, --destination=DEST 20:35:09 INFO - Directory to install application into. [default: 20:35:09 INFO - "/builds/slave/test"] 20:35:09 INFO - --app=APP Application being installed. [default: firefox] 20:35:09 INFO - mkdir: /builds/slave/test/build/application 20:35:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 20:35:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 20:35:26 INFO - Reading from file tmpfile_stdout 20:35:26 INFO - Output received: 20:35:26 INFO - /builds/slave/test/build/application/firefox/firefox 20:35:26 INFO - Running post-action listener: _resource_record_post_action 20:35:26 INFO - [mozharness: 2016-08-13 03:35:26.170629Z] Finished install step (success) 20:35:26 INFO - [mozharness: 2016-08-13 03:35:26.170877Z] Running run-tests step. 20:35:26 INFO - Running pre-action listener: _resource_record_pre_action 20:35:26 INFO - Running main action method: run_tests 20:35:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:35:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:35:26 INFO - Python 2.7.3 20:35:26 INFO - Return code: 0 20:35:26 INFO - grabbing minidump binary from tooltool 20:35:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:35:26 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 0x1df0370>, '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 0x1df38f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1df3d80>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:35:26 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 20:35:26 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 20:35:26 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 20:35:26 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:35:26 INFO - Return code: 0 20:35:26 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 20:35:26 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:35:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:35:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 20:35:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:35:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dEUXn0EdTxmP3attTspuxA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-002', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 20:35:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/dEUXn0EdTxmP3attTspuxA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-002 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 20:35:26 INFO - Using env: {'DISPLAY': ':0', 20:35:26 INFO - 'HOME': '/home/cltbld', 20:35:26 INFO - 'LANG': 'en_US.UTF-8', 20:35:26 INFO - 'LANGUAGE': 'en_US:en', 20:35:26 INFO - 'LOGNAME': 'cltbld', 20:35:26 INFO - 'MAIL': '/var/mail/cltbld', 20:35:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:35:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 20:35:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:35:26 INFO - 'MOZ_NO_REMOTE': '1', 20:35:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:35:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:35:26 INFO - 'NO_EM_RESTART': '1', 20:35:26 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:35:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:35:26 INFO - 'PWD': '/builds/slave/test', 20:35:26 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:35:26 INFO - 'SHELL': '/bin/bash', 20:35:26 INFO - 'SHLVL': '1', 20:35:26 INFO - 'TERM': 'linux', 20:35:26 INFO - 'TMOUT': '86400', 20:35:26 INFO - 'USER': 'cltbld', 20:35:26 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1471059225.105527-494328540', 20:35:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:35:26 INFO - '_': '/tools/buildbot/bin/python'} 20:35:26 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dEUXn0EdTxmP3attTspuxA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-002', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 20:35:26 INFO - mozversion application_buildid: 20160812173001 20:35:26 INFO - mozversion application_changeset: 1ba6215e84c3b34b928898331c3d444b3dd96ee3 20:35:26 INFO - mozversion application_display_name: Nightly 20:35:26 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:35:26 INFO - mozversion application_name: Firefox 20:35:26 INFO - mozversion application_remotingname: firefox 20:35:26 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 20:35:26 INFO - mozversion application_vendor: Mozilla 20:35:26 INFO - mozversion application_version: 51.0a1 20:35:26 INFO - mozversion platform_buildid: 20160812173001 20:35:26 INFO - mozversion platform_changeset: 1ba6215e84c3b34b928898331c3d444b3dd96ee3 20:35:26 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 20:35:26 INFO - mozversion platform_version: 51.0a1 20:35:26 INFO - using testdate: 1471059326 20:35:26 INFO - actual date: 1471059326 20:35:26 INFO - starting webserver on 'localhost:54224' 20:35:26 INFO - SUITE-START | Running 2 tests 20:35:26 INFO - TEST-START | dromaeo_css 20:35:26 INFO - operating with platform_type : linux_ 20:35:26 INFO - Initialising browser for dromaeo_css test... 20:35:26 INFO - TEST-INFO | started process 14797 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJeEEDK/profile http://localhost:54224/getInfo.html) 20:35:30 INFO - PROCESS | 14797 | __metrics Screen width/height:1600/1200 20:35:30 INFO - PROCESS | 14797 | colorDepth:24 20:35:30 INFO - PROCESS | 14797 | Browser inner width/height: 1024/697 20:35:30 INFO - PROCESS | 14797 | __metrics 20:35:31 ERROR - PROCESS | 14797 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2983: TypeError: this.tabs is undefined 20:35:32 INFO - TEST-INFO | 14797: exit 0 20:35:32 INFO - Browser initialized. 20:35:32 INFO - Running cycle 1/1 for dromaeo_css test... 20:35:32 INFO - TEST-INFO | started process 14919 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJeEEDK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:35:44 INFO - PROCESS | 14919 | RSS: Main: 163299328 20:35:44 INFO - PROCESS | 14919 | 20:36:33 INFO - PROCESS | 14919 | 1471059393882 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 20:38:43 INFO - PROCESS | 14919 | Cycle 1(1): loaded http://localhost:54224/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54224/tests/dromaeo/cssquery-ext.html) 20:38:44 INFO - PROCESS | 14919 | RSS: Main: 164773888 20:38:44 INFO - PROCESS | 14919 | 20:41:46 INFO - PROCESS | 14919 | Cycle 1(1): loaded http://localhost:54224/tests/dromaeo/cssquery-ext.html (next: http://localhost:54224/tests/dromaeo/cssquery-jquery.html) 20:41:47 INFO - PROCESS | 14919 | RSS: Main: 165830656 20:41:47 INFO - PROCESS | 14919 | 20:44:49 INFO - PROCESS | 14919 | Cycle 1(1): loaded http://localhost:54224/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54224/tests/dromaeo/cssquery-mootools.html) 20:44:50 INFO - PROCESS | 14919 | RSS: Main: 166457344 20:44:50 INFO - PROCESS | 14919 | 20:47:51 INFO - PROCESS | 14919 | Cycle 1(1): loaded http://localhost:54224/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54224/tests/dromaeo/cssquery-prototype.html) 20:47:52 INFO - PROCESS | 14919 | RSS: Main: 163889152 20:47:52 INFO - PROCESS | 14919 | 20:50:54 INFO - PROCESS | 14919 | Cycle 1(1): loaded http://localhost:54224/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54224/tests/dromaeo/cssquery-yui.html) 20:50:55 INFO - PROCESS | 14919 | RSS: Main: 165994496 20:50:55 INFO - PROCESS | 14919 | 20:53:58 INFO - PROCESS | 14919 | Cycle 1(1): loaded http://localhost:54224/tests/dromaeo/cssquery-yui.html (next: http://localhost:54224/tests/dromaeo/cssquery-dojo.html) 20:53:58 INFO - PROCESS | 14919 | RSS: Main: 166981632 20:53:58 INFO - PROCESS | 14919 | 20:53:58 INFO - PROCESS | 14919 | __start_tp_report 20:53:58 INFO - PROCESS | 14919 | _x_x_mozilla_page_load 20:53:58 INFO - PROCESS | 14919 | _x_x_mozilla_page_load_details 20:53:58 INFO - PROCESS | 14919 | |i|pagename|runs| 20:53:58 INFO - PROCESS | 14919 | |0;dojo.html;3117.049299963511;3140.528920661902;3144.544041114038;3158.873645054198;3162.873485060598;5406.91889621656;5439.347278326602;5479.917801232985;5530.419305972875;5559.082751346034;5441.129419292914;5503.889922201553;5531.585131115163;5539.972300138504;5545.417731138223;4916.877078073059;4998.375203099613;5031.496850314958;5059.848204553869;5120.590352771769;5077.441481437039;5101.260317253996;5120.615953803461;5145.30538377318;5145.511176438233;4910.582600478963;4957.132501812169;5041.067402530525;5091.439941606421;5109.770060347293;4958.925616115761;5031.169856973595;5045.117104506733;5071.315372424712;5097.821576244851;4953.653244272902;4997.85006449807;5003.099442100421;5011.498850114996;5026.170681837492;5376.91934620981;5429.8099566515375;5514.724263786835;5542.279503664538;5564.749586268627;5844.590878638497;5942.346341902387;5948.97025514874;5972.432618901197;5974.97012514939;5973.432523910222;5974.940250597482;5978.192943952554;5979.133025711291;5979.5515336349945;5410.296661434067;5473.67157970523;5559.19391688207;5564.33228012641;5578.497935185853;6039.1545183674325;6115.876089542891;6121.755129794848;6122.295935967331;6125.050617154348;5824.912626310609;5866.914620795166;5867.471927526543;5867.61860479076;5873.676947767914;5750.648597579566;5824.271966004249;5876.500497457679;5900.852478688067;5922.2597175353085;5824.330202026821;5925.4370834770625;5933.288005439289;5975.133605627159;5978.491828194565;5856.736446859902;5890.175375447441;5916.319623243382;5950.940490595125;5951;4426.1369033038245;4470.508244093147;4512.984578469818;4543.341215523797;4580.175568397721;3985.501812273466;4014.277430062617;4042.777647229431;4050.4936882889638;4055.513338399411;5667.064934285879;5688.175214593861;5690.715464226855;5720.141978703145;5724.856878578069;5852.063669812895;5902.675352855634;5973.253343332083;5986.341502434729;5991.7603295867675;5561.777528898799;5660.15097735343;5666.320041595035;5683.8863222736145;5710.172025056344;5039.244113383022;5070.923936140887;5085.211792172219;5085.821996230115;5125.359330083739;5986.940130598726;6067.211262535842;6092.908606370908;6143.262808463013;6159.630422174594;5931.495822855106;6013.579049466495;6014.759409623741;6062.939370606237;6067.878642427215;6153.815385538441;6160.353162918008;6160.507159427325;6167.167432396748;6169.383061693974;5697.515711164598;5740.39725828782;5862.325832529314;5879.5002424794375;5892.558058145742;5907.468327850343;5961.642301461926;5998.850028749316;6003.489703375262;6043.969780151071;5810.099434587646;5828.184054232326;5847.38602446737;5854.414558544111;5864.912026319694;5543.279373681396;5702.059160238514;5760.942390576208;5818.010938140442;5826.126081087871;5721.22763426932;5722.62802917809;5754.539636829128;5777.24895763548;5797.91303130445;5772.2207501986695;5853.239078919713;5855.03391940325;5860.970695146668;5865.384134665798;5551.111822108443;5597.608167428241;5603.551715862803;5670.659760414388;5725.656460612377 20:53:58 INFO - PROCESS | 14919 | |1;ext.html;549.4478296810728;584.126730537846;599.9650602710325;611.8011646214982;619.1270308864501;39402.01494962624;43088.569114308884;43129.35305970413;43254.56745432545;43255.134897302036;42263;42484.36273455901;42722;42724.78637606808;42826.57173428265;8739.4756314621;8904.73285801427;8923.330750193729;8931.866022009675;8960.64157433705;8773.56132193391;8775.25410340122;8791.868121978176;8848.98236702781;8855.5572221389;8850.336224783136;8877.68928087517;8934.597943092544;8940.8658870117;8964.05877382872;8865;8879.156480134408;8889;8900.243479304267;8930.642774289021;8808.339374546871;8840.646374145026;8870.73387798367;8909.287257019423;8914.554272286425;40482;40564.39153412701;40885;40914.9771255718;40925.59074409248;2684.516786978343;3301.2036158417773;3474.114100904253;3548.7870727756417;3606.386914224588;31475.842620786978;31800;31913.361732765447;32077.358452830813;33455.498167527505;4185.518665353462;4198.412222288882;4216.156768646283;4242.787860606957;4261.573842615745;313103;315804;316824;316878;319519;35347;35551.11122221914;35598.82200588981;35600;35715.82142089325;36815.0796230091;37205.62794372022;37766.811165944;39361.60638393636;39445.80277098596;16838.83161168397;16901.915490422714;17067;17069.31722731077;17129.22918468672;13120.934395327962;13127.081104322606;13149.342532873317;13155.934220328838;13167.012474064484;19062.61874762497;19148.425547233604;19150.233990640496;19197.424077277705;19232.326868559532;6881.277465866112;6974.755883544051;7103.218645948941;7333.2666733327305;7367.668454919542;925.509479975614;1062.4793851013103;1067.1196263082988;1106.6016234155697;1134.6085600467825;32599.18502037468;32865.342693146005;33396.66603333935;33487.33025339479;33691.15772105668;1056.4295280548572;1145.0496088246734;1185.543565727184;1215.1554669504785;1216.3796463803524;16516.17419129039;16653.750193747102;16998.235079421454;17303.82696173022;17684.993551096086;543049;881019;897873;900415;900759;60924.69537652372;60997.39002610006;61391.38608613946;61463.385366146664;61585.69207153936;1358.4634069542674;1389.4789453954768;1399.5871217990716;1400.1216629935022;1407.0713329202677;31466.528002080446;33719.15702107467;33834.83082584571;34041.65958340484;34240.31519369549;50365.74817126038;50726;50821.49178508168;50879;50984.23523647074;461768;461804;468066;468608;470084;28903.85548072246;29111.85444072766;29132.126036218946;29387.265318367212;29576.408471830873;47416.52583474121;48062.759686201345;48407.51592484171;48946.51053489562;49094.26358604695;38757.612423876526;39110.804445977585;41380.238983423296;41426.585734143475;43233.13533729371;40641.59358406378;41687.16625667409;41731.37402938898;42697.78651106849;43251.35122973095;41552.37671434991;42810;43835.561644383146;43848.780756096014;43867;34020.65979340175;36900.81549592342;37444.81277593595;38929.80535097307;39131;27731.44537109287;29505;29700.40599187961;29718.554221687125;29988.250293742833 20:53:58 INFO - PROCESS | 14919 | |2;jquery.html;391.5751409720453;394.77892380267036;396.80953142491614;399.49862922032844;431.0258815077925;13114.344282785847;18407.72388414175;19387.903060484714;20001.099950502226;20100.69848952267;19061.809381906176;19261.711074333896;19607.01964901753;19686.21255149796;20034.899825500852;5753.913691294634;5801.53587712982;5933.288005439354;6076.240469941257;6127.601705889125;6151.969240153815;6159.846003849895;6160.19917410736;6162.322144564117;6167.876642467148;6199.163112979735;6735.831604209885;6750.189977202743;6758.9662051689675;6768.8307792305095;5648.124540696199;5907.822765317047;6743.325667433266;6783.660816959157;6814.250432452451;5792.4497172768515;5826.067829147359;5839.708014599296;5856.824295271149;5859.062549992023;14508.27458627075;22203;23019;23153.53692926132;23171;2258.728952525691;2331.2423462374795;2660.813743037988;2726.05950946925;2801.6357873476522;10318.742031449274;10646.893531064668;10652.680419587425;10858.72853178669;10983;1910.512819231101;1933.8646294759371;1947.5617985953188;1982.1080513768861;2038.398672391648;83543.58228208881;84151.57924210401;85189;85634.14365856323;86855.56572217098;11243.494042768096;11276.887231127748;11619;11715.707107322385;11871;16025.234069993543;16092.517224483285;16104.355825766837;16128;16156.434524791575;8314.833703326021;8497.787555311043;8503.787405314793;8518.105598912149;8741.169588889044;7998.12020677725;8001.799955001172;8018.55897925608;8234.094249632535;8307.293880020145;4578.45058592971;4651.651126165551;4860.392450943632;4867.780949857265;4982.202847544376;1786.2319202742685;1928.3829174664254;1953.9413817585496;1954.5699946011855;1980.5147738803796;883.4831623500324;991.0881988570533;1017.7455636090978;1028.5885645741614;1057.619257067455;19179;19997.300094496914;20066;20238.49403764888;20290.69563956542;965.5124162298135;1009.3842755918884;1012.4026824173773;1022.6114076650974;1051.5530899367739;9262.629494820132;11017.944910275397;11234.438278086227;11326.377049262204;11328;466657;470061;470630;472202;473132;88056;92050;93964;94516.52741736248;95065.52467237758;968.6803354892868;1003.5684655598017;1032.385730490357;1036.7667274863095;1042.7341028037954;17232;17393.043382614076;17712.70288851461;18063.909680452038;18163.45509634713;43843.78078109589;44568.77715611401;44973;45338.546614533436;45695.314570282135;57589.42410575841;57983.420165797805;58386.4161358398;58766.11850822327;59448;8456.40805143634;8560.229579337889;8595.914040859512;8656.740297791077;8693.434926729742;12347.938260308641;12749.426275817796;12954.157979731288;13215.339233038118;13400;10947.50736216888;11425.771484570096;11479.598214062802;11664.533418663497;12337.691557711129;10898.106887579463;11397.487113080097;11433.59982400612;11442.713932151762;11496.425178741198;11257.774844502901;11497.367644779617;11676.124290678403;11870.347130907883;12203.14577979533;8429.283510901396;8691.956540217512;8847.380683352103;8858.822823543363;9046.321525885453;8948.73153805361;10400.843987340044;10449.843252351373;10897.891021089688;11212.49543770516 20:53:58 INFO - PROCESS | 14919 | |3;mootools.html;1497.2588568658512;1528.0144306922034;1669.9960047942473;1733.5232810976988;1799.0285245967186;7935.166807485218;8485.53329566875;8613.353998450119;9218.677346292881;9222.723318300454;8642.870356944652;8905.688300909469;8970.686025989091;8979.506127163004;8984.416012959153;2375.418022584465;2422.9757702423017;2426.708794944609;2428.1501474483875;2429.4776623026046;2249.583826992012;2255.4925141843037;2315.143396943133;2315.6758053872472;2319.060780383947;2405.795507381875;2410.2528216253017;2426.5268272686835;2432.1001229545095;2441.426264827764;2348.56551537966;2368.59733845245;2374.050379848057;2388.164142550111;2409.6265078912797;2233.530958498717;2244.5062086340977;2247.505548779266;2249.2127755285683;2249.302716157996;8886;8888.200061994386;8891.199792018684;8905.465672059698;8970.551472426418;5206.349206349207;5330.307060082165;5374.328208973879;5381.408045115034;5436.483534064258;3206.567113439679;3386.762926595139;3393.8133402662843;3427.845746941394;3477.51314815926;1149.1898211760688;1162;1175.4534141624101;1185.8043422835221;1190.9876604885865;12519.687007824787;12588.81116783249;12601.11792174539;12602.68493287666;12640.49438022478;4472.396226509444;4640.907181856344;4755.714657120584;4823.517648235219;4832.830850920201;10495;10501.422421766876;10551.630692925712;10575.735606609896;10583.470826458646;5428.37573679032;5430.70131142791;5468.26178465902;5477.835664930059;5485.780568777284;4331.480222373335;4712.151812673752;4802.759862006886;4822.180229361017;5006.998600279959;3927.136030073379;4048.4332193492933;4140.399642051885;4147.647449966787;4149.502059752849;1253.404632799413;1267.866873978219;1270.5807083662369;1274.0571976737149;1278.9552365667157;958.4488918871676;971.155095067296;1002.3434650304063;1006.597361055569;1015.7511409704522;6041.456268935729;6102.847428814315;6104.4200800923845;6135;6194.194754681863;476.9689970151929;482.87445264231553;484.2590836020894;494.75509622736257;499.2486308106277;4156.127213285184;4194.328907374806;4259.254630439661;4357.803898824497;4382.255016647177;10702.357858528514;11128.221024528206;11197.49611267495;11202.719932001764;11215.102791776639;11016.944915275373;11070.391128487849;11096.278741881913;11105.666829995112;11113.83329250062;7831.216878312123;7989.320907722792;8137.308328792119;8168.2240187183315;8195.385346099067;6008.789692360747;6098.786542470993;6246.5002799775;6260.655663938527;6432.35676432353;10240.53917573696;10453.9477302613;10538.894611054098;10635;10636.84044739345;10412.114970227616;10521.631742889269;10624.20318476102;10629.840552391875;10651.840222396826;7222;7560;7738.7678369649;7973.601319934096;8119.918800811916;8794.20852123312;8883.466991980502;8884.60019299146;8886.688965886164;8947;7908.644111015134;8003.31971782405;8099.554524501209;8213.87557913915;8281.917180828115;7748.34139098183;7878.094019187637;7891.131975482807;7917.010373703287;7944.404169687181;7097.574145551283;7201.207867134506;7259.854802904018;7261.564306141649;7269.200387957215;5242.580593552583;5340.465953404784;5356.1697936819855;5356.250124982427;5378.97310513445;5383.1117865553315;5414.972925135349;5446.618736688394;5504.504594586507;5596.272484576979 20:53:58 INFO - PROCESS | 14919 | |4;prototype.html;336.22420220919076;337.36070147071297;345.95329630499873;351.8539805980518;354.0793935767006;5332.773462103719;5418.241446197536;5433.91849122263;5536.169574563813;5546.500814926656;5471.616986810925;5474.534664553507;5529.281193444846;5534.948359811643;5548.250986116873;4292.463442069741;4296.419983302261;4319.82720691172;4344.652427805784;4365.847195348163;4189.183109293689;4293.205756934962;4307.978460107695;4340;4362.803673834669;4260.893477663052;4265.189613973335;4271.103068355649;4279.03721662625;4302.290122129845;4255.6169944705125;4302.849400270991;4309.806058727349;4313.439252897103;4315.82736690532;3658.2500587379523;3789.2989796887387;3812.4471951567143;3812.752171108869;3817.4464702618243;5366.248725178478;5369.382521010056;5371.140617501181;5418.376886658006;5426.321709786277;4892.290617860391;4907.214845624683;4912.189488734354;4924.335214745999;4926.605871530269;5568.1091025435735;5708.457696518824;5718.59969802114;5764.74058667361;5794.88410231793;4102.897427564305;4119.464469618961;4123.752574845519;4128.256913755523;4141.544430112685;6063.998320831172;6068.939310606882;6073.848153796146;6080.726367313481;6093.238345206849;4073.674106071507;4252.149570085995;4256.446661933991;4271.252530807096;4277.871663850089;4276.465441819772;4282.80727367263;4291.163223171452;4292.098659281523;4303.33298338758;4916.861165392994;4927.43334516528;4935.90128197434;4937;4972.303877457159;5701.258836351248;5821.544613846539;5861.6189947653265;5866.2960444746905;5882.529397648178;1455.4178328668618;1478.2313197137428;1478.8521147885126;1479.5561331600693;1484.7327481053298;959.2469911119738;966.4394651102484;992.4045572656348;1000.6097621927454;1008.4100801031332;4883.951160488421;4903.26451032348;4905.492572810386;4930.077269864755;4961.603071754251;5237.371515418175;5277.340332458442;5278.656887302313;5301.356579460379;5309.973450132802;4610.893385587435;4879.731614761222;4907.3620429343955;4940.728259945666;4997.400311962515;2665.200439868032;2748.6151938728194;2749.5188342040465;2759.351552385188;2776.680681721628;5355.384130825005;5367.087595108841;5380.300560927054;5403.513683768401;5406;5081.83117882889;5229.398619158846;5243.580513558906;5266.7629956652045;5296.788128474895;5276.65701729394;5278.076336641149;5299;5303.655262407931;5307.840764777063;5154.407243167084;5179.8446046618665;5192.948070519397;5199.064168449564;5212.270282160576;4871;5067.645264831426;5081.5426611605135;5083.542481176712;5104.438511763778;5281.260623512788;5308.46915308466;5311.760970756248;5335.2263921730355;5383.542398895981;3908.9804550977065;4063.146739184804;4212.810423530887;4284.935725964051;4342.088161485997;5832.24180856486;5838.795642152504;5868.559858010752;5874.911876321773;5884.764609415746;5530.207245341077;5622.184783206494;5659.236607655863;5686.516646085129;5690.544756419559;5640.379558248672;5668.489835914787;5686.090225564056;5693.800716974886;5701.629394089371;5598;5616.943830561642;5660.207570940154;5671.682065991441;5694.629849059798;5485.807996720096;5746;5761.107028410603;5782.826515204551;5829.795957141479;5618.52242559387;5645.322561292507;5650.57620678459;5658.321001479849;5664.575156863334 20:53:58 INFO - PROCESS | 14919 | |5;yui.html;733.1092722342353;749.6139488163595;759.2710997442455;772.2586317135549;810.7324582887647;16577.171141442926;17542.12289385532;17576.209070591838;17588.999999999985;17597.296108155657;15707.450239241629;15870.285837137328;15871.682566348665;15871.84128158718;15889.205539723025;652.8237375908502;779.7543773711262;779.7582749347692;791.5092642561591;793.3811626931004;798.3333916179997;799.2407213147504;801.4429971170039;802.430274505102;802.9638666260004;845.3110714767445;852.5140669818206;853.9658413663446;854.6752234151014;854.747849384433;848.855694531931;849.0702680564772;849.5412477262271;849.583703985046;849.6219182463775;617.0713076819403;619.9008158694587;620.5035971223003;620.8106527509108;621.1583304622262;15737;15787.92106039474;15801.683966320725;15836;15845.207739612973;13322.933385333012;14156.646083847883;14292.071015383966;15975.520734377988;15984.360625574964;13288.468461261538;13452;13718.588442346645;13887.722245555033;14049.157050576998;4523.321501774727;4548.2495388260895;4574.977125114387;4634.265783187901;4656.743879086649;86965.56517217374;87309;87391.56304218502;89738;89845.55077224573;11279.605213817642;11674.299542027506;11737.765244695058;12076.396180190955;12433.502659893684;21571.892140539512;21785.346439606838;21869.12523499074;21872.12511499554;21936;8284.378671599654;8438.198371154731;8443.915560844312;8477.830443391098;8478.74563763088;4835.129676658235;4981.227909674007;4986.376702912136;5069.746512674352;5138.049460849755;3710.220853620716;3775.5091838061426;3807.923841523154;3827.7129215308964;3847.826847791856;646.8447572582546;648.6821457485893;651.3519048546726;662.0730976632752;670.7954074007474;553.3802141601432;597.8116893178635;598.9580729348904;631.8072987738692;673.9452756436161;9460.8785243011;9599.664011759554;9671.564779584936;9709.223262139012;9947.751306217402;660.9669516524154;686.4062585863193;698.1099098649263;699.0807088678372;704.17259719829;4032.5765794591143;4049.2913740095955;4331.848385306562;4433.312836510346;4573.47405048417;114528;126178.36910815387;126375;131238;132367.0289891305;59837.70081149566;60956.39043609596;64018.67990660017;87421;105660.47169764101;100384;100562;100980.49509752404;103237;103774;8262.967129108862;8400.663973441238;8502.74491765248;8648.610812513327;8757.518336491554;41442.58557414387;56062.71968640131;56355;58026.129608056755;58178.7091064542;77639;80208;82320.58839706003;83599.5820020896;83935;11580;11736.413179341169;11798.823017654913;11819.763604728028;11996.100292477924;13245.27151006704;13267.734645306848;13378.331083445983;13426.098727461873;13894.722105558034;12123.454444550192;12345.197562158432;12499.187552809039;12555.87444125547;12613.864752172349;12311.322877241837;12539.435725392561;13054.08621396493;13082.869171308546;13266.071375003658;12284.815727763911;12510.624681259576;12665.936670316589;12718.554850580185;13029.413676384775;10064.44645544502;10188.847167292644;10200.897991019994;10546.525406356579;11132.220744547803;10932.289401188897;11677.824832627688;11789.292642441482;11930.880691193324;12385.62843114708 20:53:58 INFO - PROCESS | 14919 | __end_tp_report 20:53:58 INFO - PROCESS | 14919 | __start_cc_report 20:53:58 INFO - PROCESS | 14919 | _x_x_mozilla_cycle_collect,336 20:53:58 INFO - PROCESS | 14919 | __end_cc_report 20:53:58 INFO - PROCESS | 14919 | __startTimestamp1471060438748__endTimestamp 20:53:58 INFO - PROCESS | 14919 | 20:53:58 INFO - PROCESS | 14919 | ------- Summary: start ------- 20:53:58 INFO - PROCESS | 14919 | Number of tests: 6 20:53:58 INFO - PROCESS | 14919 | 20:53:58 INFO - PROCESS | 14919 | [#0] dojo.html Cycles:165 Average:5506.07 Median:5722.63 stddev:639.66 (11.2%) stddev-sans-first:613.56 20:53:58 INFO - PROCESS | 14919 | Values: 3117.0 3140.5 3144.5 3158.9 3162.9 5406.9 5439.3 5479.9 5530.4 5559.1 5441.1 5503.9 5531.6 5540.0 5545.4 4916.9 4998.4 5031.5 5059.8 5120.6 5077.4 5101.3 5120.6 5145.3 5145.5 4910.6 4957.1 5041.1 5091.4 5109.8 4958.9 5031.2 5045.1 5071.3 5097.8 4953.7 4997.9 5003.1 5011.5 5026.2 5376.9 5429.8 5514.7 5542.3 5564.7 5844.6 5942.3 5949.0 5972.4 5975.0 5973.4 5974.9 5978.2 5979.1 5979.6 5410.3 5473.7 5559.2 5564.3 5578.5 6039.2 6115.9 6121.8 6122.3 6125.1 5824.9 5866.9 5867.5 5867.6 5873.7 5750.6 5824.3 5876.5 5900.9 5922.3 5824.3 5925.4 5933.3 5975.1 5978.5 5856.7 5890.2 5916.3 5950.9 5951.0 4426.1 4470.5 4513.0 4543.3 4580.2 3985.5 4014.3 4042.8 4050.5 4055.5 5667.1 5688.2 5690.7 5720.1 5724.9 5852.1 5902.7 5973.3 5986.3 5991.8 5561.8 5660.2 5666.3 5683.9 5710.2 5039.2 5070.9 5085.2 5085.8 5125.4 5986.9 6067.2 6092.9 6143.3 6159.6 5931.5 6013.6 6014.8 6062.9 6067.9 6153.8 6160.4 6160.5 6167.2 6169.4 5697.5 5740.4 5862.3 5879.5 5892.6 5907.5 5961.6 5998.9 6003.5 6044.0 5810.1 5828.2 5847.4 5854.4 5864.9 5543.3 5702.1 5760.9 5818.0 5826.1 5721.2 5722.6 5754.5 5777.2 5797.9 5772.2 5853.2 5855.0 5861.0 5865.4 5551.1 5597.6 5603.6 5670.7 5725.7 20:53:58 INFO - PROCESS | 14919 | 20:53:58 INFO - PROCESS | 14919 | [#1] ext.html Cycles:180 Average:67144.53 Median:40899.99 stddev:157216.01 (384.4%) stddev-sans-first:157577.53 20:53:58 INFO - PROCESS | 14919 | Values: 549.4 584.1 600.0 611.8 619.1 39402.0 43088.6 43129.4 43254.6 43255.1 42263.0 42484.4 42722.0 42724.8 42826.6 8739.5 8904.7 8923.3 8931.9 8960.6 8773.6 8775.3 8791.9 8849.0 8855.6 8850.3 8877.7 8934.6 8940.9 8964.1 8865.0 8879.2 8889.0 8900.2 8930.6 8808.3 8840.6 8870.7 8909.3 8914.6 40482.0 40564.4 40885.0 40915.0 40925.6 2684.5 3301.2 3474.1 3548.8 3606.4 31475.8 31800.0 31913.4 32077.4 33455.5 4185.5 4198.4 4216.2 4242.8 4261.6 313103.0 315804.0 316824.0 316878.0 319519.0 35347.0 35551.1 35598.8 35600.0 35715.8 36815.1 37205.6 37766.8 39361.6 39445.8 16838.8 16901.9 17067.0 17069.3 17129.2 13120.9 13127.1 13149.3 13155.9 13167.0 19062.6 19148.4 19150.2 19197.4 19232.3 6881.3 6974.8 7103.2 7333.3 7367.7 925.5 1062.5 1067.1 1106.6 1134.6 32599.2 32865.3 33396.7 33487.3 33691.2 1056.4 1145.0 1185.5 1215.2 1216.4 16516.2 16653.8 16998.2 17303.8 17685.0 543049.0 881019.0 897873.0 900415.0 900759.0 60924.7 60997.4 61391.4 61463.4 61585.7 1358.5 1389.5 1399.6 1400.1 1407.1 31466.5 33719.2 33834.8 34041.7 34240.3 50365.7 50726.0 50821.5 50879.0 50984.2 461768.0 461804.0 468066.0 468608.0 470084.0 28903.9 29111.9 29132.1 29387.3 29576.4 47416.5 48062.8 48407.5 48946.5 49094.3 38757.6 39110.8 41380.2 41426.6 43233.1 40641.6 41687.2 41731.4 42697.8 43251.4 41552.4 42810.0 43835.6 43848.8 43867.0 34020.7 36900.8 37444.8 38929.8 39131.0 27731.4 29505.0 29700.4 29718.6 29988.3 20:53:58 INFO - PROCESS | 14919 | 20:53:58 INFO - PROCESS | 14919 | [#2] jquery.html Cycles:180 Average:28749.15 Median:2496.03 stddev:77791.61 (3116.6%) stddev-sans-first:77980.70 20:53:58 INFO - PROCESS | 14919 | Values: 391.6 394.8 396.8 399.5 431.0 13114.3 18407.7 19387.9 20001.1 20100.7 19061.8 19261.7 19607.0 19686.2 20034.9 5753.9 5801.5 5933.3 6076.2 6127.6 6152.0 6159.8 6160.2 6162.3 6167.9 6199.2 6735.8 6750.2 6759.0 6768.8 5648.1 5907.8 6743.3 6783.7 6814.3 5792.4 5826.1 5839.7 5856.8 5859.1 14508.3 22203.0 23019.0 23153.5 23171.0 2258.7 2331.2 2660.8 2726.1 2801.6 10318.7 10646.9 10652.7 10858.7 10983.0 1910.5 1933.9 1947.6 1982.1 2038.4 83543.6 84151.6 85189.0 85634.1 86855.6 11243.5 11276.9 11619.0 11715.7 11871.0 16025.2 16092.5 16104.4 16128.0 16156.4 8314.8 8497.8 8503.8 8518.1 8741.2 7998.1 8001.8 8018.6 8234.1 8307.3 4578.5 4651.7 4860.4 4867.8 4982.2 1786.2 1928.4 1953.9 1954.6 1980.5 883.5 991.1 1017.7 1028.6 1057.6 19179.0 19997.3 20066.0 20238.5 20290.7 965.5 1009.4 1012.4 1022.6 1051.6 9262.6 11017.9 11234.4 11326.4 11328.0 466657.0 470061.0 470630.0 472202.0 473132.0 88056.0 92050.0 93964.0 94516.5 95065.5 968.7 1003.6 1032.4 1036.8 1042.7 17232.0 17393.0 17712.7 18063.9 18163.5 43843.8 44568.8 44973.0 45338.5 45695.3 57589.4 57983.4 58386.4 58766.1 59448.0 8456.4 8560.2 8595.9 8656.7 8693.4 12347.9 12749.4 12954.2 13215.3 13400.0 10947.5 11425.8 11479.6 11664.5 12337.7 10898.1 11397.5 11433.6 11442.7 11496.4 11257.8 11497.4 11676.1 11870.3 12203.1 8429.3 8692.0 8847.4 8858.8 9046.3 8948.7 10400.8 10449.8 10897.9 11212.5 20:53:58 INFO - PROCESS | 14919 | 20:53:58 INFO - PROCESS | 14919 | [#3] mootools.html Cycles:180 Average:5920.99 Median:4676.53 stddev:3389.94 (72.5%) stddev-sans-first:3383.15 20:53:58 INFO - PROCESS | 14919 | Values: 1497.3 1528.0 1670.0 1733.5 1799.0 7935.2 8485.5 8613.4 9218.7 9222.7 8642.9 8905.7 8970.7 8979.5 8984.4 2375.4 2423.0 2426.7 2428.2 2429.5 2249.6 2255.5 2315.1 2315.7 2319.1 2405.8 2410.3 2426.5 2432.1 2441.4 2348.6 2368.6 2374.1 2388.2 2409.6 2233.5 2244.5 2247.5 2249.2 2249.3 8886.0 8888.2 8891.2 8905.5 8970.6 5206.3 5330.3 5374.3 5381.4 5436.5 3206.6 3386.8 3393.8 3427.8 3477.5 1149.2 1162.0 1175.5 1185.8 1191.0 12519.7 12588.8 12601.1 12602.7 12640.5 4472.4 4640.9 4755.7 4823.5 4832.8 10495.0 10501.4 10551.6 10575.7 10583.5 5428.4 5430.7 5468.3 5477.8 5485.8 4331.5 4712.2 4802.8 4822.2 5007.0 3927.1 4048.4 4140.4 4147.6 4149.5 1253.4 1267.9 1270.6 1274.1 1279.0 958.4 971.2 1002.3 1006.6 1015.8 6041.5 6102.8 6104.4 6135.0 6194.2 477.0 482.9 484.3 494.8 499.2 4156.1 4194.3 4259.3 4357.8 4382.3 10702.4 11128.2 11197.5 11202.7 11215.1 11016.9 11070.4 11096.3 11105.7 11113.8 7831.2 7989.3 8137.3 8168.2 8195.4 6008.8 6098.8 6246.5 6260.7 6432.4 10240.5 10453.9 10538.9 10635.0 10636.8 10412.1 10521.6 10624.2 10629.8 10651.8 7222.0 7560.0 7738.8 7973.6 8119.9 8794.2 8883.5 8884.6 8886.7 8947.0 7908.6 8003.3 8099.6 8213.9 8281.9 7748.3 7878.1 7891.1 7917.0 7944.4 7097.6 7201.2 7259.9 7261.6 7269.2 5242.6 5340.5 5356.2 5356.3 5379.0 5383.1 5415.0 5446.6 5504.5 5596.3 20:53:58 INFO - PROCESS | 14919 | 20:53:58 INFO - PROCESS | 14919 | [#4] prototype.html Cycles:180 Average:4662.57 Median:5196.01 stddev:1335.34 (25.7%) stddev-sans-first:1299.00 20:53:58 INFO - PROCESS | 14919 | Values: 336.2 337.4 346.0 351.9 354.1 5332.8 5418.2 5433.9 5536.2 5546.5 5471.6 5474.5 5529.3 5534.9 5548.3 4292.5 4296.4 4319.8 4344.7 4365.8 4189.2 4293.2 4308.0 4340.0 4362.8 4260.9 4265.2 4271.1 4279.0 4302.3 4255.6 4302.8 4309.8 4313.4 4315.8 3658.3 3789.3 3812.4 3812.8 3817.4 5366.2 5369.4 5371.1 5418.4 5426.3 4892.3 4907.2 4912.2 4924.3 4926.6 5568.1 5708.5 5718.6 5764.7 5794.9 4102.9 4119.5 4123.8 4128.3 4141.5 6064.0 6068.9 6073.8 6080.7 6093.2 4073.7 4252.1 4256.4 4271.3 4277.9 4276.5 4282.8 4291.2 4292.1 4303.3 4916.9 4927.4 4935.9 4937.0 4972.3 5701.3 5821.5 5861.6 5866.3 5882.5 1455.4 1478.2 1478.9 1479.6 1484.7 959.2 966.4 992.4 1000.6 1008.4 4884.0 4903.3 4905.5 4930.1 4961.6 5237.4 5277.3 5278.7 5301.4 5310.0 4610.9 4879.7 4907.4 4940.7 4997.4 2665.2 2748.6 2749.5 2759.4 2776.7 5355.4 5367.1 5380.3 5403.5 5406.0 5081.8 5229.4 5243.6 5266.8 5296.8 5276.7 5278.1 5299.0 5303.7 5307.8 5154.4 5179.8 5192.9 5199.1 5212.3 4871.0 5067.6 5081.5 5083.5 5104.4 5281.3 5308.5 5311.8 5335.2 5383.5 3909.0 4063.1 4212.8 4284.9 4342.1 5832.2 5838.8 5868.6 5874.9 5884.8 5530.2 5622.2 5659.2 5686.5 5690.5 5640.4 5668.5 5686.1 5693.8 5701.6 5598.0 5616.9 5660.2 5671.7 5694.6 5485.8 5746.0 5761.1 5782.8 5829.8 5618.5 5645.3 5650.6 5658.3 5664.6 20:53:58 INFO - PROCESS | 14919 | 20:53:58 INFO - PROCESS | 14919 | [#5] yui.html Cycles:180 Average:21516.85 Median:4478.32 stddev:31833.98 (710.8%) stddev-sans-first:31885.03 20:53:58 INFO - PROCESS | 14919 | Values: 733.1 749.6 759.3 772.3 810.7 16577.2 17542.1 17576.2 17589.0 17597.3 15707.5 15870.3 15871.7 15871.8 15889.2 652.8 779.8 779.8 791.5 793.4 798.3 799.2 801.4 802.4 803.0 845.3 852.5 854.0 854.7 854.7 848.9 849.1 849.5 849.6 849.6 617.1 619.9 620.5 620.8 621.2 15737.0 15787.9 15801.7 15836.0 15845.2 13322.9 14156.6 14292.1 15975.5 15984.4 13288.5 13452.0 13718.6 13887.7 14049.2 4523.3 4548.2 4575.0 4634.3 4656.7 86965.6 87309.0 87391.6 89738.0 89845.6 11279.6 11674.3 11737.8 12076.4 12433.5 21571.9 21785.3 21869.1 21872.1 21936.0 8284.4 8438.2 8443.9 8477.8 8478.7 4835.1 4981.2 4986.4 5069.7 5138.0 3710.2 3775.5 3807.9 3827.7 3847.8 646.8 648.7 651.4 662.1 670.8 553.4 597.8 599.0 631.8 673.9 9460.9 9599.7 9671.6 9709.2 9947.8 661.0 686.4 698.1 699.1 704.2 4032.6 4049.3 4331.8 4433.3 4573.5 114528.0 126178.4 126375.0 131238.0 132367.0 59837.7 60956.4 64018.7 87421.0 105660.5 100384.0 100562.0 100980.5 103237.0 103774.0 8263.0 8400.7 8502.7 8648.6 8757.5 41442.6 56062.7 56355.0 58026.1 58178.7 77639.0 80208.0 82320.6 83599.6 83935.0 11580.0 11736.4 11798.8 11819.8 11996.1 13245.3 13267.7 13378.3 13426.1 13894.7 12123.5 12345.2 12499.2 12555.9 12613.9 12311.3 12539.4 13054.1 13082.9 13266.1 12284.8 12510.6 12665.9 12718.6 13029.4 10064.4 10188.8 10200.9 10546.5 11132.2 10932.3 11677.8 11789.3 11930.9 12385.6 20:53:58 INFO - PROCESS | 14919 | -------- Summary: end -------- 20:53:58 INFO - PROCESS | 14919 | 20:53:59 INFO - TEST-INFO | 14919: exit 0 20:53:59 INFO - TEST-OK | dromaeo_css | took 1113079ms 20:53:59 INFO - TEST-START | kraken 20:53:59 INFO - operating with platform_type : linux_ 20:53:59 INFO - Initialising browser for kraken test... 20:53:59 INFO - TEST-INFO | started process 15271 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpW_4i9M/profile http://localhost:54224/getInfo.html) 20:54:04 INFO - PROCESS | 15271 | __metrics Screen width/height:1600/1200 20:54:04 INFO - PROCESS | 15271 | colorDepth:24 20:54:04 INFO - PROCESS | 15271 | Browser inner width/height: 1024/697 20:54:04 INFO - PROCESS | 15271 | __metrics 20:54:04 ERROR - PROCESS | 15271 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2983: TypeError: this.tabs is undefined 20:54:05 INFO - TEST-INFO | 15271: exit 0 20:54:05 INFO - Browser initialized. 20:54:05 INFO - Running cycle 1/1 for kraken test... 20:54:05 INFO - TEST-INFO | started process 15393 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpW_4i9M/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:54:17 INFO - PROCESS | 15393 | RSS: Main: 163504128 20:54:17 INFO - PROCESS | 15393 | 20:54:19 INFO - PROCESS | 15393 | Cycle 1(1): loaded http://localhost:54224/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54224/tests/kraken/driver.html?testName=audio-beat-detection) 20:54:20 INFO - PROCESS | 15393 | RSS: Main: 168636416 20:54:20 INFO - PROCESS | 15393 | 20:54:23 INFO - PROCESS | 15393 | Cycle 1(1): loaded http://localhost:54224/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54224/tests/kraken/driver.html?testName=audio-dft) 20:54:24 INFO - PROCESS | 15393 | RSS: Main: 167600128 20:54:24 INFO - PROCESS | 15393 | 20:54:26 INFO - PROCESS | 15393 | Cycle 1(1): loaded http://localhost:54224/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54224/tests/kraken/driver.html?testName=audio-fft) 20:54:27 INFO - PROCESS | 15393 | RSS: Main: 163794944 20:54:27 INFO - PROCESS | 15393 | 20:54:29 INFO - PROCESS | 15393 | Cycle 1(1): loaded http://localhost:54224/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54224/tests/kraken/driver.html?testName=audio-oscillator) 20:54:30 INFO - PROCESS | 15393 | RSS: Main: 164425728 20:54:30 INFO - PROCESS | 15393 | 20:54:32 INFO - PROCESS | 15393 | Cycle 1(1): loaded http://localhost:54224/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54224/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:54:33 INFO - PROCESS | 15393 | RSS: Main: 164524032 20:54:33 INFO - PROCESS | 15393 | 20:54:36 INFO - PROCESS | 15393 | Cycle 1(1): loaded http://localhost:54224/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54224/tests/kraken/driver.html?testName=imaging-darkroom) 20:54:36 INFO - PROCESS | 15393 | RSS: Main: 165072896 20:54:36 INFO - PROCESS | 15393 | 20:54:40 INFO - PROCESS | 15393 | Cycle 1(1): loaded http://localhost:54224/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54224/tests/kraken/driver.html?testName=imaging-desaturate) 20:54:41 INFO - PROCESS | 15393 | RSS: Main: 162168832 20:54:41 INFO - PROCESS | 15393 | 20:54:43 INFO - PROCESS | 15393 | Cycle 1(1): loaded http://localhost:54224/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54224/tests/kraken/driver.html?testName=json-parse-financial) 20:54:44 INFO - PROCESS | 15393 | RSS: Main: 163995648 20:54:44 INFO - PROCESS | 15393 | 20:54:46 INFO - PROCESS | 15393 | Cycle 1(1): loaded http://localhost:54224/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54224/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:54:46 INFO - PROCESS | 15393 | RSS: Main: 163598336 20:54:46 INFO - PROCESS | 15393 | 20:54:48 INFO - PROCESS | 15393 | Cycle 1(1): loaded http://localhost:54224/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54224/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:54:49 INFO - PROCESS | 15393 | RSS: Main: 163835904 20:54:49 INFO - PROCESS | 15393 | 20:54:51 INFO - PROCESS | 15393 | Cycle 1(1): loaded http://localhost:54224/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54224/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:54:52 INFO - PROCESS | 15393 | RSS: Main: 164372480 20:54:52 INFO - PROCESS | 15393 | 20:54:54 INFO - PROCESS | 15393 | Cycle 1(1): loaded http://localhost:54224/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54224/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:54:55 INFO - PROCESS | 15393 | RSS: Main: 164347904 20:54:55 INFO - PROCESS | 15393 | 20:54:58 INFO - PROCESS | 15393 | Cycle 1(1): loaded http://localhost:54224/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54224/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:54:58 INFO - PROCESS | 15393 | RSS: Main: 164618240 20:54:58 INFO - PROCESS | 15393 | 20:55:00 INFO - PROCESS | 15393 | Cycle 1(1): loaded http://localhost:54224/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54224/tests/kraken/driver.html?testName=ai-astar) 20:55:00 INFO - PROCESS | 15393 | RSS: Main: 165416960 20:55:00 INFO - PROCESS | 15393 | 20:55:00 INFO - PROCESS | 15393 | __start_tp_report 20:55:00 INFO - PROCESS | 15393 | _x_x_mozilla_page_load 20:55:00 INFO - PROCESS | 15393 | _x_x_mozilla_page_load_details 20:55:00 INFO - PROCESS | 15393 | |i|pagename|runs| 20:55:00 INFO - PROCESS | 15393 | |0;ai-astar;104;112;108;111;112;112;117;111;111;112 20:55:00 INFO - PROCESS | 15393 | |1;audio-beat-detection;153;124;153;176;120;148;152;124;181;119 20:55:00 INFO - PROCESS | 15393 | |2;audio-dft;163;163;162;162;161;164;168;162;163;163 20:55:00 INFO - PROCESS | 15393 | |3;audio-fft;75;76;77;186;76;77;76;75;175;77 20:55:00 INFO - PROCESS | 15393 | |4;audio-oscillator;84;85;151;87;85;85;140;85;86;147 20:55:00 INFO - PROCESS | 15393 | |5;imaging-gaussian-blur;117;119;116;117;117;117;117;117;119;117 20:55:00 INFO - PROCESS | 15393 | |6;imaging-darkroom;147;147;149;147;146;147;147;148;147;148 20:55:00 INFO - PROCESS | 15393 | |7;imaging-desaturate;96;97;95;96;95;96;95;96;96;96 20:55:00 INFO - PROCESS | 15393 | |8;json-parse-financial;50;51;57;51;52;65;52;51;51;57 20:55:00 INFO - PROCESS | 15393 | |9;json-stringify-tinderbox;62;62;63;62;62;62;61;62;62;62 20:55:00 INFO - PROCESS | 15393 | |10;stanford-crypto-aes;87;86;84;81;89;84;90;80;87;79 20:55:00 INFO - PROCESS | 15393 | |11;stanford-crypto-ccm;129;138;128;127;134;124;127;125;151;135 20:55:00 INFO - PROCESS | 15393 | |12;stanford-crypto-pbkdf2;165;169;167;164;167;168;168;167;168;164 20:55:00 INFO - PROCESS | 15393 | |13;stanford-crypto-sha256-iterative;69;64;69;64;65;64;65;64;64;64 20:55:00 INFO - PROCESS | 15393 | __end_tp_report 20:55:00 INFO - PROCESS | 15393 | __start_cc_report 20:55:00 INFO - PROCESS | 15393 | _x_x_mozilla_cycle_collect,828 20:55:00 INFO - PROCESS | 15393 | __end_cc_report 20:55:00 INFO - PROCESS | 15393 | __startTimestamp1471060500638__endTimestamp 20:55:00 INFO - PROCESS | 15393 | 20:55:00 INFO - PROCESS | 15393 | ------- Summary: start ------- 20:55:00 INFO - PROCESS | 15393 | Number of tests: 14 20:55:00 INFO - PROCESS | 15393 | 20:55:00 INFO - PROCESS | 15393 | [#0] ai-astar Cycles:10 Average:111.00 Median:112.00 stddev:3.30 (2.9%) stddev-sans-first:2.33 20:55:00 INFO - PROCESS | 15393 | Values: 104.0 112.0 108.0 111.0 112.0 112.0 117.0 111.0 111.0 112.0 20:55:00 INFO - PROCESS | 15393 | 20:55:00 INFO - PROCESS | 15393 | [#1] audio-beat-detection Cycles:10 Average:145.00 Median:152.50 stddev:22.67 (14.9%) stddev-sans-first:23.86 20:55:00 INFO - PROCESS | 15393 | Values: 153.0 124.0 153.0 176.0 120.0 148.0 152.0 124.0 181.0 119.0 20:55:00 INFO - PROCESS | 15393 | 20:55:00 INFO - PROCESS | 15393 | [#2] audio-dft Cycles:10 Average:163.10 Median:163.00 stddev:1.91 (1.2%) stddev-sans-first:2.03 20:55:00 INFO - PROCESS | 15393 | Values: 163.0 163.0 162.0 162.0 161.0 164.0 168.0 162.0 163.0 163.0 20:55:00 INFO - PROCESS | 15393 | 20:55:00 INFO - PROCESS | 15393 | [#3] audio-fft Cycles:10 Average:97.00 Median:76.00 stddev:44.09 (58.0%) stddev-sans-first:46.04 20:55:00 INFO - PROCESS | 15393 | Values: 75.0 76.0 77.0 186.0 76.0 77.0 76.0 75.0 175.0 77.0 20:55:00 INFO - PROCESS | 15393 | 20:55:00 INFO - PROCESS | 15393 | [#4] audio-oscillator Cycles:10 Average:103.50 Median:85.00 stddev:29.46 (34.7%) stddev-sans-first:30.39 20:55:00 INFO - PROCESS | 15393 | Values: 84.0 85.0 151.0 87.0 85.0 85.0 140.0 85.0 86.0 147.0 20:55:00 INFO - PROCESS | 15393 | 20:55:00 INFO - PROCESS | 15393 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.00 stddev:0.95 (0.8%) stddev-sans-first:1.00 20:55:00 INFO - PROCESS | 15393 | Values: 117.0 119.0 116.0 117.0 117.0 117.0 117.0 117.0 119.0 117.0 20:55:00 INFO - PROCESS | 15393 | 20:55:00 INFO - PROCESS | 15393 | [#6] imaging-darkroom Cycles:10 Average:147.30 Median:147.00 stddev:0.82 (0.6%) stddev-sans-first:0.87 20:55:00 INFO - PROCESS | 15393 | Values: 147.0 147.0 149.0 147.0 146.0 147.0 147.0 148.0 147.0 148.0 20:55:00 INFO - PROCESS | 15393 | 20:55:00 INFO - PROCESS | 15393 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 20:55:00 INFO - PROCESS | 15393 | Values: 96.0 97.0 95.0 96.0 95.0 96.0 95.0 96.0 96.0 96.0 20:55:00 INFO - PROCESS | 15393 | 20:55:00 INFO - PROCESS | 15393 | [#8] json-parse-financial Cycles:10 Average:53.70 Median:52.00 stddev:4.69 (9.0%) stddev-sans-first:4.78 20:55:00 INFO - PROCESS | 15393 | Values: 50.0 51.0 57.0 51.0 52.0 65.0 52.0 51.0 51.0 57.0 20:55:00 INFO - PROCESS | 15393 | 20:55:00 INFO - PROCESS | 15393 | [#9] json-stringify-tinderbox Cycles:10 Average:62.00 Median:62.00 stddev:0.47 (0.8%) stddev-sans-first:0.50 20:55:00 INFO - PROCESS | 15393 | Values: 62.0 62.0 63.0 62.0 62.0 62.0 61.0 62.0 62.0 62.0 20:55:00 INFO - PROCESS | 15393 | 20:55:00 INFO - PROCESS | 15393 | [#10] stanford-crypto-aes Cycles:10 Average:84.70 Median:86.50 stddev:3.77 (4.4%) stddev-sans-first:3.91 20:55:00 INFO - PROCESS | 15393 | Values: 87.0 86.0 84.0 81.0 89.0 84.0 90.0 80.0 87.0 79.0 20:55:00 INFO - PROCESS | 15393 | 20:55:00 INFO - PROCESS | 15393 | [#11] stanford-crypto-ccm Cycles:10 Average:131.80 Median:131.50 stddev:8.15 (6.2%) stddev-sans-first:8.58 20:55:00 INFO - PROCESS | 15393 | Values: 129.0 138.0 128.0 127.0 134.0 124.0 127.0 125.0 151.0 135.0 20:55:00 INFO - PROCESS | 15393 | 20:55:00 INFO - PROCESS | 15393 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.70 Median:167.50 stddev:1.77 (1.1%) stddev-sans-first:1.76 20:55:00 INFO - PROCESS | 15393 | Values: 165.0 169.0 167.0 164.0 167.0 168.0 168.0 167.0 168.0 164.0 20:55:00 INFO - PROCESS | 15393 | 20:55:00 INFO - PROCESS | 15393 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.20 Median:64.50 stddev:2.04 (3.2%) stddev-sans-first:1.64 20:55:00 INFO - PROCESS | 15393 | Values: 69.0 64.0 69.0 64.0 65.0 64.0 65.0 64.0 64.0 64.0 20:55:00 INFO - PROCESS | 15393 | -------- Summary: end -------- 20:55:00 INFO - PROCESS | 15393 | 20:55:01 INFO - TEST-INFO | 15393: exit 0 20:55:01 INFO - TEST-OK | kraken | took 62097ms 20:55:01 INFO - SUITE-END | took 1175s 20:55:01 INFO - Completed test suite (00:19:35) 20:55:01 INFO - javascript benchmark 20:55:01 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7318.96083335585, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3117.049299963511, 3140.528920661902, 3144.544041114038, 3158.873645054198, 3162.873485060598, 5406.91889621656, 5439.347278326602, 5479.917801232985, 5530.419305972875, 5559.082751346034, 5441.129419292914, 5503.889922201553, 5531.585131115163, 5539.972300138504, 5545.417731138223, 4916.877078073059, 4998.375203099613, 5031.496850314958, 5059.848204553869, 5120.590352771769, 5077.441481437039, 5101.260317253996, 5120.615953803461, 5145.30538377318, 5145.511176438233, 4910.582600478963, 4957.132501812169, 5041.067402530525, 5091.439941606421, 5109.770060347293, 4958.925616115761, 5031.169856973595, 5045.117104506733, 5071.315372424712, 5097.821576244851, 4953.653244272902, 4997.85006449807, 5003.099442100421, 5011.498850114996, 5026.170681837492, 5376.91934620981, 5429.8099566515375, 5514.724263786835, 5542.279503664538, 5564.749586268627, 5844.590878638497, 5942.346341902387, 5948.97025514874, 5972.432618901197, 5974.97012514939, 5973.432523910222, 5974.940250597482, 5978.192943952554, 5979.133025711291, 5979.5515336349945, 5410.296661434067, 5473.67157970523, 5559.19391688207, 5564.33228012641, 5578.497935185853, 6039.1545183674325, 6115.876089542891, 6121.755129794848, 6122.295935967331, 6125.050617154348, 5824.912626310609, 5866.914620795166, 5867.471927526543, 5867.61860479076, 5873.676947767914, 5750.648597579566, 5824.271966004249, 5876.500497457679, 5900.852478688067, 5922.2597175353085, 5824.330202026821, 5925.4370834770625, 5933.288005439289, 5975.133605627159, 5978.491828194565, 5856.736446859902, 5890.175375447441, 5916.319623243382, 5950.940490595125, 5951.0, 4426.1369033038245, 4470.508244093147, 4512.984578469818, 4543.341215523797, 4580.175568397721, 3985.501812273466, 4014.277430062617, 4042.777647229431, 4050.4936882889638, 4055.513338399411, 5667.064934285879, 5688.175214593861, 5690.715464226855, 5720.141978703145, 5724.856878578069, 5852.063669812895, 5902.675352855634, 5973.253343332083, 5986.341502434729, 5991.7603295867675, 5561.777528898799, 5660.15097735343, 5666.320041595035, 5683.8863222736145, 5710.172025056344, 5039.244113383022, 5070.923936140887, 5085.211792172219, 5085.821996230115, 5125.359330083739, 5986.940130598726, 6067.211262535842, 6092.908606370908, 6143.262808463013, 6159.630422174594, 5931.495822855106, 6013.579049466495, 6014.759409623741, 6062.939370606237, 6067.878642427215, 6153.815385538441, 6160.353162918008, 6160.507159427325, 6167.167432396748, 6169.383061693974, 5697.515711164598, 5740.39725828782, 5862.325832529314, 5879.5002424794375, 5892.558058145742, 5907.468327850343, 5961.642301461926, 5998.850028749316, 6003.489703375262, 6043.969780151071, 5810.099434587646, 5828.184054232326, 5847.38602446737, 5854.414558544111, 5864.912026319694, 5543.279373681396, 5702.059160238514, 5760.942390576208, 5818.010938140442, 5826.126081087871, 5721.22763426932, 5722.62802917809, 5754.539636829128, 5777.24895763548, 5797.91303130445, 5772.2207501986695, 5853.239078919713, 5855.03391940325, 5860.970695146668, 5865.384134665798, 5551.111822108443, 5597.608167428241, 5603.551715862803, 5670.659760414388, 5725.656460612377], "value": 5461.545424203636, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [549.4478296810728, 584.126730537846, 599.9650602710325, 611.8011646214982, 619.1270308864501, 39402.01494962624, 43088.569114308884, 43129.35305970413, 43254.56745432545, 43255.134897302036, 42263.0, 42484.36273455901, 42722.0, 42724.78637606808, 42826.57173428265, 8739.4756314621, 8904.73285801427, 8923.330750193729, 8931.866022009675, 8960.64157433705, 8773.56132193391, 8775.25410340122, 8791.868121978176, 8848.98236702781, 8855.5572221389, 8850.336224783136, 8877.68928087517, 8934.597943092544, 8940.8658870117, 8964.05877382872, 8865.0, 8879.156480134408, 8889.0, 8900.243479304267, 8930.642774289021, 8808.339374546871, 8840.646374145026, 8870.73387798367, 8909.287257019423, 8914.554272286425, 40482.0, 40564.39153412701, 40885.0, 40914.9771255718, 40925.59074409248, 2684.516786978343, 3301.2036158417773, 3474.114100904253, 3548.7870727756417, 3606.386914224588, 31475.842620786978, 31800.0, 31913.361732765447, 32077.358452830813, 33455.498167527505, 4185.518665353462, 4198.412222288882, 4216.156768646283, 4242.787860606957, 4261.573842615745, 313103.0, 315804.0, 316824.0, 316878.0, 319519.0, 35347.0, 35551.11122221914, 35598.82200588981, 35600.0, 35715.82142089325, 36815.0796230091, 37205.62794372022, 37766.811165944, 39361.60638393636, 39445.80277098596, 16838.83161168397, 16901.915490422714, 17067.0, 17069.31722731077, 17129.22918468672, 13120.934395327962, 13127.081104322606, 13149.342532873317, 13155.934220328838, 13167.012474064484, 19062.61874762497, 19148.425547233604, 19150.233990640496, 19197.424077277705, 19232.326868559532, 6881.277465866112, 6974.755883544051, 7103.218645948941, 7333.2666733327305, 7367.668454919542, 925.509479975614, 1062.4793851013103, 1067.1196263082988, 1106.6016234155697, 1134.6085600467825, 32599.18502037468, 32865.342693146005, 33396.66603333935, 33487.33025339479, 33691.15772105668, 1056.4295280548572, 1145.0496088246734, 1185.543565727184, 1215.1554669504785, 1216.3796463803524, 16516.17419129039, 16653.750193747102, 16998.235079421454, 17303.82696173022, 17684.993551096086, 543049.0, 881019.0, 897873.0, 900415.0, 900759.0, 60924.69537652372, 60997.39002610006, 61391.38608613946, 61463.385366146664, 61585.69207153936, 1358.4634069542674, 1389.4789453954768, 1399.5871217990716, 1400.1216629935022, 1407.0713329202677, 31466.528002080446, 33719.15702107467, 33834.83082584571, 34041.65958340484, 34240.31519369549, 50365.74817126038, 50726.0, 50821.49178508168, 50879.0, 50984.23523647074, 461768.0, 461804.0, 468066.0, 468608.0, 470084.0, 28903.85548072246, 29111.85444072766, 29132.126036218946, 29387.265318367212, 29576.408471830873, 47416.52583474121, 48062.759686201345, 48407.51592484171, 48946.51053489562, 49094.26358604695, 38757.612423876526, 39110.804445977585, 41380.238983423296, 41426.585734143475, 43233.13533729371, 40641.59358406378, 41687.16625667409, 41731.37402938898, 42697.78651106849, 43251.35122973095, 41552.37671434991, 42810.0, 43835.561644383146, 43848.780756096014, 43867.0, 34020.65979340175, 36900.81549592342, 37444.81277593595, 38929.80535097307, 39131.0, 27731.44537109287, 29505.0, 29700.40599187961, 29718.554221687125, 29988.250293742833], "value": 19954.102452663097, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [391.5751409720453, 394.77892380267036, 396.80953142491614, 399.49862922032844, 431.0258815077925, 13114.344282785847, 18407.72388414175, 19387.903060484714, 20001.099950502226, 20100.69848952267, 19061.809381906176, 19261.711074333896, 19607.01964901753, 19686.21255149796, 20034.899825500852, 5753.913691294634, 5801.53587712982, 5933.288005439354, 6076.240469941257, 6127.601705889125, 6151.969240153815, 6159.846003849895, 6160.19917410736, 6162.322144564117, 6167.876642467148, 6199.163112979735, 6735.831604209885, 6750.189977202743, 6758.9662051689675, 6768.8307792305095, 5648.124540696199, 5907.822765317047, 6743.325667433266, 6783.660816959157, 6814.250432452451, 5792.4497172768515, 5826.067829147359, 5839.708014599296, 5856.824295271149, 5859.062549992023, 14508.27458627075, 22203.0, 23019.0, 23153.53692926132, 23171.0, 2258.728952525691, 2331.2423462374795, 2660.813743037988, 2726.05950946925, 2801.6357873476522, 10318.742031449274, 10646.893531064668, 10652.680419587425, 10858.72853178669, 10983.0, 1910.512819231101, 1933.8646294759371, 1947.5617985953188, 1982.1080513768861, 2038.398672391648, 83543.58228208881, 84151.57924210401, 85189.0, 85634.14365856323, 86855.56572217098, 11243.494042768096, 11276.887231127748, 11619.0, 11715.707107322385, 11871.0, 16025.234069993543, 16092.517224483285, 16104.355825766837, 16128.0, 16156.434524791575, 8314.833703326021, 8497.787555311043, 8503.787405314793, 8518.105598912149, 8741.169588889044, 7998.12020677725, 8001.799955001172, 8018.55897925608, 8234.094249632535, 8307.293880020145, 4578.45058592971, 4651.651126165551, 4860.392450943632, 4867.780949857265, 4982.202847544376, 1786.2319202742685, 1928.3829174664254, 1953.9413817585496, 1954.5699946011855, 1980.5147738803796, 883.4831623500324, 991.0881988570533, 1017.7455636090978, 1028.5885645741614, 1057.619257067455, 19179.0, 19997.300094496914, 20066.0, 20238.49403764888, 20290.69563956542, 965.5124162298135, 1009.3842755918884, 1012.4026824173773, 1022.6114076650974, 1051.5530899367739, 9262.629494820132, 11017.944910275397, 11234.438278086227, 11326.377049262204, 11328.0, 466657.0, 470061.0, 470630.0, 472202.0, 473132.0, 88056.0, 92050.0, 93964.0, 94516.52741736248, 95065.52467237758, 968.6803354892868, 1003.5684655598017, 1032.385730490357, 1036.7667274863095, 1042.7341028037954, 17232.0, 17393.043382614076, 17712.70288851461, 18063.909680452038, 18163.45509634713, 43843.78078109589, 44568.77715611401, 44973.0, 45338.546614533436, 45695.314570282135, 57589.42410575841, 57983.420165797805, 58386.4161358398, 58766.11850822327, 59448.0, 8456.40805143634, 8560.229579337889, 8595.914040859512, 8656.740297791077, 8693.434926729742, 12347.938260308641, 12749.426275817796, 12954.157979731288, 13215.339233038118, 13400.0, 10947.50736216888, 11425.771484570096, 11479.598214062802, 11664.533418663497, 12337.691557711129, 10898.106887579463, 11397.487113080097, 11433.59982400612, 11442.713932151762, 11496.425178741198, 11257.774844502901, 11497.367644779617, 11676.124290678403, 11870.347130907883, 12203.14577979533, 8429.283510901396, 8691.956540217512, 8847.380683352103, 8858.822823543363, 9046.321525885453, 8948.73153805361, 10400.843987340044, 10449.843252351373, 10897.891021089688, 11212.49543770516], "value": 9390.24597024647, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1497.2588568658512, 1528.0144306922034, 1669.9960047942473, 1733.5232810976988, 1799.0285245967186, 7935.166807485218, 8485.53329566875, 8613.353998450119, 9218.677346292881, 9222.723318300454, 8642.870356944652, 8905.688300909469, 8970.686025989091, 8979.506127163004, 8984.416012959153, 2375.418022584465, 2422.9757702423017, 2426.708794944609, 2428.1501474483875, 2429.4776623026046, 2249.583826992012, 2255.4925141843037, 2315.143396943133, 2315.6758053872472, 2319.060780383947, 2405.795507381875, 2410.2528216253017, 2426.5268272686835, 2432.1001229545095, 2441.426264827764, 2348.56551537966, 2368.59733845245, 2374.050379848057, 2388.164142550111, 2409.6265078912797, 2233.530958498717, 2244.5062086340977, 2247.505548779266, 2249.2127755285683, 2249.302716157996, 8886.0, 8888.200061994386, 8891.199792018684, 8905.465672059698, 8970.551472426418, 5206.349206349207, 5330.307060082165, 5374.328208973879, 5381.408045115034, 5436.483534064258, 3206.567113439679, 3386.762926595139, 3393.8133402662843, 3427.845746941394, 3477.51314815926, 1149.1898211760688, 1162.0, 1175.4534141624101, 1185.8043422835221, 1190.9876604885865, 12519.687007824787, 12588.81116783249, 12601.11792174539, 12602.68493287666, 12640.49438022478, 4472.396226509444, 4640.907181856344, 4755.714657120584, 4823.517648235219, 4832.830850920201, 10495.0, 10501.422421766876, 10551.630692925712, 10575.735606609896, 10583.470826458646, 5428.37573679032, 5430.70131142791, 5468.26178465902, 5477.835664930059, 5485.780568777284, 4331.480222373335, 4712.151812673752, 4802.759862006886, 4822.180229361017, 5006.998600279959, 3927.136030073379, 4048.4332193492933, 4140.399642051885, 4147.647449966787, 4149.502059752849, 1253.404632799413, 1267.866873978219, 1270.5807083662369, 1274.0571976737149, 1278.9552365667157, 958.4488918871676, 971.155095067296, 1002.3434650304063, 1006.597361055569, 1015.7511409704522, 6041.456268935729, 6102.847428814315, 6104.4200800923845, 6135.0, 6194.194754681863, 476.9689970151929, 482.87445264231553, 484.2590836020894, 494.75509622736257, 499.2486308106277, 4156.127213285184, 4194.328907374806, 4259.254630439661, 4357.803898824497, 4382.255016647177, 10702.357858528514, 11128.221024528206, 11197.49611267495, 11202.719932001764, 11215.102791776639, 11016.944915275373, 11070.391128487849, 11096.278741881913, 11105.666829995112, 11113.83329250062, 7831.216878312123, 7989.320907722792, 8137.308328792119, 8168.2240187183315, 8195.385346099067, 6008.789692360747, 6098.786542470993, 6246.5002799775, 6260.655663938527, 6432.35676432353, 10240.53917573696, 10453.9477302613, 10538.894611054098, 10635.0, 10636.84044739345, 10412.114970227616, 10521.631742889269, 10624.20318476102, 10629.840552391875, 10651.840222396826, 7222.0, 7560.0, 7738.7678369649, 7973.601319934096, 8119.918800811916, 8794.20852123312, 8883.466991980502, 8884.60019299146, 8886.688965886164, 8947.0, 7908.644111015134, 8003.31971782405, 8099.554524501209, 8213.87557913915, 8281.917180828115, 7748.34139098183, 7878.094019187637, 7891.131975482807, 7917.010373703287, 7944.404169687181, 7097.574145551283, 7201.207867134506, 7259.854802904018, 7261.564306141649, 7269.200387957215, 5242.580593552583, 5340.465953404784, 5356.1697936819855, 5356.250124982427, 5378.97310513445, 5383.1117865553315, 5414.972925135349, 5446.618736688394, 5504.504594586507, 5596.272484576979], "value": 4659.156163199729, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [336.22420220919076, 337.36070147071297, 345.95329630499873, 351.8539805980518, 354.0793935767006, 5332.773462103719, 5418.241446197536, 5433.91849122263, 5536.169574563813, 5546.500814926656, 5471.616986810925, 5474.534664553507, 5529.281193444846, 5534.948359811643, 5548.250986116873, 4292.463442069741, 4296.419983302261, 4319.82720691172, 4344.652427805784, 4365.847195348163, 4189.183109293689, 4293.205756934962, 4307.978460107695, 4340.0, 4362.803673834669, 4260.893477663052, 4265.189613973335, 4271.103068355649, 4279.03721662625, 4302.290122129845, 4255.6169944705125, 4302.849400270991, 4309.806058727349, 4313.439252897103, 4315.82736690532, 3658.2500587379523, 3789.2989796887387, 3812.4471951567143, 3812.752171108869, 3817.4464702618243, 5366.248725178478, 5369.382521010056, 5371.140617501181, 5418.376886658006, 5426.321709786277, 4892.290617860391, 4907.214845624683, 4912.189488734354, 4924.335214745999, 4926.605871530269, 5568.1091025435735, 5708.457696518824, 5718.59969802114, 5764.74058667361, 5794.88410231793, 4102.897427564305, 4119.464469618961, 4123.752574845519, 4128.256913755523, 4141.544430112685, 6063.998320831172, 6068.939310606882, 6073.848153796146, 6080.726367313481, 6093.238345206849, 4073.674106071507, 4252.149570085995, 4256.446661933991, 4271.252530807096, 4277.871663850089, 4276.465441819772, 4282.80727367263, 4291.163223171452, 4292.098659281523, 4303.33298338758, 4916.861165392994, 4927.43334516528, 4935.90128197434, 4937.0, 4972.303877457159, 5701.258836351248, 5821.544613846539, 5861.6189947653265, 5866.2960444746905, 5882.529397648178, 1455.4178328668618, 1478.2313197137428, 1478.8521147885126, 1479.5561331600693, 1484.7327481053298, 959.2469911119738, 966.4394651102484, 992.4045572656348, 1000.6097621927454, 1008.4100801031332, 4883.951160488421, 4903.26451032348, 4905.492572810386, 4930.077269864755, 4961.603071754251, 5237.371515418175, 5277.340332458442, 5278.656887302313, 5301.356579460379, 5309.973450132802, 4610.893385587435, 4879.731614761222, 4907.3620429343955, 4940.728259945666, 4997.400311962515, 2665.200439868032, 2748.6151938728194, 2749.5188342040465, 2759.351552385188, 2776.680681721628, 5355.384130825005, 5367.087595108841, 5380.300560927054, 5403.513683768401, 5406.0, 5081.83117882889, 5229.398619158846, 5243.580513558906, 5266.7629956652045, 5296.788128474895, 5276.65701729394, 5278.076336641149, 5299.0, 5303.655262407931, 5307.840764777063, 5154.407243167084, 5179.8446046618665, 5192.948070519397, 5199.064168449564, 5212.270282160576, 4871.0, 5067.645264831426, 5081.5426611605135, 5083.542481176712, 5104.438511763778, 5281.260623512788, 5308.46915308466, 5311.760970756248, 5335.2263921730355, 5383.542398895981, 3908.9804550977065, 4063.146739184804, 4212.810423530887, 4284.935725964051, 4342.088161485997, 5832.24180856486, 5838.795642152504, 5868.559858010752, 5874.911876321773, 5884.764609415746, 5530.207245341077, 5622.184783206494, 5659.236607655863, 5686.516646085129, 5690.544756419559, 5640.379558248672, 5668.489835914787, 5686.090225564056, 5693.800716974886, 5701.629394089371, 5598.0, 5616.943830561642, 5660.207570940154, 5671.682065991441, 5694.629849059798, 5485.807996720096, 5746.0, 5761.107028410603, 5782.826515204551, 5829.795957141479, 5618.52242559387, 5645.322561292507, 5650.57620678459, 5658.321001479849, 5664.575156863334], "value": 4242.936664425423, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [733.1092722342353, 749.6139488163595, 759.2710997442455, 772.2586317135549, 810.7324582887647, 16577.171141442926, 17542.12289385532, 17576.209070591838, 17588.999999999985, 17597.296108155657, 15707.450239241629, 15870.285837137328, 15871.682566348665, 15871.84128158718, 15889.205539723025, 652.8237375908502, 779.7543773711262, 779.7582749347692, 791.5092642561591, 793.3811626931004, 798.3333916179997, 799.2407213147504, 801.4429971170039, 802.430274505102, 802.9638666260004, 845.3110714767445, 852.5140669818206, 853.9658413663446, 854.6752234151014, 854.747849384433, 848.855694531931, 849.0702680564772, 849.5412477262271, 849.583703985046, 849.6219182463775, 617.0713076819403, 619.9008158694587, 620.5035971223003, 620.8106527509108, 621.1583304622262, 15737.0, 15787.92106039474, 15801.683966320725, 15836.0, 15845.207739612973, 13322.933385333012, 14156.646083847883, 14292.071015383966, 15975.520734377988, 15984.360625574964, 13288.468461261538, 13452.0, 13718.588442346645, 13887.722245555033, 14049.157050576998, 4523.321501774727, 4548.2495388260895, 4574.977125114387, 4634.265783187901, 4656.743879086649, 86965.56517217374, 87309.0, 87391.56304218502, 89738.0, 89845.55077224573, 11279.605213817642, 11674.299542027506, 11737.765244695058, 12076.396180190955, 12433.502659893684, 21571.892140539512, 21785.346439606838, 21869.12523499074, 21872.12511499554, 21936.0, 8284.378671599654, 8438.198371154731, 8443.915560844312, 8477.830443391098, 8478.74563763088, 4835.129676658235, 4981.227909674007, 4986.376702912136, 5069.746512674352, 5138.049460849755, 3710.220853620716, 3775.5091838061426, 3807.923841523154, 3827.7129215308964, 3847.826847791856, 646.8447572582546, 648.6821457485893, 651.3519048546726, 662.0730976632752, 670.7954074007474, 553.3802141601432, 597.8116893178635, 598.9580729348904, 631.8072987738692, 673.9452756436161, 9460.8785243011, 9599.664011759554, 9671.564779584936, 9709.223262139012, 9947.751306217402, 660.9669516524154, 686.4062585863193, 698.1099098649263, 699.0807088678372, 704.17259719829, 4032.5765794591143, 4049.2913740095955, 4331.848385306562, 4433.312836510346, 4573.47405048417, 114528.0, 126178.36910815387, 126375.0, 131238.0, 132367.0289891305, 59837.70081149566, 60956.39043609596, 64018.67990660017, 87421.0, 105660.47169764101, 100384.0, 100562.0, 100980.49509752404, 103237.0, 103774.0, 8262.967129108862, 8400.663973441238, 8502.74491765248, 8648.610812513327, 8757.518336491554, 41442.58557414387, 56062.71968640131, 56355.0, 58026.129608056755, 58178.7091064542, 77639.0, 80208.0, 82320.58839706003, 83599.5820020896, 83935.0, 11580.0, 11736.413179341169, 11798.823017654913, 11819.763604728028, 11996.100292477924, 13245.27151006704, 13267.734645306848, 13378.331083445983, 13426.098727461873, 13894.722105558034, 12123.454444550192, 12345.197562158432, 12499.187552809039, 12555.87444125547, 12613.864752172349, 12311.322877241837, 12539.435725392561, 13054.08621396493, 13082.869171308546, 13266.071375003658, 12284.815727763911, 12510.624681259576, 12665.936670316589, 12718.554850580185, 13029.413676384775, 10064.44645544502, 10188.847167292644, 10200.897991019994, 10546.525406356579, 11132.220744547803, 10932.289401188897, 11677.824832627688, 11789.292642441482, 11930.880691193324, 12385.62843114708], "value": 7597.203847936961, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1544.1000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 112.0, 108.0, 111.0, 112.0, 112.0, 117.0, 111.0, 111.0, 112.0], "value": 111.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 124.0, 153.0, 176.0, 120.0, 148.0, 152.0, 124.0, 181.0, 119.0], "value": 145.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 162.0, 162.0, 161.0, 164.0, 168.0, 162.0, 163.0, 163.0], "value": 163.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 77.0, 186.0, 76.0, 77.0, 76.0, 75.0, 175.0, 77.0], "value": 97.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 151.0, 87.0, 85.0, 85.0, 140.0, 85.0, 86.0, 147.0], "value": 103.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 119.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 119.0, 117.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 149.0, 147.0, 146.0, 147.0, 147.0, 148.0, 147.0, 148.0], "value": 147.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 97.0, 95.0, 96.0, 95.0, 96.0, 95.0, 96.0, 96.0, 96.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 51.0, 57.0, 51.0, 52.0, 65.0, 52.0, 51.0, 51.0, 57.0], "value": 53.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 63.0, 62.0, 62.0, 62.0, 61.0, 62.0, 62.0, 62.0], "value": 62.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 84.0, 81.0, 89.0, 84.0, 90.0, 80.0, 87.0, 79.0], "value": 84.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 138.0, 128.0, 127.0, 134.0, 124.0, 127.0, 125.0, 151.0, 135.0], "value": 131.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 169.0, 167.0, 164.0, 167.0, 168.0, 168.0, 167.0, 168.0, 164.0], "value": 166.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 64.0, 69.0, 64.0, 65.0, 64.0, 65.0, 64.0, 64.0, 64.0], "value": 65.2, "unit": "score"}]}]} 20:55:01 INFO - Return code: 0 20:55:01 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 20:55:01 ERROR - # TBPL SUCCESS # 20:55:01 INFO - Running post-action listener: _resource_record_post_action 20:55:01 INFO - [mozharness: 2016-08-13 03:55:01.948683Z] Finished run-tests step (success) 20:55:01 INFO - Running post-run listener: _resource_record_post_run 20:55:02 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 8192; Write bytes: 408371200; Read time: 240; Write time: 386708 20:55:02 INFO - TinderboxPrint: CPU usage
13.4% 20:55:02 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 240 20:55:02 INFO - TinderboxPrint: I/O write bytes / time
408,371,200 / 386,708 20:55:02 INFO - TinderboxPrint: CPU idle
8,234.3 (86.6%) 20:55:02 INFO - TinderboxPrint: CPU user
1,218.0 (12.8%) 20:55:02 INFO - TinderboxPrint: Swap in / out
0 / 0 20:55:02 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 4096; Write bytes: 117592064; Read time: 132; Write time: 120372 20:55:02 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 4096; Write bytes: 290304000; Read time: 108; Write time: 266292 20:55:02 INFO - Running post-run listener: _upload_blobber_files 20:55:02 INFO - Blob upload gear active. 20:55:02 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:55:02 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 20:55:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 20:55:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 20:55:02 INFO - (blobuploader) - INFO - Open directory for files ... 20:55:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 20:55:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:55:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:55:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 20:55:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:55:03 INFO - (blobuploader) - INFO - Done attempting. 20:55:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:55:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:55:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:55:07 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:55:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:55:07 INFO - (blobuploader) - INFO - Done attempting. 20:55:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 20:55:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:55:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:55:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 20:55:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:55:08 INFO - (blobuploader) - INFO - Done attempting. 20:55:08 INFO - (blobuploader) - INFO - Iteration through files over. 20:55:08 INFO - Return code: 0 20:55:08 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:55:08 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:55:08 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2daf1f22fa3341e683319273f572d4c217363f25507ae0dcf6d754489453f19e84cd9dd6aa9f00489a32ede18bfd431269c6ffc6c67b6f58c9a3f3ce23ea4bfc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6686faca20ab4ee6d451a73d0bb2cd430f5c8c5bc0ee80ce5ed84be6b81b435baea18688303d2616e1c1e25a03054fdc718dc2a005ae7d85f84a6beb69afc609", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/67e5c3d2da7a3abae8fe84c1481f077bdf602cb84d208907d59d8b02c9d1f3656fa49ada1862a6c7d2a9039e18e152f830ec862e15f9fa1e63368a8c7d3337dc"} 20:55:08 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:55:08 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:55:08 INFO - Contents: 20:55:08 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2daf1f22fa3341e683319273f572d4c217363f25507ae0dcf6d754489453f19e84cd9dd6aa9f00489a32ede18bfd431269c6ffc6c67b6f58c9a3f3ce23ea4bfc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6686faca20ab4ee6d451a73d0bb2cd430f5c8c5bc0ee80ce5ed84be6b81b435baea18688303d2616e1c1e25a03054fdc718dc2a005ae7d85f84a6beb69afc609", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/67e5c3d2da7a3abae8fe84c1481f077bdf602cb84d208907d59d8b02c9d1f3656fa49ada1862a6c7d2a9039e18e152f830ec862e15f9fa1e63368a8c7d3337dc"} 20:55:08 INFO - Running post-run listener: copy_logs_to_upload_dir 20:55:08 INFO - Copying logs to upload dir... 20:55:08 INFO - mkdir: /builds/slave/test/build/upload/logs 20:55:08 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.820918 ========= master_lag: 1.79 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-08-12 20:55:09.643362) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-12 20:55:09.647038) ========= 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=a0d2d2de893abaa8702a9954000001a7-1471059225.105527-494328540 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2daf1f22fa3341e683319273f572d4c217363f25507ae0dcf6d754489453f19e84cd9dd6aa9f00489a32ede18bfd431269c6ffc6c67b6f58c9a3f3ce23ea4bfc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6686faca20ab4ee6d451a73d0bb2cd430f5c8c5bc0ee80ce5ed84be6b81b435baea18688303d2616e1c1e25a03054fdc718dc2a005ae7d85f84a6beb69afc609", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/67e5c3d2da7a3abae8fe84c1481f077bdf602cb84d208907d59d8b02c9d1f3656fa49ada1862a6c7d2a9039e18e152f830ec862e15f9fa1e63368a8c7d3337dc"} build_url:https://queue.taskcluster.net/v1/task/dEUXn0EdTxmP3attTspuxA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011235 build_url: 'https://queue.taskcluster.net/v1/task/dEUXn0EdTxmP3attTspuxA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2daf1f22fa3341e683319273f572d4c217363f25507ae0dcf6d754489453f19e84cd9dd6aa9f00489a32ede18bfd431269c6ffc6c67b6f58c9a3f3ce23ea4bfc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6686faca20ab4ee6d451a73d0bb2cd430f5c8c5bc0ee80ce5ed84be6b81b435baea18688303d2616e1c1e25a03054fdc718dc2a005ae7d85f84a6beb69afc609", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/67e5c3d2da7a3abae8fe84c1481f077bdf602cb84d208907d59d8b02c9d1f3656fa49ada1862a6c7d2a9039e18e152f830ec862e15f9fa1e63368a8c7d3337dc"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-12 20:55:09.676245) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-12 20:55:09.676623) ========= 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=a0d2d2de893abaa8702a9954000001a7-1471059225.105527-494328540 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004491 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-12 20:55:09.726437) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-12 20:55:09.726787) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-12 20:55:09.868564) ========= ========= Total master_lag: 2.28 =========