builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-035 starttime: 1471059268.2 results: success (0) buildid: 20160812173001 builduid: a3f208ba48c746d989153be67641dbaa revision: 1ba6215e84c3b34b928898331c3d444b3dd96ee3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-12 20:34:28.195897) ========= 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:28.196390) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-12 20:34:28.196966) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-12 20:34:28.237332) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-12 20:34:28.237661) ========= 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=ed14279e38b05397cf4aa391000001a4-1471059002.348362-85883166 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-12 20:34:29-- 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% 19.7M=0.001s 2016-08-12 20:34:29 (19.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.087090 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-12 20:34:28.340290) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-12 20:34:28.340647) ========= 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=ed14279e38b05397cf4aa391000001a4-1471059002.348362-85883166 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017294 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-12 20:34:28.391393) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-12 20:34:28.391748) ========= 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=ed14279e38b05397cf4aa391000001a4-1471059002.348362-85883166 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-12 20:34:29,910 truncating revision to first 12 chars 2016-08-12 20:34:29,910 Setting DEBUG logging. 2016-08-12 20:34:29,910 attempt 1/10 2016-08-12 20:34:29,910 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:30,175 unpacking tar archive at: fx-team-1ba6215e84c3/testing/mozharness/ program finished with exit code 0 elapsedTime=0.655859 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-12 20:34:29.062034) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-12 20:34:29.062406) ========= script_repo_revision: 1ba6215e84c3b34b928898331c3d444b3dd96ee3 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-12 20:34:29.062914) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-12 20:34:29.063236) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-12 20:34:29.074036) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-08-12 20:34:29.074511) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=ed14279e38b05397cf4aa391000001a4-1471059002.348362-85883166 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:34:30 INFO - MultiFileLogger online at 20160812 20:34:30 in /builds/slave/test 20:34:30 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --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:30 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:34:30 INFO - {'append_to_log': False, 20:34:30 INFO - 'base_work_dir': '/builds/slave/test', 20:34:30 INFO - 'blob_upload_branch': 'Fx-Team', 20:34:30 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:34:30 INFO - 'branch': 'Fx-Team', 20:34:30 INFO - 'buildbot_json_path': 'buildprops.json', 20:34:30 INFO - 'config_files': ('talos/linux_config.py',), 20:34:30 INFO - 'default_actions': ('clobber', 20:34:30 INFO - 'read-buildbot-config', 20:34:30 INFO - 'download-and-extract', 20:34:30 INFO - 'populate-webroot', 20:34:30 INFO - 'create-virtualenv', 20:34:30 INFO - 'install', 20:34:30 INFO - 'run-tests'), 20:34:30 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:34:30 INFO - 'download_minidump_stackwalk': True, 20:34:30 INFO - 'download_symbols': 'ondemand', 20:34:30 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:34:30 INFO - 'tooltool.py': '/tools/tooltool.py', 20:34:30 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:34:30 INFO - '/tools/misc-python/virtualenv.py')}, 20:34:30 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:34:30 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:34:30 INFO - 'installer_path': 'installer.exe', 20:34:30 INFO - 'log_level': 'info', 20:34:30 INFO - 'log_name': 'talos', 20:34:30 INFO - 'log_to_console': True, 20:34:30 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:34:30 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:34:30 INFO - 'opt_config_files': (), 20:34:30 INFO - 'pip_index': False, 20:34:30 INFO - 'sps_profile': False, 20:34:30 INFO - 'sps_profile_interval': 0, 20:34:30 INFO - 'suite': 'dromaeojs', 20:34:30 INFO - 'system_bits': '32', 20:34:30 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:34:30 INFO - 'title': 'talos-linux64-ix-035', 20:34:30 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:34:30 INFO - 'use_talos_json': True, 20:34:30 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:34:30 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:34:30 INFO - 'work_dir': 'build'} 20:34:30 INFO - [mozharness: 2016-08-13 03:34:30.683100Z] Running clobber step. 20:34:30 INFO - Running pre-action listener: _resource_record_pre_action 20:34:30 INFO - Running main action method: clobber 20:34:30 INFO - rmtree: /builds/slave/test/build 20:34:30 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:34:31 INFO - Running post-action listener: _resource_record_post_action 20:34:31 INFO - [mozharness: 2016-08-13 03:34:31.148288Z] Finished clobber step (success) 20:34:31 INFO - [mozharness: 2016-08-13 03:34:31.148387Z] Running read-buildbot-config step. 20:34:31 INFO - Running pre-action listener: _resource_record_pre_action 20:34:31 INFO - Running main action method: read_buildbot_config 20:34:31 INFO - Using buildbot properties: 20:34:31 INFO - { 20:34:31 INFO - "project": "", 20:34:31 INFO - "product": "firefox", 20:34:31 INFO - "script_repo_revision": "production", 20:34:31 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 20:34:31 INFO - "repository": "", 20:34:31 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 20:34:31 INFO - "buildid": "20160812173001", 20:34:31 INFO - "pgo_build": "True", 20:34:31 INFO - "basedir": "/builds/slave/test", 20:34:31 INFO - "buildnumber": 1453, 20:34:31 INFO - "slavename": "talos-linux64-ix-035", 20:34:31 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 20:34:31 INFO - "platform": "ubuntu64_hw", 20:34:31 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 20:34:31 INFO - "branch": "fx-team", 20:34:31 INFO - "repo_path": "integration/fx-team", 20:34:31 INFO - "revision": "1ba6215e84c3b34b928898331c3d444b3dd96ee3", 20:34:31 INFO - "stage_platform": "linux64-pgo", 20:34:31 INFO - "builduid": "a3f208ba48c746d989153be67641dbaa", 20:34:31 INFO - "slavebuilddir": "test" 20:34:31 INFO - } 20:34:31 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:31 INFO - Running post-action listener: _resource_record_post_action 20:34:31 INFO - [mozharness: 2016-08-13 03:34:31.150799Z] Finished read-buildbot-config step (success) 20:34:31 INFO - [mozharness: 2016-08-13 03:34:31.150887Z] Running download-and-extract step. 20:34:31 INFO - Running pre-action listener: _resource_record_pre_action 20:34:31 INFO - Running main action method: download_and_extract 20:34:31 INFO - mkdir: /builds/slave/test/build/tests 20:34:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:34:31 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:31 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:31 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:31 INFO - Downloaded 1361 bytes. 20:34:31 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 20:34:31 INFO - Using the following test package requirements: 20:34:31 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 20:34:31 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 20:34:31 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 20:34:31 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 20:34:31 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 20:34:31 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 20:34:31 INFO - u'jsshell-linux-x86_64.zip'], 20:34:31 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 20:34:31 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 20:34:31 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 20:34:31 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 20:34:31 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 20:34:31 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 20:34:31 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 20:34:31 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 20:34:31 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 20:34:31 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 20:34:31 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 20:34:31 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 20:34:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:34:31 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:31 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:31 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:33 INFO - Downloaded 21834639 bytes. 20:34:33 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:37 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:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:34:37 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:37 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:37 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:38 INFO - Downloaded 21834639 bytes. 20:34:38 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:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:34:43 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:43 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:43 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: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.tar.bz2 20:34:44 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:44 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:45 INFO - Downloaded 59405109 bytes. 20:34:45 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:45 INFO - mkdir: /builds/slave/test/properties 20:34:45 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:34:45 INFO - Writing to file /builds/slave/test/properties/build_url 20:34:45 INFO - Contents: 20:34:45 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:46 INFO - Running post-action listener: _resource_record_post_action 20:34:46 INFO - Running post-action listener: set_extra_try_arguments 20:34:46 INFO - [mozharness: 2016-08-13 03:34:46.490785Z] Finished download-and-extract step (success) 20:34:46 INFO - [mozharness: 2016-08-13 03:34:46.491008Z] Running populate-webroot step. 20:34:46 INFO - Running pre-action listener: _resource_record_pre_action 20:34:46 INFO - Running main action method: populate_webroot 20:34:46 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:34:46 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:34:46 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:34:46 INFO - '--tppagecycles', 20:34:46 INFO - '7'], 20:34:46 INFO - 'tests': ['tsvgm']}}, 20:34:46 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:34:46 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:34:46 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:34:46 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:34:46 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:34:46 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:34:46 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:34:46 INFO - 'talos_options': ['--disable-e10s'], 20:34:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:34:46 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:34:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:34:46 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:34:46 INFO - 'talos_options': ['--disable-e10s'], 20:34:46 INFO - 'tests': ['damp', 'tps']}, 20:34:46 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:34:46 INFO - 'tests': ['damp', 'tps']}, 20:34:46 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:34:46 INFO - 'tests': ['dromaeo_dom']}, 20:34:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:34:46 INFO - 'g4': {'talos_options': ['--disable-e10s'], 20:34:46 INFO - 'tests': ['basic_compositor_video']}, 20:34:46 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 20:34:46 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:34:46 INFO - 'tests': ['a11yr', 20:34:46 INFO - 'ts_paint', 20:34:46 INFO - 'tpaint', 20:34:46 INFO - 'sessionrestore', 20:34:46 INFO - 'sessionrestore_no_auto_restore', 20:34:46 INFO - 'tabpaint']}, 20:34:46 INFO - 'other-e10s': {'tests': ['a11yr', 20:34:46 INFO - 'ts_paint', 20:34:46 INFO - 'tpaint', 20:34:46 INFO - 'sessionrestore', 20:34:46 INFO - 'sessionrestore_no_auto_restore', 20:34:46 INFO - 'tabpaint']}, 20:34:46 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:34:46 INFO - 'ts_paint', 20:34:46 INFO - 'tpaint', 20:34:46 INFO - 'sessionrestore', 20:34:46 INFO - 'sessionrestore_no_auto_restore', 20:34:46 INFO - 'tabpaint']}, 20:34:46 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:34:46 INFO - 'ts_paint', 20:34:46 INFO - 'tpaint', 20:34:46 INFO - 'sessionrestore', 20:34:46 INFO - 'sessionrestore_no_auto_restore', 20:34:46 INFO - 'tabpaint']}, 20:34:46 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:34:46 INFO - 'tests': ['a11yr', 20:34:46 INFO - 'ts_paint', 20:34:46 INFO - 'tpaint', 20:34:46 INFO - 'sessionrestore', 20:34:46 INFO - 'sessionrestore_no_auto_restore', 20:34:46 INFO - 'tabpaint']}, 20:34:46 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:34:46 INFO - 'tests': ['a11yr', 20:34:46 INFO - 'ts_paint', 20:34:46 INFO - 'tpaint', 20:34:46 INFO - 'sessionrestore', 20:34:46 INFO - 'sessionrestore_no_auto_restore', 20:34:46 INFO - 'tabpaint']}, 20:34:46 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:34:46 INFO - 'tests': ['tsvgx', 20:34:46 INFO - 'tsvgr_opacity', 20:34:46 INFO - 'tart', 20:34:46 INFO - 'tscrollx', 20:34:46 INFO - 'cart']}, 20:34:46 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:34:46 INFO - 'tsvgr_opacity', 20:34:46 INFO - 'tart', 20:34:46 INFO - 'tscrollx', 20:34:46 INFO - 'cart']}, 20:34:46 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:34:46 INFO - 'talos_options': ['--disable-e10s'], 20:34:46 INFO - 'tests': ['tp5o']}, 20:34:46 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:34:46 INFO - 'tests': ['tp5o']}, 20:34:46 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:34:46 INFO - 'talos_options': ['--disable-e10s', 20:34:46 INFO - '--xperf_path', 20:34:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:34:46 INFO - 'tests': ['tp5n']}, 20:34:46 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:34:46 INFO - 'talos_options': ['--xperf_path', 20:34:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:34:46 INFO - 'tests': ['tp5n']}}, 20:34:46 INFO - 'talos.zip': {'path': '', 20:34:46 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:34:46 INFO - Running post-action listener: _resource_record_post_action 20:34:46 INFO - [mozharness: 2016-08-13 03:34:46.508324Z] Finished populate-webroot step (success) 20:34:46 INFO - [mozharness: 2016-08-13 03:34:46.508411Z] Running create-virtualenv step. 20:34:46 INFO - Running pre-action listener: _resource_record_pre_action 20:34:46 INFO - Running main action method: create_virtualenv 20:34:46 INFO - Creating virtualenv /builds/slave/test/build/venv 20:34:46 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:46 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:34:46 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:34:46 INFO - Using real prefix '/usr' 20:34:46 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 0x7f957cdc1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fc58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2092850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x208d370>, '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 0x20908f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2090d80>, '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': 'ed14279e38b05397cf4aa391000001a4-1471059002.348362-85883166', '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': 'ed14279e38b05397cf4aa391000001a4-1471059002.348362-85883166', 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 0x7f957cdc1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fc58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2092850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x208d370>, '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 0x20908f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2090d80>, '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': 'ed14279e38b05397cf4aa391000001a4-1471059002.348362-85883166', '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': 'ed14279e38b05397cf4aa391000001a4-1471059002.348362-85883166', 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 - Downloading/unpacking psutil>=3.1.1 20:34:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:34:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:34:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:34:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:34:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:34:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:34:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:34:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:34:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:34:51 INFO - Installing collected packages: psutil 20:34:51 INFO - Running setup.py install for psutil 20:34:51 INFO - building 'psutil._psutil_linux' extension 20:34:51 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:51 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:51 INFO - building 'psutil._psutil_posix' extension 20:34:51 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:51 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:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:34:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:34:51 INFO - Successfully installed psutil 20:34:51 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 0x7f957cdc1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fc58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2092850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x208d370>, '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 0x20908f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2090d80>, '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': 'ed14279e38b05397cf4aa391000001a4-1471059002.348362-85883166', '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': 'ed14279e38b05397cf4aa391000001a4-1471059002.348362-85883166', 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:54 INFO - Return code: 0 20:34:54 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 20:34:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:34:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:34:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:34:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:34:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:34:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:34:54 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 0x7f957cdc1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fc58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2092850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x208d370>, '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 0x20908f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2090d80>, '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': 'ed14279e38b05397cf4aa391000001a4-1471059002.348362-85883166', '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:54 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:54 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:54 INFO - Using env: {'DISPLAY': ':0', 20:34:54 INFO - 'HOME': '/home/cltbld', 20:34:54 INFO - 'LANG': 'en_US.UTF-8', 20:34:54 INFO - 'LANGUAGE': 'en_US:en', 20:34:54 INFO - 'LOGNAME': 'cltbld', 20:34:54 INFO - 'MAIL': '/var/mail/cltbld', 20:34:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:34:54 INFO - 'MOZ_NO_REMOTE': '1', 20:34:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:34:54 INFO - 'NO_EM_RESTART': '1', 20:34:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:34:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:34:54 INFO - 'PWD': '/builds/slave/test', 20:34:54 INFO - 'SHELL': '/bin/bash', 20:34:54 INFO - 'SHLVL': '1', 20:34:54 INFO - 'TERM': 'linux', 20:34:54 INFO - 'TMOUT': '86400', 20:34:54 INFO - 'USER': 'cltbld', 20:34:54 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1471059002.348362-85883166', 20:34:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:34:54 INFO - '_': '/tools/buildbot/bin/python'} 20:34:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:34:54 INFO - Downloading/unpacking jsonschema==2.5.1 20:34:54 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:54 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 - 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:54 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:54 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:54 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:56 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:34:56 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 20:34:56 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:56 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:56 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:56 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:56 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:56 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:56 INFO - Downloading functools32-3.2.3-2.tar.gz 20:34:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:34:56 INFO - warning: no files found matching '*.txt' 20:34:56 INFO - no previously-included directories found matching 'build' 20:34:56 INFO - no previously-included directories found matching 'dist' 20:34:56 INFO - no previously-included directories found matching '.git*' 20:34:56 INFO - Installing collected packages: jsonschema, functools32 20:34:56 INFO - Running setup.py install for functools32 20:34:56 INFO - warning: no files found matching '*.txt' 20:34:56 INFO - no previously-included directories found matching 'build' 20:34:56 INFO - no previously-included directories found matching 'dist' 20:34:56 INFO - no previously-included directories found matching '.git*' 20:34:56 INFO - Successfully installed jsonschema functools32 20:34:56 INFO - Cleaning up... 20:34:56 INFO - Return code: 0 20:34:56 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 20:34:56 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:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:34:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:34:56 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:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:34:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:34:56 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 0x7f957cdc1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fc58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2092850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x208d370>, '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 0x20908f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2090d80>, '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': 'ed14279e38b05397cf4aa391000001a4-1471059002.348362-85883166', '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:56 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:56 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:56 INFO - Using env: {'DISPLAY': ':0', 20:34:56 INFO - 'HOME': '/home/cltbld', 20:34:56 INFO - 'LANG': 'en_US.UTF-8', 20:34:56 INFO - 'LANGUAGE': 'en_US:en', 20:34:56 INFO - 'LOGNAME': 'cltbld', 20:34:56 INFO - 'MAIL': '/var/mail/cltbld', 20:34:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:34:56 INFO - 'MOZ_NO_REMOTE': '1', 20:34:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:34:56 INFO - 'NO_EM_RESTART': '1', 20:34:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:34:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:34:56 INFO - 'PWD': '/builds/slave/test', 20:34:56 INFO - 'SHELL': '/bin/bash', 20:34:56 INFO - 'SHLVL': '1', 20:34:56 INFO - 'TERM': 'linux', 20:34:56 INFO - 'TMOUT': '86400', 20:34:56 INFO - 'USER': 'cltbld', 20:34:56 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1471059002.348362-85883166', 20:34:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:34:56 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 0x7f957cdc1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fc58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2092850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x208d370>, '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 0x20908f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2090d80>, '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': 'ed14279e38b05397cf4aa391000001a4-1471059002.348362-85883166', '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': 'ed14279e38b05397cf4aa391000001a4-1471059002.348362-85883166', 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 - Downloading/unpacking blobuploader==1.2.4 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: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:34:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:34:59 INFO - Downloading/unpacking docopt==0.6.1 (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:34:59 INFO - Downloading docopt-0.6.1.tar.gz 20:34:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:34:59 INFO - Installing collected packages: blobuploader, requests, docopt 20:34:59 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:00 INFO - Running setup.py install for docopt 20:35:00 INFO - Successfully installed blobuploader requests docopt 20:35:00 INFO - Cleaning up... 20:35:00 INFO - Return code: 0 20:35:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:35:00 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:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:35:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:35:00 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:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:35:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:35:00 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 0x7f957cdc1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fc58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2092850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x208d370>, '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 0x20908f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2090d80>, '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': 'ed14279e38b05397cf4aa391000001a4-1471059002.348362-85883166', '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:00 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:00 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:00 INFO - Using env: {'DISPLAY': ':0', 20:35:00 INFO - 'HOME': '/home/cltbld', 20:35:00 INFO - 'LANG': 'en_US.UTF-8', 20:35:00 INFO - 'LANGUAGE': 'en_US:en', 20:35:00 INFO - 'LOGNAME': 'cltbld', 20:35:00 INFO - 'MAIL': '/var/mail/cltbld', 20:35:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:35:00 INFO - 'MOZ_NO_REMOTE': '1', 20:35:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:35:00 INFO - 'NO_EM_RESTART': '1', 20:35:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:35:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:35:00 INFO - 'PWD': '/builds/slave/test', 20:35:00 INFO - 'SHELL': '/bin/bash', 20:35:00 INFO - 'SHLVL': '1', 20:35:00 INFO - 'TERM': 'linux', 20:35:00 INFO - 'TMOUT': '86400', 20:35:00 INFO - 'USER': 'cltbld', 20:35:00 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1471059002.348362-85883166', 20:35:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:35:00 INFO - '_': '/tools/buildbot/bin/python'} 20:35:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:35:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:35:00 INFO - Running setup.py (path:/tmp/pip-ROqDf8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:35:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:35:00 INFO - Running setup.py (path:/tmp/pip-viQSK4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:35:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:35:00 INFO - Running setup.py (path:/tmp/pip-oVE3Eb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:35:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:35:00 INFO - Running setup.py (path:/tmp/pip-mVM9uk-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-1iQnu3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:35:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:35:01 INFO - Running setup.py (path:/tmp/pip-o4IPwf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:35:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:35:01 INFO - Running setup.py (path:/tmp/pip-cd7L9f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:35:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:35:01 INFO - Running setup.py (path:/tmp/pip-3qUy2t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:35:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:35:01 INFO - Running setup.py (path:/tmp/pip-ea2RNB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:35:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:35:01 INFO - Running setup.py (path:/tmp/pip-0G0cHR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:35:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:35:01 INFO - Running setup.py (path:/tmp/pip-yzBR16-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:35:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:35:01 INFO - Running setup.py (path:/tmp/pip-XRx6G6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:35:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:35:01 INFO - Running setup.py (path:/tmp/pip-WnooUb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:35:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:35:01 INFO - Running setup.py (path:/tmp/pip-wGUgY6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:35:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:35:01 INFO - Running setup.py (path:/tmp/pip-X2Bdj2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:35:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:35:01 INFO - Running setup.py (path:/tmp/pip-BndELm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:35:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:35:01 INFO - Running setup.py (path:/tmp/pip-WYF5CS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:35:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:35:01 INFO - Running setup.py install for manifestparser 20:35:02 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:35:02 INFO - Running setup.py install for mozcrash 20:35:02 INFO - Running setup.py install for mozdebug 20:35:02 INFO - Running setup.py install for mozdevice 20:35:02 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:35:02 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:35:02 INFO - Running setup.py install for mozfile 20:35:02 INFO - Running setup.py install for mozhttpd 20:35:02 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:35:02 INFO - Running setup.py install for mozinfo 20:35:02 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:35:02 INFO - Running setup.py install for mozInstall 20:35:02 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:35:02 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:35:02 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:35:02 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:35:02 INFO - Running setup.py install for mozleak 20:35:02 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:03 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:35:03 INFO - Running setup.py install for mozprocess 20:35:03 INFO - Running setup.py install for mozprofile 20:35:03 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:35:03 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:35:03 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:35:03 INFO - Running setup.py install for mozrunner 20:35:03 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:35:03 INFO - Running setup.py install for mozscreenshot 20:35:03 INFO - Running setup.py install for moztest 20:35:03 INFO - Running setup.py install for mozversion 20:35:03 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:35:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:35:03 INFO - Cleaning up... 20:35:03 INFO - Return code: 0 20:35:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:35:03 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:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:35:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:35:03 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:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:35:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:35:03 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 0x7f957cdc1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fc58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2092850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x208d370>, '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 0x20908f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2090d80>, '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': 'ed14279e38b05397cf4aa391000001a4-1471059002.348362-85883166', '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:03 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:03 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:03 INFO - Using env: {'DISPLAY': ':0', 20:35:03 INFO - 'HOME': '/home/cltbld', 20:35:03 INFO - 'LANG': 'en_US.UTF-8', 20:35:03 INFO - 'LANGUAGE': 'en_US:en', 20:35:03 INFO - 'LOGNAME': 'cltbld', 20:35:03 INFO - 'MAIL': '/var/mail/cltbld', 20:35:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:35:03 INFO - 'MOZ_NO_REMOTE': '1', 20:35:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:35:03 INFO - 'NO_EM_RESTART': '1', 20:35:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:35:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:35:03 INFO - 'PWD': '/builds/slave/test', 20:35:03 INFO - 'SHELL': '/bin/bash', 20:35:03 INFO - 'SHLVL': '1', 20:35:03 INFO - 'TERM': 'linux', 20:35:03 INFO - 'TMOUT': '86400', 20:35:03 INFO - 'USER': 'cltbld', 20:35:03 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1471059002.348362-85883166', 20:35:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:35:03 INFO - '_': '/tools/buildbot/bin/python'} 20:35:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:35:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:35:03 INFO - Running setup.py (path:/tmp/pip-FAboKz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:35:04 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:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:35:04 INFO - Running setup.py (path:/tmp/pip-P_pXIk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:35:04 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:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:35:04 INFO - Running setup.py (path:/tmp/pip-rczUP_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:35:04 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:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:35:04 INFO - Running setup.py (path:/tmp/pip-6jR22j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:35:04 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:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:35:04 INFO - Running setup.py (path:/tmp/pip-w1s9Hx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:35:04 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:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:35:04 INFO - Running setup.py (path:/tmp/pip-Ch7JZ0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:35:04 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:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:35:04 INFO - Running setup.py (path:/tmp/pip-9Id7hE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:35:04 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:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:35:04 INFO - Running setup.py (path:/tmp/pip-QT9fIQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:35:04 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:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:35:04 INFO - Running setup.py (path:/tmp/pip-HhXCpv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:35:04 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:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:35:04 INFO - Running setup.py (path:/tmp/pip-TYwv69-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:35:04 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:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:35:04 INFO - Running setup.py (path:/tmp/pip-oeSTia-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:35:04 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:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:35:04 INFO - Running setup.py (path:/tmp/pip-vdnLda-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:35:04 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:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:35:04 INFO - Running setup.py (path:/tmp/pip-fU8MU9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:35:04 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:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:35:04 INFO - Running setup.py (path:/tmp/pip-Jf7SuI-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-A5C3uj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:35:05 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:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:35:05 INFO - Running setup.py (path:/tmp/pip-mkDjGr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:35:05 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:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:35:05 INFO - Running setup.py (path:/tmp/pip-Z7sZx6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:35:05 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:05 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:05 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:05 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:05 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:05 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:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:35:05 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:05 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:05 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:05 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:05 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:05 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:07 INFO - Downloading blessings-1.6.tar.gz 20:35:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:35:07 INFO - Installing collected packages: blessings 20:35:07 INFO - Running setup.py install for blessings 20:35:07 INFO - Successfully installed blessings 20:35:07 INFO - Cleaning up... 20:35:07 INFO - Return code: 0 20:35:07 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:35:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:35:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:35:07 INFO - Reading from file tmpfile_stdout 20:35:07 INFO - Current package versions: 20:35:07 INFO - argparse == 1.2.1 20:35:07 INFO - blessings == 1.6 20:35:07 INFO - blobuploader == 1.2.4 20:35:07 INFO - docopt == 0.6.1 20:35:07 INFO - functools32 == 3.2.3-2 20:35:07 INFO - jsonschema == 2.5.1 20:35:07 INFO - manifestparser == 1.1 20:35:07 INFO - mozInstall == 1.12 20:35:07 INFO - mozcrash == 0.17 20:35:07 INFO - mozdebug == 0.1 20:35:07 INFO - mozdevice == 0.48 20:35:07 INFO - mozfile == 1.2 20:35:07 INFO - mozhttpd == 0.7 20:35:07 INFO - mozinfo == 0.9 20:35:07 INFO - mozleak == 0.1 20:35:07 INFO - mozlog == 3.3 20:35:07 INFO - moznetwork == 0.27 20:35:07 INFO - mozprocess == 0.23 20:35:07 INFO - mozprofile == 0.28 20:35:07 INFO - mozrunner == 6.12 20:35:07 INFO - mozscreenshot == 0.1 20:35:07 INFO - mozsystemmonitor == 0.3 20:35:07 INFO - moztest == 0.7 20:35:07 INFO - mozversion == 1.4 20:35:07 INFO - psutil == 3.1.1 20:35:07 INFO - requests == 1.2.3 20:35:07 INFO - wsgiref == 0.1.2 20:35:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:35:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:35:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:35:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:35:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:35:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:35:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:35:07 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 0x7f957cdc1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fc58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2092850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x208d370>, '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 0x20908f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2090d80>, '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': 'ed14279e38b05397cf4aa391000001a4-1471059002.348362-85883166', '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:07 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:07 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:07 INFO - Using env: {'DISPLAY': ':0', 20:35:07 INFO - 'HOME': '/home/cltbld', 20:35:07 INFO - 'LANG': 'en_US.UTF-8', 20:35:07 INFO - 'LANGUAGE': 'en_US:en', 20:35:07 INFO - 'LOGNAME': 'cltbld', 20:35:07 INFO - 'MAIL': '/var/mail/cltbld', 20:35:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:35:07 INFO - 'MOZ_NO_REMOTE': '1', 20:35:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:35:07 INFO - 'NO_EM_RESTART': '1', 20:35:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:35:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:35:07 INFO - 'PWD': '/builds/slave/test', 20:35:07 INFO - 'SHELL': '/bin/bash', 20:35:07 INFO - 'SHLVL': '1', 20:35:07 INFO - 'TERM': 'linux', 20:35:07 INFO - 'TMOUT': '86400', 20:35:07 INFO - 'USER': 'cltbld', 20:35:07 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1471059002.348362-85883166', 20:35:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:35:07 INFO - '_': '/tools/buildbot/bin/python'} 20:35:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:35:07 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:07 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:07 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:07 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:07 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:07 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:07 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:07 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:07 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:07 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:07 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:07 INFO - Cleaning up... 20:35:07 INFO - Return code: 0 20:35:07 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:35:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:35:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:35:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:35:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:35:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:35:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:35:07 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 0x7f957cdc1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fc58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2092850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x208d370>, '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 0x20908f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2090d80>, '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': 'ed14279e38b05397cf4aa391000001a4-1471059002.348362-85883166', '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:07 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:07 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:07 INFO - Using env: {'DISPLAY': ':0', 20:35:07 INFO - 'HOME': '/home/cltbld', 20:35:07 INFO - 'LANG': 'en_US.UTF-8', 20:35:07 INFO - 'LANGUAGE': 'en_US:en', 20:35:07 INFO - 'LOGNAME': 'cltbld', 20:35:07 INFO - 'MAIL': '/var/mail/cltbld', 20:35:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:35:07 INFO - 'MOZ_NO_REMOTE': '1', 20:35:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:35:07 INFO - 'NO_EM_RESTART': '1', 20:35:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:35:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:35:07 INFO - 'PWD': '/builds/slave/test', 20:35:07 INFO - 'SHELL': '/bin/bash', 20:35:07 INFO - 'SHLVL': '1', 20:35:07 INFO - 'TERM': 'linux', 20:35:07 INFO - 'TMOUT': '86400', 20:35:07 INFO - 'USER': 'cltbld', 20:35:07 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1471059002.348362-85883166', 20:35:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:35:07 INFO - '_': '/tools/buildbot/bin/python'} 20:35:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:35:07 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 20:35:07 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.029375Z] Finished create-virtualenv step (success) 20:35:08 INFO - [mozharness: 2016-08-13 03:35:08.029837Z] 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:08 INFO - Reading from file tmpfile_stdout 20:35:08 INFO - Detecting whether we're running mozinstall >=1.0... 20:35:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:35:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:35:08 INFO - Reading from file tmpfile_stdout 20:35:08 INFO - Output received: 20:35:08 INFO - Usage: mozinstall [options] installer 20:35:08 INFO - Options: 20:35:08 INFO - -h, --help show this help message and exit 20:35:08 INFO - -d DEST, --destination=DEST 20:35:08 INFO - Directory to install application into. [default: 20:35:08 INFO - "/builds/slave/test"] 20:35:08 INFO - --app=APP Application being installed. [default: firefox] 20:35:08 INFO - mkdir: /builds/slave/test/build/application 20:35:08 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:08 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:25 INFO - Reading from file tmpfile_stdout 20:35:25 INFO - Output received: 20:35:25 INFO - /builds/slave/test/build/application/firefox/firefox 20:35:25 INFO - Running post-action listener: _resource_record_post_action 20:35:25 INFO - [mozharness: 2016-08-13 03:35:25.835597Z] Finished install step (success) 20:35:25 INFO - [mozharness: 2016-08-13 03:35:25.835843Z] Running run-tests step. 20:35:25 INFO - Running pre-action listener: _resource_record_pre_action 20:35:25 INFO - Running main action method: run_tests 20:35:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:35:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:35:25 INFO - Python 2.7.3 20:35:25 INFO - Return code: 0 20:35:25 INFO - grabbing minidump binary from tooltool 20:35:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:35:25 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 0x208d370>, '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 0x20908f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2090d80>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:35:25 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:25 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:25 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:25 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:35:25 INFO - Return code: 0 20:35:25 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 20:35:25 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:35:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:35:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 20:35:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:35:25 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', '--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-035', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 20:35:25 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 --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-035 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 20:35:25 INFO - Using env: {'DISPLAY': ':0', 20:35:25 INFO - 'HOME': '/home/cltbld', 20:35:25 INFO - 'LANG': 'en_US.UTF-8', 20:35:25 INFO - 'LANGUAGE': 'en_US:en', 20:35:25 INFO - 'LOGNAME': 'cltbld', 20:35:25 INFO - 'MAIL': '/var/mail/cltbld', 20:35:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:35:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 20:35:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:35:25 INFO - 'MOZ_NO_REMOTE': '1', 20:35:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:35:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:35:25 INFO - 'NO_EM_RESTART': '1', 20:35:25 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:35:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:35:25 INFO - 'PWD': '/builds/slave/test', 20:35:25 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:35:25 INFO - 'SHELL': '/bin/bash', 20:35:25 INFO - 'SHLVL': '1', 20:35:25 INFO - 'TERM': 'linux', 20:35:25 INFO - 'TMOUT': '86400', 20:35:25 INFO - 'USER': 'cltbld', 20:35:25 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1471059002.348362-85883166', 20:35:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:35:25 INFO - '_': '/tools/buildbot/bin/python'} 20:35:25 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--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-035', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 20: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:49621' 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 18393 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAF4p64/profile http://localhost:49621/getInfo.html) 20:35:29 INFO - PROCESS | 18393 | __metrics Screen width/height:1600/1200 20:35:29 INFO - PROCESS | 18393 | colorDepth:24 20:35:29 INFO - PROCESS | 18393 | Browser inner width/height: 1024/697 20:35:29 INFO - PROCESS | 18393 | __metrics 20:35:30 INFO - PROCESS | 18393 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 20:35:30 INFO - PROCESS | 18393 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:35:31 INFO - TEST-INFO | 18393: exit 0 20:35:31 INFO - Browser initialized. 20:35:31 INFO - Running cycle 1/1 for dromaeo_css test... 20:35:31 INFO - TEST-INFO | started process 18474 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAF4p64/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:35:43 INFO - PROCESS | 18474 | RSS: Main: 156073984 20:35:43 INFO - PROCESS | 18474 | 20:36:35 INFO - PROCESS | 18474 | 1471059395191 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:44 INFO - PROCESS | 18474 | Cycle 1(1): loaded http://localhost:49621/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49621/tests/dromaeo/cssquery-ext.html) 20:38:45 INFO - PROCESS | 18474 | RSS: Main: 261816320 20:38:45 INFO - PROCESS | 18474 | 20:41:47 INFO - PROCESS | 18474 | Cycle 1(1): loaded http://localhost:49621/tests/dromaeo/cssquery-ext.html (next: http://localhost:49621/tests/dromaeo/cssquery-jquery.html) 20:41:48 INFO - PROCESS | 18474 | RSS: Main: 244305920 20:41:48 INFO - PROCESS | 18474 | 20:44:50 INFO - PROCESS | 18474 | Cycle 1(1): loaded http://localhost:49621/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49621/tests/dromaeo/cssquery-mootools.html) 20:44:51 INFO - PROCESS | 18474 | RSS: Main: 184721408 20:44:51 INFO - PROCESS | 18474 | 20:47:53 INFO - PROCESS | 18474 | Cycle 1(1): loaded http://localhost:49621/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49621/tests/dromaeo/cssquery-prototype.html) 20:47:53 INFO - PROCESS | 18474 | RSS: Main: 218005504 20:47:53 INFO - PROCESS | 18474 | 20:50:56 INFO - PROCESS | 18474 | Cycle 1(1): loaded http://localhost:49621/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49621/tests/dromaeo/cssquery-yui.html) 20:50:57 INFO - PROCESS | 18474 | RSS: Main: 184025088 20:50:57 INFO - PROCESS | 18474 | 20:53:59 INFO - PROCESS | 18474 | Cycle 1(1): loaded http://localhost:49621/tests/dromaeo/cssquery-yui.html (next: http://localhost:49621/tests/dromaeo/cssquery-dojo.html) 20:54:00 INFO - PROCESS | 18474 | RSS: Main: 258928640 20:54:00 INFO - PROCESS | 18474 | 20:54:00 INFO - PROCESS | 18474 | __start_tp_report 20:54:00 INFO - PROCESS | 18474 | _x_x_mozilla_page_load 20:54:00 INFO - PROCESS | 18474 | _x_x_mozilla_page_load_details 20:54:00 INFO - PROCESS | 18474 | |i|pagename|runs| 20:54:00 INFO - PROCESS | 18474 | |0;dojo.html;3091.1653853459566;3099.4111118887395;3128.030310603713;3133.075742655916;3135.435621588113;5255.290535777669;5316.362036555609;5374.167004114363;5449.509544141027;5476.972615136924;5396.487333703301;5433.565314774818;5447.536959358459;5487;5498.642588231772;4873.22028475444;4944.53026962438;4944.53026962438;4965.354503914504;5099.566536844372;5027.044861476326;5056.797728090872;5069.822556210515;5084.3136176616235;5089.41471730752;4784.856454306377;4808.374911261513;4893.070316639827;4954.851354459336;5003.574696150831;4909;4923.089228492705;4927.926081108786;4982.750862456863;5009.599232061426;4934.4572097069295;4960.454350021495;4968.378952630921;4998.425181104183;5019.021290848286;5248.81629142982;5370.812021579226;5438.53772429344;5476.616636835423;5527.364353099405;5870.618409803349;5871.823845284648;5907.763689452417;5913.024350982083;5916.940830591682;5921.851953701149;5945.137954996545;5958.523318134538;5967.075103358986;5973.313068997078;5363.704996225206;5409.729513524348;5423.538999185034;5424.728763561806;5548.472895075001;6023.186869772612;6030.366811484819;6030.728617212236;6032.728527216286;6034.034554471264;5743.684097374601;5769.278840144982;5774.162746401748;5816.47651711348;5820.330661973842;5656.264685590847;5722.769604534962;5768.192453056576;5859.091840764689;5860.413958604106;5839.153322768175;5840.123981402823;5844.26946631671;5859.384764599741;5869.266341707286;5787.305523337142;5800.4489573490455;5845.678487683133;5853.970730146322;5868.413158684098;4365.323374876899;4425.690201685916;4458.353538736865;4489.079738653568;4489.2592722201125;3967.761934283952;3973.8807835764396;3995.5005624296964;4004.4994375703036;4027.5166979962005;5531.308586426697;5532.419095994943;5539;5539.279893613804;5574.303212098488;5649.096144616841;5784.623999440023;5832.037713777179;5858.150568167592;5890.617109887844;5499.560035197174;5520.751566179531;5524.944750552523;5549.722513874371;5549.972250138723;5008.549230569266;5015.24771284303;5017.67385119966;5023.095842748267;5057.8229761958155;5838.036723940587;5934.43622855828;5957.523398128053;6032.909506357408;6047.485963693048;5892.351841297368;5894.086416605433;5898.3216930053595;5922.615030023035;5933.821985340447;6074.57477976555;6075.27096748393;6097.817065488042;6102.420270074336;6103.115048318058;5613.663180209201;5677.858053548694;5678.68767217807;5729.083346664514;5766.106253530709;5798.94201057984;5823.650580965155;5884.529237661062;5901.527877769682;5926.022206336079;5650.3219613646625;5673.461021202979;5683.033884239772;5683.857903552444;5685.886282274414;5466.480684334982;5614.69119198448;5650.29371328584;5704.11586204139;5709.54323654115;5628.324601047737;5634.971825140848;5637.605367624227;5670.603057785916;5692.117721753135;5763.049096898964;5768.682722450306;5801.941980580309;5817.301923769175;5821.243238378984;5552.583556233218;5591.04952158126;5617.971910140586;5629.971850140723;5637.802676906289 20:54:00 INFO - PROCESS | 18474 | |1;ext.html;591.9847461603349;616.2635650397775;617.3332800575382;628.1300398947457;640.6188317950817;31769.36461270776;32321;34759.82620086902;35072.82463587679;35167;43150.13699726004;44224.33663495042;44237.11525769483;48489.51510484894;48505.75747121268;8962.507062111581;9061.864072038925;9101.817963640724;9102.499362535058;9123.406978546407;9004.68483603074;9044.77388065297;9072.31957603179;9081.091890810932;9106.544672766335;9108.362414630945;9146.451212927212;9152.679656212;9156.587953542106;9159.175674189322;9017.95491022544;9070.365074444791;9084.90915090854;9089.81820363589;9093.63625454981;8940.792992945933;8993.055729148411;8993.59528821198;9002.234810041155;9008.549572521348;42544.57455425468;42799;42821.78589107034;42845.35731964023;42855.57144428547;3648.7687639969577;3714.0900479382453;3800.619938006205;3840.4047372657283;4141.751494910285;32799;33081.6691833081;33518.83240583806;33523.4971475428;35016.64983350159;4064.410660454247;4211.536730959592;4348.369486424483;4358.375091604117;4404.911901761947;353675;354340;355164;355627.99999999744;355645;57314.7134264326;57390.42609573934;57883.421165787804;57994;58081.70959145177;59664.70167649221;59917.40082599205;60061.39938600558;60104.39895601075;60105.39894601086;16335.18324083791;16602.418915337905;16629;16643.33426662944;16649.50051498457;12820.294883781482;12897.290649014207;12931.28877911705;12936.223826570436;12944.805827912589;14501.492447764278;16107.758383624256;16140.659604357303;16145.919270403807;16157.676846463004;6400.423961843457;6440.516961227927;6456.9354306456335;6496.350364963466;6840.486963477759;1007.4610083605236;1033.1424917318607;1066.1151244467228;1124;1133.1388145009853;32700.69197232084;32766;32771.67228327734;32772.34455310881;33538.664613353554;1115.8214685650257;1125.622916323041;1147.713071732067;1147.862256529222;1150.235093662705;16745.83254167467;17099.829001710073;17229.39697110595;17376.65246695059;17525.50275444601;536330;541159;541422;541509;541907;57712.71143644255;58030.41969580334;58049.41950580524;58070;58097.128543071885;1243.5461056714234;1361.3465536542515;1372.5264783649625;1376.8347798264272;1378.3866179550005;31774.36451271008;32806.83596582002;33472.330553389285;33655;34112.48831267483;43625.56374436215;43941.340879887466;44023.339649904636;44092.55907440885;44150;393476;394323;396136;396441;398465;33865.49201762025;35168.47247291344;43135.56864431441;43420.782896085315;44476;47061.294080589505;47552.52447475481;47833.76083119562;47844.76077619589;48274.27588586104;39714.2057158861;39826.203475930895;39898.601013989486;40930;41255.58744412637;40309.1938161241;40963;41079;41841.79079104585;42855.57144428516;39926.401103982884;41004;41464.585354146075;41766.582334176266;41877.581224187365;33717.49423758597;36597.81701091584;36617.45073823948;37273.81363093167;37388.252234954605;27561.31096722598;27805.721942780314;27979.300517487227;28060.29849253785;28268.717312826608 20:54:00 INFO - PROCESS | 18474 | |2;jquery.html;366.57950442037105;376.6440713525719;396.8353133449618;403.1755060900458;421.4079218697729;14592.562223133296;16869.91565042176;18421.907890460545;20151;20180.8990955045;15256.923715381408;15358.308876100575;15762.211889405513;18803.811961880376;19408.835469871818;5700.914486282699;5763.0779075347955;5834.620749651281;5871.588988770788;5872.383399743008;5624.634398764088;5748.396418376073;5766.336871259817;5774.82675519735;5793.913091303634;5597.776088956437;5674.914876276859;5718.971405142968;5745.023346031185;5773.249477567911;5739.827805165852;5741.741621627037;5749.108888122348;5750.108733146369;5755.6258843175265;4937.753112344404;5177.197534382177;5205.609579281569;5213;5216.165413533854;13861.653458663513;15573.922130389388;22650.433739156488;23432.531349372915;23656.526869462687;2326.220716060122;2387.200287903537;2389;2400.1839374612714;2471.938201544976;10038.799224015553;10098.932803561956;10230;10238.334508257014;10701.464926753632;1798.7301904714266;1809.4571628511526;1887.7451544041517;1899.9715004274947;1948.6687263165295;86517.56741216316;87321.56339218264;87374.56312718395;88889;91651.54174229153;10660.68017959447;10762.892371076345;10776.67669969902;10889.237753357189;10890.346579205274;12404.56584019555;14107.85892141086;14957;15400.691986160215;15449.768253476206;7943.285104340637;7971.760847174594;8103.635336409876;8158.224968627971;8189.22202390772;7791.181925897812;7869.213078692085;7910.920890791133;8019.35845132388;8193.631286592117;4464.933026004613;4485.125400546927;4576.359309696645;4618.515055919147;4682.344471773954;1869.7756269247777;1974.2450756045964;2010.497375656086;2020.3736841578864;2046.9181232750523;867.2238346679686;987.3976874106789;1030.2891005206384;1082.4209048159198;1090.1660229924114;18462.630747384977;19125;19172.616547668968;19283.614327713367;19636.607267854848;964.3827950111934;988.229181238635;1010.1060561403211;1023.2683631203577;1056.3714589819044;10191.133753630877;10250.743731406774;10649.84025239622;10656.680299591024;10657.147428205724;490338;494499;494959;496029.63896263455;496523;97926;98775.50612246893;99788;101723;102827;949.2074118111454;965.546193289167;998.4259051045677;1000.8348622477355;1015.5836107196162;16117.274722637276;16420.004976362277;16994;17419.56451088733;17467.56331091733;31519.84240078785;32513;44440.33339499845;44818.55181448144;45600.315995259436;57466.7126664364;58318.4168158313;60554;61104.69447652733;61322.69338653456;8140.308073813792;8259.297959673495;8553.690503564127;8860.202581767671;8970.551472426483;9462.57418416159;12488.812667809809;13132.606021819362;13726.901847851948;14050.508232212233;9301.255899528156;11363.602273920373;11530.308181509135;11722.94138529302;11881.1089168311;11049.502772375423;11321.716957075809;11370.829437558277;11478.196526243417;11545.653630391102;11782.293062416282;11794.233374830952;11817.881821181678;11962.641120766391;11992.520299187934;8325.583720814057;8399.370047246359;8401.62192701342;8555.31557475388;8657.22085012352;11176;11178.664640060812;11683.532658693557;11732.70668233301;11748.530058797553 20:54:00 INFO - PROCESS | 18474 | |3;mootools.html;1485.5097817720152;1498.9025713328633;1608.5335252776695;1769.9732758964537;1787.0528619831493;8433.325333973282;9143.634254629824;9153.81692366154;9160.221381182599;9166.40418372807;7535.359494442979;7757.922420775791;7766.456348055638;8000.759977200679;8935.106489351061;2288.9084436622556;2364.207990323244;2381.4879800842814;2389.462370966536;2396.4607963208227;2351.9294421167306;2370.6562548430466;2385.0459816073535;2390.796782273509;2392.9162479313227;2395.197608801054;2395.9161429349974;2398.70016247969;2399.1003373734848;2407.1935901473025;2278.4190031541934;2310.156792770635;2314.872682002489;2317.0268487235317;2325.279163459333;2303.170858490942;2314.4445333120098;2335.3577766114286;2336.707911511061;2337.883105844701;8718.912810871938;8772.692955746583;8773.517456539888;8779.253763430052;8956.417832840845;5267.55225805807;5389.892202155974;5408.4591540845995;5408.486193811582;5410.133503941134;3394.1853955050856;3498.2129020970333;3550.289942011608;3563.7149028077692;3569.161247106928;1123.4831977290455;1161.866385365677;1178.4637989714658;1189.0309397840733;1196.5752157983964;11820.054395648327;12194.024478041736;12232.755344893052;12465.189762665397;12577.622671319876;4427.5351088135285;4542.84100056503;4561.498235194126;4653;4690.64820138491;9669.17811985975;9704.563294651758;9717.708468745948;9721.319507634398;9742;5298.390685071189;5312.282841816305;5332.813351532678;5333.786648534093;5338.225957236179;4747.8575642730775;4922.384701912261;4962.6774259673;4980.77586508608;4982.900341993212;3704.221973452758;3704.81475926208;3781.905452363713;3832.0994566276904;3843.6348546888003;1162.9302241865514;1168.0888906652824;1170.4030944218339;1186.5965571705663;1189.5598628507507;991.7867658453467;995.5918073589938;1016.8678071850612;1025.3489034463169;1029.9330543514648;6066.545009124334;6074.878502429927;6149.7847575335545;6210.099535567318;6381.074744162071;462.45661347916064;463.63604570412065;466.710639403572;472.4401584122825;996.19308360227;3902.843886244575;4211.789410529523;4233.153369326147;4249.065205654751;4507.121111383249;11151.275167114112;11424.885751142383;11490.42547872603;11508.88491115078;11513.597024104116;11049.226554141294;11194.496247668874;11397.031252343644;11404.600838970597;11409.48657310423;8108.43240973138;8259.174082591693;8262.17378262169;8263.834723305501;8264.669413223404;5996.520278377807;6004.249468816398;6032.33644299118;6048.274207095177;6186.319504854552;9720.222382209548;10201.336913100624;10213.795724085328;10297.433641149808;10355.119814815524;10308.639197628047;10390.636327728493;10502.52738626779;10527.894721052691;10552.366857988545;6715.697793599202;7006.633706427401;7081.150261968597;7747.845043098993;7749.418793590616;8792.604332805167;8873.467591944504;8897;8899.777505562413;8903.554822258731;7798.181190975093;7816.687332506864;7978.242067003625;8094.716684915999;8117.918820811952;7547.358474529727;7737.381009519112;7755.302022817974;7755.728549500966;7784.727534536264;6983.44132469391;7050.612216328152;7078.504504684623;7079.1505019398;7086.716531338689;5176.9741151294;5216.791328346823;5289.20661900718;5307.203919412119;5469.288992430958;5423.186522021729;5433.2665090213895;5442.319710036246;5493.862653433696;5500.834974950758 20:54:00 INFO - PROCESS | 18474 | |4;prototype.html;304.3471753089623;317.5522513256309;323.43883362366296;323.74100719424456;326.41082845463944;5255.789768409264;5304.230886521452;5315.069862774014;5330.786768529254;5383.515483606469;4982.925256121152;4993.528203539244;5153.587712982961;5180.740962951847;5278.709670968095;4126.587341265879;4126.896827579305;4128.938065929014;4154.501459824825;4162.97918510407;4079.1229885574594;4132.586741325858;4152.252594532983;4154.563770804052;4163.209819777495;3880.2821478026513;3929.4302326162688;4079.2657321682086;4090.3046482097966;4113.8971525711795;4059.3505039193883;4062.939055914164;4078.286299897506;4080.612591718815;4084.979575102135;3626.9455958160647;3627.818609069562;3628.63713628635;3630.945535816965;3639.090227443139;5039.874003149914;5053.7618283520405;5071.37994603646;5166.664166829144;5184.144616138333;4649.558291962258;4661.207594708908;4663.554298167545;4674.602658774008;4694.178518759203;5425.240466334716;5426.864328391822;5431.293931788881;5436.472040501147;5467.152591348347;3669.2294618130227;3850.1144736710435;3978.76127432355;3983.721139520235;3989.3816458448696;5641.671413865839;5652.2195508415125;5653;5663.1505274208785;5667.376588575254;3953.940690889639;3960.940585891214;3975.284448799244;3975.5351681956795;3984.5019372578427;3950.150717595731;4023.114914718757;4030.214108248922;4036.345098509597;4046.817893194813;4577.130345234395;4591.839285625054;4602.171609110325;4616.9307460387445;4628.95371046292;5473.75368108436;5476.370217424967;5506.265526359264;5508.55931525477;5519.613627046068;1371.245814801875;1380.5582213691723;1395.5603984744773;1397.3362652739868;1403.859614038588;879.3185281406961;883.5802993578;887.3699673232078;888.8177923525661;899.9775005624781;4749.857504274808;4761.357216775691;4762.380890484214;4762.642182403062;4855.684380515255;5032.798688052437;5034.622403319766;5049.747512624427;5068.873278168002;5115.2582875483595;4534.841280555231;4672.95327046732;4677.321788340671;4698.859034228979;4704.400503828646;2616;2616.4636249568794;2620.6593142891684;2624.9237812496785;2629.7508683375245;5049.823256186016;5058.924116138261;5079.3650793650795;5094.414142373675;5104.719240441737;4802.27965805132;4983.50164983506;4996.6502344836235;5048.873778155502;5055.51972562606;5033.471485494044;5043.899122017612;5052.8484145475695;5074.579117847009;5079.492050794965;4845.878853028703;4915.729634870117;4952.306677065142;4952.826651067196;4956.3804524434445;5259.47405259471;5614.29821272341;5616.6068375213345;5626.831195064155;5656.547476201977;5852.151438041546;5856.531477481876;5865.94134058654;5868;5869.618474799296;3959.6238357356006;4060.3097473428998;4097.7746223957965;4117.75293482392;4123.340265557496;5354.625176237626;5483.259759932358;5611.8877622448135;5652.576056795675;5657.575681823797;5421.484958928895;5438.428964958623;5442.755076021509;5454.427285135003;5491.945080549303;5483.8080667176455;5484.698341591251;5489.478499542537;5490.258815060076;5519.254900588369;5246.265522826884;5380.757865896122;5402.595325215394;5421.593380496557;5423.210340587518;5466.398696143341;5504.146857237135;5520.889582208413;5521.1442226454965;5550.583706221969;5272;5378.865528361822;5414.593905457185;5416.322959630046;5417.458254174709 20:54:00 INFO - PROCESS | 18474 | |5;yui.html;739.412167326975;744.7653988993467;790.7706765038142;824.979375515612;832.6835802395088;14363.856361436383;15042.172680502568;15472.845271547281;15502.069875807445;16437.09595972221;14268.429262829475;14382.640433989156;14439.42242310309;14473.42106315746;14495.130292182477;639.1180171363512;774.8876412920151;783.298947442039;795.2961628958385;798.5767543202084;778.6029125146188;779.4115442840647;779.5283853268747;780.0756104016758;780.6174974262627;820.1962077164383;821.6179476543406;822.235321151329;823.0247157118804;825.7894236969595;669.0866966590618;808.8746244332137;816.0003995106007;820.9096999330069;821.4537332673794;605.5730709849546;605.7879742090278;606.0122001138117;606.4026933470528;606.4057223920582;15306.234688265653;15335.30991105403;15336.769948450783;15337.46318878845;15360.539183824503;14667.193304368255;14990.550283491513;15246.161461119635;15460;15573;12873;13049.86950130496;13380.598582042554;13675.521356752466;13756.65608359789;4477.350784136282;4486.641068714495;4496.392986946753;4515.729056256635;4624.213883639755;81739;84465.17487551748;85481.57259213664;86226.30066711122;86544;10959.671209863716;10978.615748448925;11111.333320000826;11162.609308674157;11264.831027534594;20028;20066.698999515018;20092.59814803696;20109.899450502948;20131.19475221004;8356.749297521084;8440.746777596682;8450.281726053354;8809.911900881038;8816.955915220382;4780.593649539828;4934.383202099738;4938.530839570307;4961.751912404366;5113.51421614946;3547.219611685425;3718.795466249382;3725.2735716535017;3730.9926319893475;3731.3097077040834;609.3571282297219;627.4603840696997;627.632834791652;628.8647940692681;630.0517720830121;644.1754554170669;664.3323459922747;679.9626020568817;684.3020119478203;690.492488021304;8359.373047021498;8470.322374210049;8681.956590217009;9134.589161662776;9215.723528294162;590.7784580782206;592.9229200203946;649.8886903395247;658.5916731626422;690.3959035843637;4075.083106301118;4116.238495878272;4135.17296540693;4147.896302592399;4191.476065491814;97897.51051244698;100311;102581.48709256406;111942;120026.39986800184;95217;95341.52329238309;95877.52061239649;95919.36725694721;96118;54108.458915410345;54135.0604990742;55226;55313.1703024455;83474.58262708648;9490.525473726148;9840.242184455983;9853.753656158653;9932.851007235042;10021.749456263651;50438;51082.74458627683;52392;52727.20909186442;52842.73578632082;66440.33559664342;70668.64665676639;73265.26734732585;73450;73685.6315718418;12715;12769.61691149267;12942.158759680591;12966.675833104247;13001.609951701465;14190.929045354707;14393.712125757636;14404.207768572829;14784.556463306119;15143.545693628768;13024.218546887218;13265.137766045176;13393.397297121848;13901.443942242196;13923.721525569634;12792.232466052066;13557.525486607921;13795.310234488035;14010.719785604435;14762.48331308399;12156.878431215575;12160.75678486443;12357;12749.043821713223;12793.104482686123;10840.403777792297;11035.724106897393;11460.968512833884;11608.245464045149;11962.46168922418;10287.43419111956;11639.41802909868;11834.644960651194;11866.584669536525;12034.879651203375 20:54:00 INFO - PROCESS | 18474 | __end_tp_report 20:54:00 INFO - PROCESS | 18474 | __start_cc_report 20:54:00 INFO - PROCESS | 18474 | _x_x_mozilla_cycle_collect,998 20:54:00 INFO - PROCESS | 18474 | __end_cc_report 20:54:00 INFO - PROCESS | 18474 | __startTimestamp1471060440243__endTimestamp 20:54:00 INFO - PROCESS | 18474 | 20:54:00 INFO - PROCESS | 18474 | ------- Summary: start ------- 20:54:00 INFO - PROCESS | 18474 | Number of tests: 6 20:54:00 INFO - PROCESS | 18474 | 20:54:00 INFO - PROCESS | 18474 | [#0] dojo.html Cycles:165 Average:5423.45 Median:5629.97 stddev:625.13 (11.1%) stddev-sans-first:599.67 20:54:00 INFO - PROCESS | 18474 | Values: 3091.2 3099.4 3128.0 3133.1 3135.4 5255.3 5316.4 5374.2 5449.5 5477.0 5396.5 5433.6 5447.5 5487.0 5498.6 4873.2 4944.5 4944.5 4965.4 5099.6 5027.0 5056.8 5069.8 5084.3 5089.4 4784.9 4808.4 4893.1 4954.9 5003.6 4909.0 4923.1 4927.9 4982.8 5009.6 4934.5 4960.5 4968.4 4998.4 5019.0 5248.8 5370.8 5438.5 5476.6 5527.4 5870.6 5871.8 5907.8 5913.0 5916.9 5921.9 5945.1 5958.5 5967.1 5973.3 5363.7 5409.7 5423.5 5424.7 5548.5 6023.2 6030.4 6030.7 6032.7 6034.0 5743.7 5769.3 5774.2 5816.5 5820.3 5656.3 5722.8 5768.2 5859.1 5860.4 5839.2 5840.1 5844.3 5859.4 5869.3 5787.3 5800.4 5845.7 5854.0 5868.4 4365.3 4425.7 4458.4 4489.1 4489.3 3967.8 3973.9 3995.5 4004.5 4027.5 5531.3 5532.4 5539.0 5539.3 5574.3 5649.1 5784.6 5832.0 5858.2 5890.6 5499.6 5520.8 5524.9 5549.7 5550.0 5008.5 5015.2 5017.7 5023.1 5057.8 5838.0 5934.4 5957.5 6032.9 6047.5 5892.4 5894.1 5898.3 5922.6 5933.8 6074.6 6075.3 6097.8 6102.4 6103.1 5613.7 5677.9 5678.7 5729.1 5766.1 5798.9 5823.7 5884.5 5901.5 5926.0 5650.3 5673.5 5683.0 5683.9 5685.9 5466.5 5614.7 5650.3 5704.1 5709.5 5628.3 5635.0 5637.6 5670.6 5692.1 5763.0 5768.7 5801.9 5817.3 5821.2 5552.6 5591.0 5618.0 5630.0 5637.8 20:54:00 INFO - PROCESS | 18474 | 20:54:00 INFO - PROCESS | 18474 | [#1] ext.html Cycles:180 Average:59286.47 Median:41167.29 stddev:115946.79 (281.6%) stddev-sans-first:116188.30 20:54:00 INFO - PROCESS | 18474 | Values: 592.0 616.3 617.3 628.1 640.6 31769.4 32321.0 34759.8 35072.8 35167.0 43150.1 44224.3 44237.1 48489.5 48505.8 8962.5 9061.9 9101.8 9102.5 9123.4 9004.7 9044.8 9072.3 9081.1 9106.5 9108.4 9146.5 9152.7 9156.6 9159.2 9018.0 9070.4 9084.9 9089.8 9093.6 8940.8 8993.1 8993.6 9002.2 9008.5 42544.6 42799.0 42821.8 42845.4 42855.6 3648.8 3714.1 3800.6 3840.4 4141.8 32799.0 33081.7 33518.8 33523.5 35016.6 4064.4 4211.5 4348.4 4358.4 4404.9 353675.0 354340.0 355164.0 355628.0 355645.0 57314.7 57390.4 57883.4 57994.0 58081.7 59664.7 59917.4 60061.4 60104.4 60105.4 16335.2 16602.4 16629.0 16643.3 16649.5 12820.3 12897.3 12931.3 12936.2 12944.8 14501.5 16107.8 16140.7 16145.9 16157.7 6400.4 6440.5 6456.9 6496.4 6840.5 1007.5 1033.1 1066.1 1124.0 1133.1 32700.7 32766.0 32771.7 32772.3 33538.7 1115.8 1125.6 1147.7 1147.9 1150.2 16745.8 17099.8 17229.4 17376.7 17525.5 536330.0 541159.0 541422.0 541509.0 541907.0 57712.7 58030.4 58049.4 58070.0 58097.1 1243.5 1361.3 1372.5 1376.8 1378.4 31774.4 32806.8 33472.3 33655.0 34112.5 43625.6 43941.3 44023.3 44092.6 44150.0 393476.0 394323.0 396136.0 396441.0 398465.0 33865.5 35168.5 43135.6 43420.8 44476.0 47061.3 47552.5 47833.8 47844.8 48274.3 39714.2 39826.2 39898.6 40930.0 41255.6 40309.2 40963.0 41079.0 41841.8 42855.6 39926.4 41004.0 41464.6 41766.6 41877.6 33717.5 36597.8 36617.5 37273.8 37388.3 27561.3 27805.7 27979.3 28060.3 28268.7 20:54:00 INFO - PROCESS | 18474 | 20:54:00 INFO - PROCESS | 18474 | [#2] jquery.html Cycles:180 Average:29257.07 Median:2394.59 stddev:81898.31 (3420.1%) stddev-sans-first:82099.33 20:54:00 INFO - PROCESS | 18474 | Values: 366.6 376.6 396.8 403.2 421.4 14592.6 16869.9 18421.9 20151.0 20180.9 15256.9 15358.3 15762.2 18803.8 19408.8 5700.9 5763.1 5834.6 5871.6 5872.4 5624.6 5748.4 5766.3 5774.8 5793.9 5597.8 5674.9 5719.0 5745.0 5773.2 5739.8 5741.7 5749.1 5750.1 5755.6 4937.8 5177.2 5205.6 5213.0 5216.2 13861.7 15573.9 22650.4 23432.5 23656.5 2326.2 2387.2 2389.0 2400.2 2471.9 10038.8 10098.9 10230.0 10238.3 10701.5 1798.7 1809.5 1887.7 1900.0 1948.7 86517.6 87321.6 87374.6 88889.0 91651.5 10660.7 10762.9 10776.7 10889.2 10890.3 12404.6 14107.9 14957.0 15400.7 15449.8 7943.3 7971.8 8103.6 8158.2 8189.2 7791.2 7869.2 7910.9 8019.4 8193.6 4464.9 4485.1 4576.4 4618.5 4682.3 1869.8 1974.2 2010.5 2020.4 2046.9 867.2 987.4 1030.3 1082.4 1090.2 18462.6 19125.0 19172.6 19283.6 19636.6 964.4 988.2 1010.1 1023.3 1056.4 10191.1 10250.7 10649.8 10656.7 10657.1 490338.0 494499.0 494959.0 496029.6 496523.0 97926.0 98775.5 99788.0 101723.0 102827.0 949.2 965.5 998.4 1000.8 1015.6 16117.3 16420.0 16994.0 17419.6 17467.6 31519.8 32513.0 44440.3 44818.6 45600.3 57466.7 58318.4 60554.0 61104.7 61322.7 8140.3 8259.3 8553.7 8860.2 8970.6 9462.6 12488.8 13132.6 13726.9 14050.5 9301.3 11363.6 11530.3 11722.9 11881.1 11049.5 11321.7 11370.8 11478.2 11545.7 11782.3 11794.2 11817.9 11962.6 11992.5 8325.6 8399.4 8401.6 8555.3 8657.2 11176.0 11178.7 11683.5 11732.7 11748.5 20:54:00 INFO - PROCESS | 18474 | 20:54:00 INFO - PROCESS | 18474 | [#3] mootools.html Cycles:180 Average:5839.46 Median:2610.15 stddev:3328.56 (127.5%) stddev-sans-first:3321.81 20:54:00 INFO - PROCESS | 18474 | Values: 1485.5 1498.9 1608.5 1770.0 1787.1 8433.3 9143.6 9153.8 9160.2 9166.4 7535.4 7757.9 7766.5 8000.8 8935.1 2288.9 2364.2 2381.5 2389.5 2396.5 2351.9 2370.7 2385.0 2390.8 2392.9 2395.2 2395.9 2398.7 2399.1 2407.2 2278.4 2310.2 2314.9 2317.0 2325.3 2303.2 2314.4 2335.4 2336.7 2337.9 8718.9 8772.7 8773.5 8779.3 8956.4 5267.6 5389.9 5408.5 5408.5 5410.1 3394.2 3498.2 3550.3 3563.7 3569.2 1123.5 1161.9 1178.5 1189.0 1196.6 11820.1 12194.0 12232.8 12465.2 12577.6 4427.5 4542.8 4561.5 4653.0 4690.6 9669.2 9704.6 9717.7 9721.3 9742.0 5298.4 5312.3 5332.8 5333.8 5338.2 4747.9 4922.4 4962.7 4980.8 4982.9 3704.2 3704.8 3781.9 3832.1 3843.6 1162.9 1168.1 1170.4 1186.6 1189.6 991.8 995.6 1016.9 1025.3 1029.9 6066.5 6074.9 6149.8 6210.1 6381.1 462.5 463.6 466.7 472.4 996.2 3902.8 4211.8 4233.2 4249.1 4507.1 11151.3 11424.9 11490.4 11508.9 11513.6 11049.2 11194.5 11397.0 11404.6 11409.5 8108.4 8259.2 8262.2 8263.8 8264.7 5996.5 6004.2 6032.3 6048.3 6186.3 9720.2 10201.3 10213.8 10297.4 10355.1 10308.6 10390.6 10502.5 10527.9 10552.4 6715.7 7006.6 7081.2 7747.8 7749.4 8792.6 8873.5 8897.0 8899.8 8903.6 7798.2 7816.7 7978.2 8094.7 8117.9 7547.4 7737.4 7755.3 7755.7 7784.7 6983.4 7050.6 7078.5 7079.2 7086.7 5177.0 5216.8 5289.2 5307.2 5469.3 5423.2 5433.3 5442.3 5493.9 5500.8 20:54:00 INFO - PROCESS | 18474 | 20:54:00 INFO - PROCESS | 18474 | [#4] prototype.html Cycles:180 Average:4480.10 Median:5033.14 stddev:1305.16 (25.9%) stddev-sans-first:1270.63 20:54:00 INFO - PROCESS | 18474 | Values: 304.3 317.6 323.4 323.7 326.4 5255.8 5304.2 5315.1 5330.8 5383.5 4982.9 4993.5 5153.6 5180.7 5278.7 4126.6 4126.9 4128.9 4154.5 4163.0 4079.1 4132.6 4152.3 4154.6 4163.2 3880.3 3929.4 4079.3 4090.3 4113.9 4059.4 4062.9 4078.3 4080.6 4085.0 3626.9 3627.8 3628.6 3630.9 3639.1 5039.9 5053.8 5071.4 5166.7 5184.1 4649.6 4661.2 4663.6 4674.6 4694.2 5425.2 5426.9 5431.3 5436.5 5467.2 3669.2 3850.1 3978.8 3983.7 3989.4 5641.7 5652.2 5653.0 5663.2 5667.4 3953.9 3960.9 3975.3 3975.5 3984.5 3950.2 4023.1 4030.2 4036.3 4046.8 4577.1 4591.8 4602.2 4616.9 4629.0 5473.8 5476.4 5506.3 5508.6 5519.6 1371.2 1380.6 1395.6 1397.3 1403.9 879.3 883.6 887.4 888.8 900.0 4749.9 4761.4 4762.4 4762.6 4855.7 5032.8 5034.6 5049.7 5068.9 5115.3 4534.8 4673.0 4677.3 4698.9 4704.4 2616.0 2616.5 2620.7 2624.9 2629.8 5049.8 5058.9 5079.4 5094.4 5104.7 4802.3 4983.5 4996.7 5048.9 5055.5 5033.5 5043.9 5052.8 5074.6 5079.5 4845.9 4915.7 4952.3 4952.8 4956.4 5259.5 5614.3 5616.6 5626.8 5656.5 5852.2 5856.5 5865.9 5868.0 5869.6 3959.6 4060.3 4097.8 4117.8 4123.3 5354.6 5483.3 5611.9 5652.6 5657.6 5421.5 5438.4 5442.8 5454.4 5491.9 5483.8 5484.7 5489.5 5490.3 5519.3 5246.3 5380.8 5402.6 5421.6 5423.2 5466.4 5504.1 5520.9 5521.1 5550.6 5272.0 5378.9 5414.6 5416.3 5417.5 20:54:00 INFO - PROCESS | 18474 | 20:54:00 INFO - PROCESS | 18474 | [#5] yui.html Cycles:180 Average:19912.72 Median:4857.49 stddev:28079.77 (578.1%) stddev-sans-first:28121.64 20:54:00 INFO - PROCESS | 18474 | Values: 739.4 744.8 790.8 825.0 832.7 14363.9 15042.2 15472.8 15502.1 16437.1 14268.4 14382.6 14439.4 14473.4 14495.1 639.1 774.9 783.3 795.3 798.6 778.6 779.4 779.5 780.1 780.6 820.2 821.6 822.2 823.0 825.8 669.1 808.9 816.0 820.9 821.5 605.6 605.8 606.0 606.4 606.4 15306.2 15335.3 15336.8 15337.5 15360.5 14667.2 14990.6 15246.2 15460.0 15573.0 12873.0 13049.9 13380.6 13675.5 13756.7 4477.4 4486.6 4496.4 4515.7 4624.2 81739.0 84465.2 85481.6 86226.3 86544.0 10959.7 10978.6 11111.3 11162.6 11264.8 20028.0 20066.7 20092.6 20109.9 20131.2 8356.7 8440.7 8450.3 8809.9 8817.0 4780.6 4934.4 4938.5 4961.8 5113.5 3547.2 3718.8 3725.3 3731.0 3731.3 609.4 627.5 627.6 628.9 630.1 644.2 664.3 680.0 684.3 690.5 8359.4 8470.3 8682.0 9134.6 9215.7 590.8 592.9 649.9 658.6 690.4 4075.1 4116.2 4135.2 4147.9 4191.5 97897.5 100311.0 102581.5 111942.0 120026.4 95217.0 95341.5 95877.5 95919.4 96118.0 54108.5 54135.1 55226.0 55313.2 83474.6 9490.5 9840.2 9853.8 9932.9 10021.7 50438.0 51082.7 52392.0 52727.2 52842.7 66440.3 70668.6 73265.3 73450.0 73685.6 12715.0 12769.6 12942.2 12966.7 13001.6 14190.9 14393.7 14404.2 14784.6 15143.5 13024.2 13265.1 13393.4 13901.4 13923.7 12792.2 13557.5 13795.3 14010.7 14762.5 12156.9 12160.8 12357.0 12749.0 12793.1 10840.4 11035.7 11461.0 11608.2 11962.5 10287.4 11639.4 11834.6 11866.6 12034.9 20:54:00 INFO - PROCESS | 18474 | -------- Summary: end -------- 20:54:00 INFO - PROCESS | 18474 | 20:54:00 INFO - TEST-INFO | 18474: exit 0 20:54:00 INFO - TEST-OK | dromaeo_css | took 1114894ms 20:54:00 INFO - TEST-START | kraken 20:54:00 INFO - operating with platform_type : linux_ 20:54:00 INFO - Initialising browser for kraken test... 20:54:01 INFO - TEST-INFO | started process 18781 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgW0IxU/profile http://localhost:49621/getInfo.html) 20:54:04 INFO - PROCESS | 18781 | __metrics Screen width/height:1600/1200 20:54:04 INFO - PROCESS | 18781 | colorDepth:24 20:54:04 INFO - PROCESS | 18781 | Browser inner width/height: 1024/697 20:54:04 INFO - PROCESS | 18781 | __metrics 20:54:05 INFO - PROCESS | 18781 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 20:54:05 INFO - PROCESS | 18781 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:54:06 INFO - TEST-INFO | 18781: exit 0 20:54:06 INFO - Browser initialized. 20:54:06 INFO - Running cycle 1/1 for kraken test... 20:54:06 INFO - TEST-INFO | started process 18862 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgW0IxU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:54:18 INFO - PROCESS | 18862 | RSS: Main: 156205056 20:54:18 INFO - PROCESS | 18862 | 20:54:20 INFO - PROCESS | 18862 | Cycle 1(1): loaded http://localhost:49621/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49621/tests/kraken/driver.html?testName=audio-beat-detection) 20:54:21 INFO - PROCESS | 18862 | RSS: Main: 204312576 20:54:21 INFO - PROCESS | 18862 | 20:54:24 INFO - PROCESS | 18862 | Cycle 1(1): loaded http://localhost:49621/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49621/tests/kraken/driver.html?testName=audio-dft) 20:54:24 INFO - PROCESS | 18862 | RSS: Main: 194691072 20:54:24 INFO - PROCESS | 18862 | 20:54:28 INFO - PROCESS | 18862 | Cycle 1(1): loaded http://localhost:49621/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49621/tests/kraken/driver.html?testName=audio-fft) 20:54:28 INFO - PROCESS | 18862 | RSS: Main: 274866176 20:54:28 INFO - PROCESS | 18862 | 20:54:30 INFO - PROCESS | 18862 | Cycle 1(1): loaded http://localhost:49621/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49621/tests/kraken/driver.html?testName=audio-oscillator) 20:54:31 INFO - PROCESS | 18862 | RSS: Main: 185626624 20:54:31 INFO - PROCESS | 18862 | 20:54:33 INFO - PROCESS | 18862 | Cycle 1(1): loaded http://localhost:49621/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49621/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:54:34 INFO - PROCESS | 18862 | RSS: Main: 190062592 20:54:34 INFO - PROCESS | 18862 | 20:54:37 INFO - PROCESS | 18862 | Cycle 1(1): loaded http://localhost:49621/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49621/tests/kraken/driver.html?testName=imaging-darkroom) 20:54:37 INFO - PROCESS | 18862 | RSS: Main: 225382400 20:54:37 INFO - PROCESS | 18862 | 20:54:41 INFO - PROCESS | 18862 | Cycle 1(1): loaded http://localhost:49621/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49621/tests/kraken/driver.html?testName=imaging-desaturate) 20:54:41 INFO - PROCESS | 18862 | RSS: Main: 225734656 20:54:41 INFO - PROCESS | 18862 | 20:54:44 INFO - PROCESS | 18862 | Cycle 1(1): loaded http://localhost:49621/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49621/tests/kraken/driver.html?testName=json-parse-financial) 20:54:45 INFO - PROCESS | 18862 | RSS: Main: 226459648 20:54:45 INFO - PROCESS | 18862 | 20:54:46 INFO - PROCESS | 18862 | Cycle 1(1): loaded http://localhost:49621/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49621/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:54:47 INFO - PROCESS | 18862 | RSS: Main: 188219392 20:54:47 INFO - PROCESS | 18862 | 20:54:48 INFO - PROCESS | 18862 | Cycle 1(1): loaded http://localhost:49621/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49621/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:54:49 INFO - PROCESS | 18862 | RSS: Main: 195280896 20:54:49 INFO - PROCESS | 18862 | 20:54:51 INFO - PROCESS | 18862 | Cycle 1(1): loaded http://localhost:49621/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49621/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:54:52 INFO - PROCESS | 18862 | RSS: Main: 193687552 20:54:52 INFO - PROCESS | 18862 | 20:54:54 INFO - PROCESS | 18862 | Cycle 1(1): loaded http://localhost:49621/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49621/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:54:55 INFO - PROCESS | 18862 | RSS: Main: 186748928 20:54:55 INFO - PROCESS | 18862 | 20:54:58 INFO - PROCESS | 18862 | Cycle 1(1): loaded http://localhost:49621/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49621/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:54:58 INFO - PROCESS | 18862 | RSS: Main: 191643648 20:54:58 INFO - PROCESS | 18862 | 20:55:00 INFO - PROCESS | 18862 | Cycle 1(1): loaded http://localhost:49621/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49621/tests/kraken/driver.html?testName=ai-astar) 20:55:00 INFO - PROCESS | 18862 | RSS: Main: 243126272 20:55:00 INFO - PROCESS | 18862 | 20:55:00 INFO - PROCESS | 18862 | __start_tp_report 20:55:00 INFO - PROCESS | 18862 | _x_x_mozilla_page_load 20:55:00 INFO - PROCESS | 18862 | _x_x_mozilla_page_load_details 20:55:00 INFO - PROCESS | 18862 | |i|pagename|runs| 20:55:00 INFO - PROCESS | 18862 | |0;ai-astar;102;112;112;110;106;111;113;111;112;111 20:55:00 INFO - PROCESS | 18862 | |1;audio-beat-detection;144;116;119;187;117;121;143;118;161;122 20:55:00 INFO - PROCESS | 18862 | |2;audio-dft;160;159;160;161;162;159;159;162;162;161 20:55:00 INFO - PROCESS | 18862 | |3;audio-fft;75;75;75;111;76;87;75;74;104;74 20:55:00 INFO - PROCESS | 18862 | |4;audio-oscillator;83;84;125;84;84;84;115;84;84;125 20:55:00 INFO - PROCESS | 18862 | |5;imaging-gaussian-blur;117;117;117;116;116;117;117;117;117;118 20:55:00 INFO - PROCESS | 18862 | |6;imaging-darkroom;145;145;146;145;145;146;145;145;146;146 20:55:00 INFO - PROCESS | 18862 | |7;imaging-desaturate;95;94;95;95;95;95;96;95;95;95 20:55:00 INFO - PROCESS | 18862 | |8;json-parse-financial;54;50;51;50;50;52;51;49;53;51 20:55:00 INFO - PROCESS | 18862 | |9;json-stringify-tinderbox;61;63;61;61;64;63;63;62;61;62 20:55:00 INFO - PROCESS | 18862 | |10;stanford-crypto-aes;79;81;83;78;79;78;78;83;78;78 20:55:00 INFO - PROCESS | 18862 | |11;stanford-crypto-ccm;132;123;136;126;122;129;122;120;145;122 20:55:00 INFO - PROCESS | 18862 | |12;stanford-crypto-pbkdf2;163;163;163;165;161;168;166;169;167;166 20:55:00 INFO - PROCESS | 18862 | |13;stanford-crypto-sha256-iterative;63;64;64;62;64;63;63;62;62;63 20:55:00 INFO - PROCESS | 18862 | __end_tp_report 20:55:00 INFO - PROCESS | 18862 | __start_cc_report 20:55:00 INFO - PROCESS | 18862 | _x_x_mozilla_cycle_collect,1678 20:55:00 INFO - PROCESS | 18862 | __end_cc_report 20:55:00 INFO - PROCESS | 18862 | __startTimestamp1471060500648__endTimestamp 20:55:00 INFO - PROCESS | 18862 | 20:55:00 INFO - PROCESS | 18862 | ------- Summary: start ------- 20:55:00 INFO - PROCESS | 18862 | Number of tests: 14 20:55:00 INFO - PROCESS | 18862 | 20:55:00 INFO - PROCESS | 18862 | [#0] ai-astar Cycles:10 Average:110.00 Median:111.50 stddev:3.40 (3.0%) stddev-sans-first:2.03 20:55:00 INFO - PROCESS | 18862 | Values: 102.0 112.0 112.0 110.0 106.0 111.0 113.0 111.0 112.0 111.0 20:55:00 INFO - PROCESS | 18862 | 20:55:00 INFO - PROCESS | 18862 | [#1] audio-beat-detection Cycles:10 Average:134.80 Median:132.50 stddev:23.85 (18.0%) stddev-sans-first:25.06 20:55:00 INFO - PROCESS | 18862 | Values: 144.0 116.0 119.0 187.0 117.0 121.0 143.0 118.0 161.0 122.0 20:55:00 INFO - PROCESS | 18862 | 20:55:00 INFO - PROCESS | 18862 | [#2] audio-dft Cycles:10 Average:160.50 Median:161.00 stddev:1.27 (0.8%) stddev-sans-first:1.33 20:55:00 INFO - PROCESS | 18862 | Values: 160.0 159.0 160.0 161.0 162.0 159.0 159.0 162.0 162.0 161.0 20:55:00 INFO - PROCESS | 18862 | 20:55:00 INFO - PROCESS | 18862 | [#3] audio-fft Cycles:10 Average:82.60 Median:75.00 stddev:13.77 (18.4%) stddev-sans-first:14.33 20:55:00 INFO - PROCESS | 18862 | Values: 75.0 75.0 75.0 111.0 76.0 87.0 75.0 74.0 104.0 74.0 20:55:00 INFO - PROCESS | 18862 | 20:55:00 INFO - PROCESS | 18862 | [#4] audio-oscillator Cycles:10 Average:95.20 Median:84.00 stddev:18.47 (22.0%) stddev-sans-first:19.05 20:55:00 INFO - PROCESS | 18862 | Values: 83.0 84.0 125.0 84.0 84.0 84.0 115.0 84.0 84.0 125.0 20:55:00 INFO - PROCESS | 18862 | 20:55:00 INFO - PROCESS | 18862 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 20:55:00 INFO - PROCESS | 18862 | Values: 117.0 117.0 117.0 116.0 116.0 117.0 117.0 117.0 117.0 118.0 20:55:00 INFO - PROCESS | 18862 | 20:55:00 INFO - PROCESS | 18862 | [#6] imaging-darkroom Cycles:10 Average:145.40 Median:145.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 20:55:00 INFO - PROCESS | 18862 | Values: 145.0 145.0 146.0 145.0 145.0 146.0 145.0 145.0 146.0 146.0 20:55:00 INFO - PROCESS | 18862 | 20:55:00 INFO - PROCESS | 18862 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 20:55:00 INFO - PROCESS | 18862 | Values: 95.0 94.0 95.0 95.0 95.0 95.0 96.0 95.0 95.0 95.0 20:55:00 INFO - PROCESS | 18862 | 20:55:00 INFO - PROCESS | 18862 | [#8] json-parse-financial Cycles:10 Average:51.10 Median:51.00 stddev:1.52 (3.0%) stddev-sans-first:1.20 20:55:00 INFO - PROCESS | 18862 | Values: 54.0 50.0 51.0 50.0 50.0 52.0 51.0 49.0 53.0 51.0 20:55:00 INFO - PROCESS | 18862 | 20:55:00 INFO - PROCESS | 18862 | [#9] json-stringify-tinderbox Cycles:10 Average:62.10 Median:62.50 stddev:1.10 (1.8%) stddev-sans-first:1.09 20:55:00 INFO - PROCESS | 18862 | Values: 61.0 63.0 61.0 61.0 64.0 63.0 63.0 62.0 61.0 62.0 20:55:00 INFO - PROCESS | 18862 | 20:55:00 INFO - PROCESS | 18862 | [#10] stanford-crypto-aes Cycles:10 Average:79.50 Median:79.00 stddev:2.07 (2.6%) stddev-sans-first:2.19 20:55:00 INFO - PROCESS | 18862 | Values: 79.0 81.0 83.0 78.0 79.0 78.0 78.0 83.0 78.0 78.0 20:55:00 INFO - PROCESS | 18862 | 20:55:00 INFO - PROCESS | 18862 | [#11] stanford-crypto-ccm Cycles:10 Average:127.70 Median:127.50 stddev:7.96 (6.2%) stddev-sans-first:8.29 20:55:00 INFO - PROCESS | 18862 | Values: 132.0 123.0 136.0 126.0 122.0 129.0 122.0 120.0 145.0 122.0 20:55:00 INFO - PROCESS | 18862 | 20:55:00 INFO - PROCESS | 18862 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.10 Median:166.00 stddev:2.56 (1.5%) stddev-sans-first:2.60 20:55:00 INFO - PROCESS | 18862 | Values: 163.0 163.0 163.0 165.0 161.0 168.0 166.0 169.0 167.0 166.0 20:55:00 INFO - PROCESS | 18862 | 20:55:00 INFO - PROCESS | 18862 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.00 Median:63.00 stddev:0.82 (1.3%) stddev-sans-first:0.87 20:55:00 INFO - PROCESS | 18862 | Values: 63.0 64.0 64.0 62.0 64.0 63.0 63.0 62.0 62.0 63.0 20:55:00 INFO - PROCESS | 18862 | -------- Summary: end -------- 20:55:00 INFO - PROCESS | 18862 | 20:55:01 INFO - TEST-INFO | 18862: exit 0 20:55:01 INFO - TEST-OK | kraken | took 60610ms 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": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3091.1653853459566, 3099.4111118887395, 3128.030310603713, 3133.075742655916, 3135.435621588113, 5255.290535777669, 5316.362036555609, 5374.167004114363, 5449.509544141027, 5476.972615136924, 5396.487333703301, 5433.565314774818, 5447.536959358459, 5487.0, 5498.642588231772, 4873.22028475444, 4944.53026962438, 4944.53026962438, 4965.354503914504, 5099.566536844372, 5027.044861476326, 5056.797728090872, 5069.822556210515, 5084.3136176616235, 5089.41471730752, 4784.856454306377, 4808.374911261513, 4893.070316639827, 4954.851354459336, 5003.574696150831, 4909.0, 4923.089228492705, 4927.926081108786, 4982.750862456863, 5009.599232061426, 4934.4572097069295, 4960.454350021495, 4968.378952630921, 4998.425181104183, 5019.021290848286, 5248.81629142982, 5370.812021579226, 5438.53772429344, 5476.616636835423, 5527.364353099405, 5870.618409803349, 5871.823845284648, 5907.763689452417, 5913.024350982083, 5916.940830591682, 5921.851953701149, 5945.137954996545, 5958.523318134538, 5967.075103358986, 5973.313068997078, 5363.704996225206, 5409.729513524348, 5423.538999185034, 5424.728763561806, 5548.472895075001, 6023.186869772612, 6030.366811484819, 6030.728617212236, 6032.728527216286, 6034.034554471264, 5743.684097374601, 5769.278840144982, 5774.162746401748, 5816.47651711348, 5820.330661973842, 5656.264685590847, 5722.769604534962, 5768.192453056576, 5859.091840764689, 5860.413958604106, 5839.153322768175, 5840.123981402823, 5844.26946631671, 5859.384764599741, 5869.266341707286, 5787.305523337142, 5800.4489573490455, 5845.678487683133, 5853.970730146322, 5868.413158684098, 4365.323374876899, 4425.690201685916, 4458.353538736865, 4489.079738653568, 4489.2592722201125, 3967.761934283952, 3973.8807835764396, 3995.5005624296964, 4004.4994375703036, 4027.5166979962005, 5531.308586426697, 5532.419095994943, 5539.0, 5539.279893613804, 5574.303212098488, 5649.096144616841, 5784.623999440023, 5832.037713777179, 5858.150568167592, 5890.617109887844, 5499.560035197174, 5520.751566179531, 5524.944750552523, 5549.722513874371, 5549.972250138723, 5008.549230569266, 5015.24771284303, 5017.67385119966, 5023.095842748267, 5057.8229761958155, 5838.036723940587, 5934.43622855828, 5957.523398128053, 6032.909506357408, 6047.485963693048, 5892.351841297368, 5894.086416605433, 5898.3216930053595, 5922.615030023035, 5933.821985340447, 6074.57477976555, 6075.27096748393, 6097.817065488042, 6102.420270074336, 6103.115048318058, 5613.663180209201, 5677.858053548694, 5678.68767217807, 5729.083346664514, 5766.106253530709, 5798.94201057984, 5823.650580965155, 5884.529237661062, 5901.527877769682, 5926.022206336079, 5650.3219613646625, 5673.461021202979, 5683.033884239772, 5683.857903552444, 5685.886282274414, 5466.480684334982, 5614.69119198448, 5650.29371328584, 5704.11586204139, 5709.54323654115, 5628.324601047737, 5634.971825140848, 5637.605367624227, 5670.603057785916, 5692.117721753135, 5763.049096898964, 5768.682722450306, 5801.941980580309, 5817.301923769175, 5821.243238378984, 5552.583556233218, 5591.04952158126, 5617.971910140586, 5629.971850140723, 5637.802676906289], "value": 5380.44024709496, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [591.9847461603349, 616.2635650397775, 617.3332800575382, 628.1300398947457, 640.6188317950817, 31769.36461270776, 32321.0, 34759.82620086902, 35072.82463587679, 35167.0, 43150.13699726004, 44224.33663495042, 44237.11525769483, 48489.51510484894, 48505.75747121268, 8962.507062111581, 9061.864072038925, 9101.817963640724, 9102.499362535058, 9123.406978546407, 9004.68483603074, 9044.77388065297, 9072.31957603179, 9081.091890810932, 9106.544672766335, 9108.362414630945, 9146.451212927212, 9152.679656212, 9156.587953542106, 9159.175674189322, 9017.95491022544, 9070.365074444791, 9084.90915090854, 9089.81820363589, 9093.63625454981, 8940.792992945933, 8993.055729148411, 8993.59528821198, 9002.234810041155, 9008.549572521348, 42544.57455425468, 42799.0, 42821.78589107034, 42845.35731964023, 42855.57144428547, 3648.7687639969577, 3714.0900479382453, 3800.619938006205, 3840.4047372657283, 4141.751494910285, 32799.0, 33081.6691833081, 33518.83240583806, 33523.4971475428, 35016.64983350159, 4064.410660454247, 4211.536730959592, 4348.369486424483, 4358.375091604117, 4404.911901761947, 353675.0, 354340.0, 355164.0, 355627.99999999744, 355645.0, 57314.7134264326, 57390.42609573934, 57883.421165787804, 57994.0, 58081.70959145177, 59664.70167649221, 59917.40082599205, 60061.39938600558, 60104.39895601075, 60105.39894601086, 16335.18324083791, 16602.418915337905, 16629.0, 16643.33426662944, 16649.50051498457, 12820.294883781482, 12897.290649014207, 12931.28877911705, 12936.223826570436, 12944.805827912589, 14501.492447764278, 16107.758383624256, 16140.659604357303, 16145.919270403807, 16157.676846463004, 6400.423961843457, 6440.516961227927, 6456.9354306456335, 6496.350364963466, 6840.486963477759, 1007.4610083605236, 1033.1424917318607, 1066.1151244467228, 1124.0, 1133.1388145009853, 32700.69197232084, 32766.0, 32771.67228327734, 32772.34455310881, 33538.664613353554, 1115.8214685650257, 1125.622916323041, 1147.713071732067, 1147.862256529222, 1150.235093662705, 16745.83254167467, 17099.829001710073, 17229.39697110595, 17376.65246695059, 17525.50275444601, 536330.0, 541159.0, 541422.0, 541509.0, 541907.0, 57712.71143644255, 58030.41969580334, 58049.41950580524, 58070.0, 58097.128543071885, 1243.5461056714234, 1361.3465536542515, 1372.5264783649625, 1376.8347798264272, 1378.3866179550005, 31774.36451271008, 32806.83596582002, 33472.330553389285, 33655.0, 34112.48831267483, 43625.56374436215, 43941.340879887466, 44023.339649904636, 44092.55907440885, 44150.0, 393476.0, 394323.0, 396136.0, 396441.0, 398465.0, 33865.49201762025, 35168.47247291344, 43135.56864431441, 43420.782896085315, 44476.0, 47061.294080589505, 47552.52447475481, 47833.76083119562, 47844.76077619589, 48274.27588586104, 39714.2057158861, 39826.203475930895, 39898.601013989486, 40930.0, 41255.58744412637, 40309.1938161241, 40963.0, 41079.0, 41841.79079104585, 42855.57144428516, 39926.401103982884, 41004.0, 41464.585354146075, 41766.582334176266, 41877.581224187365, 33717.49423758597, 36597.81701091584, 36617.45073823948, 37273.81363093167, 37388.252234954605, 27561.31096722598, 27805.721942780314, 27979.300517487227, 28060.29849253785, 28268.717312826608], "value": 20113.45399313858, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [366.57950442037105, 376.6440713525719, 396.8353133449618, 403.1755060900458, 421.4079218697729, 14592.562223133296, 16869.91565042176, 18421.907890460545, 20151.0, 20180.8990955045, 15256.923715381408, 15358.308876100575, 15762.211889405513, 18803.811961880376, 19408.835469871818, 5700.914486282699, 5763.0779075347955, 5834.620749651281, 5871.588988770788, 5872.383399743008, 5624.634398764088, 5748.396418376073, 5766.336871259817, 5774.82675519735, 5793.913091303634, 5597.776088956437, 5674.914876276859, 5718.971405142968, 5745.023346031185, 5773.249477567911, 5739.827805165852, 5741.741621627037, 5749.108888122348, 5750.108733146369, 5755.6258843175265, 4937.753112344404, 5177.197534382177, 5205.609579281569, 5213.0, 5216.165413533854, 13861.653458663513, 15573.922130389388, 22650.433739156488, 23432.531349372915, 23656.526869462687, 2326.220716060122, 2387.200287903537, 2389.0, 2400.1839374612714, 2471.938201544976, 10038.799224015553, 10098.932803561956, 10230.0, 10238.334508257014, 10701.464926753632, 1798.7301904714266, 1809.4571628511526, 1887.7451544041517, 1899.9715004274947, 1948.6687263165295, 86517.56741216316, 87321.56339218264, 87374.56312718395, 88889.0, 91651.54174229153, 10660.68017959447, 10762.892371076345, 10776.67669969902, 10889.237753357189, 10890.346579205274, 12404.56584019555, 14107.85892141086, 14957.0, 15400.691986160215, 15449.768253476206, 7943.285104340637, 7971.760847174594, 8103.635336409876, 8158.224968627971, 8189.22202390772, 7791.181925897812, 7869.213078692085, 7910.920890791133, 8019.35845132388, 8193.631286592117, 4464.933026004613, 4485.125400546927, 4576.359309696645, 4618.515055919147, 4682.344471773954, 1869.7756269247777, 1974.2450756045964, 2010.497375656086, 2020.3736841578864, 2046.9181232750523, 867.2238346679686, 987.3976874106789, 1030.2891005206384, 1082.4209048159198, 1090.1660229924114, 18462.630747384977, 19125.0, 19172.616547668968, 19283.614327713367, 19636.607267854848, 964.3827950111934, 988.229181238635, 1010.1060561403211, 1023.2683631203577, 1056.3714589819044, 10191.133753630877, 10250.743731406774, 10649.84025239622, 10656.680299591024, 10657.147428205724, 490338.0, 494499.0, 494959.0, 496029.63896263455, 496523.0, 97926.0, 98775.50612246893, 99788.0, 101723.0, 102827.0, 949.2074118111454, 965.546193289167, 998.4259051045677, 1000.8348622477355, 1015.5836107196162, 16117.274722637276, 16420.004976362277, 16994.0, 17419.56451088733, 17467.56331091733, 31519.84240078785, 32513.0, 44440.33339499845, 44818.55181448144, 45600.315995259436, 57466.7126664364, 58318.4168158313, 60554.0, 61104.69447652733, 61322.69338653456, 8140.308073813792, 8259.297959673495, 8553.690503564127, 8860.202581767671, 8970.551472426483, 9462.57418416159, 12488.812667809809, 13132.606021819362, 13726.901847851948, 14050.508232212233, 9301.255899528156, 11363.602273920373, 11530.308181509135, 11722.94138529302, 11881.1089168311, 11049.502772375423, 11321.716957075809, 11370.829437558277, 11478.196526243417, 11545.653630391102, 11782.293062416282, 11794.233374830952, 11817.881821181678, 11962.641120766391, 11992.520299187934, 8325.583720814057, 8399.370047246359, 8401.62192701342, 8555.31557475388, 8657.22085012352, 11176.0, 11178.664640060812, 11683.532658693557, 11732.70668233301, 11748.530058797553], "value": 9083.348613946959, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1485.5097817720152, 1498.9025713328633, 1608.5335252776695, 1769.9732758964537, 1787.0528619831493, 8433.325333973282, 9143.634254629824, 9153.81692366154, 9160.221381182599, 9166.40418372807, 7535.359494442979, 7757.922420775791, 7766.456348055638, 8000.759977200679, 8935.106489351061, 2288.9084436622556, 2364.207990323244, 2381.4879800842814, 2389.462370966536, 2396.4607963208227, 2351.9294421167306, 2370.6562548430466, 2385.0459816073535, 2390.796782273509, 2392.9162479313227, 2395.197608801054, 2395.9161429349974, 2398.70016247969, 2399.1003373734848, 2407.1935901473025, 2278.4190031541934, 2310.156792770635, 2314.872682002489, 2317.0268487235317, 2325.279163459333, 2303.170858490942, 2314.4445333120098, 2335.3577766114286, 2336.707911511061, 2337.883105844701, 8718.912810871938, 8772.692955746583, 8773.517456539888, 8779.253763430052, 8956.417832840845, 5267.55225805807, 5389.892202155974, 5408.4591540845995, 5408.486193811582, 5410.133503941134, 3394.1853955050856, 3498.2129020970333, 3550.289942011608, 3563.7149028077692, 3569.161247106928, 1123.4831977290455, 1161.866385365677, 1178.4637989714658, 1189.0309397840733, 1196.5752157983964, 11820.054395648327, 12194.024478041736, 12232.755344893052, 12465.189762665397, 12577.622671319876, 4427.5351088135285, 4542.84100056503, 4561.498235194126, 4653.0, 4690.64820138491, 9669.17811985975, 9704.563294651758, 9717.708468745948, 9721.319507634398, 9742.0, 5298.390685071189, 5312.282841816305, 5332.813351532678, 5333.786648534093, 5338.225957236179, 4747.8575642730775, 4922.384701912261, 4962.6774259673, 4980.77586508608, 4982.900341993212, 3704.221973452758, 3704.81475926208, 3781.905452363713, 3832.0994566276904, 3843.6348546888003, 1162.9302241865514, 1168.0888906652824, 1170.4030944218339, 1186.5965571705663, 1189.5598628507507, 991.7867658453467, 995.5918073589938, 1016.8678071850612, 1025.3489034463169, 1029.9330543514648, 6066.545009124334, 6074.878502429927, 6149.7847575335545, 6210.099535567318, 6381.074744162071, 462.45661347916064, 463.63604570412065, 466.710639403572, 472.4401584122825, 996.19308360227, 3902.843886244575, 4211.789410529523, 4233.153369326147, 4249.065205654751, 4507.121111383249, 11151.275167114112, 11424.885751142383, 11490.42547872603, 11508.88491115078, 11513.597024104116, 11049.226554141294, 11194.496247668874, 11397.031252343644, 11404.600838970597, 11409.48657310423, 8108.43240973138, 8259.174082591693, 8262.17378262169, 8263.834723305501, 8264.669413223404, 5996.520278377807, 6004.249468816398, 6032.33644299118, 6048.274207095177, 6186.319504854552, 9720.222382209548, 10201.336913100624, 10213.795724085328, 10297.433641149808, 10355.119814815524, 10308.639197628047, 10390.636327728493, 10502.52738626779, 10527.894721052691, 10552.366857988545, 6715.697793599202, 7006.633706427401, 7081.150261968597, 7747.845043098993, 7749.418793590616, 8792.604332805167, 8873.467591944504, 8897.0, 8899.777505562413, 8903.554822258731, 7798.181190975093, 7816.687332506864, 7978.242067003625, 8094.716684915999, 8117.918820811952, 7547.358474529727, 7737.381009519112, 7755.302022817974, 7755.728549500966, 7784.727534536264, 6983.44132469391, 7050.612216328152, 7078.504504684623, 7079.1505019398, 7086.716531338689, 5176.9741151294, 5216.791328346823, 5289.20661900718, 5307.203919412119, 5469.288992430958, 5423.186522021729, 5433.2665090213895, 5442.319710036246, 5493.862653433696, 5500.834974950758], "value": 4624.156241915079, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [304.3471753089623, 317.5522513256309, 323.43883362366296, 323.74100719424456, 326.41082845463944, 5255.789768409264, 5304.230886521452, 5315.069862774014, 5330.786768529254, 5383.515483606469, 4982.925256121152, 4993.528203539244, 5153.587712982961, 5180.740962951847, 5278.709670968095, 4126.587341265879, 4126.896827579305, 4128.938065929014, 4154.501459824825, 4162.97918510407, 4079.1229885574594, 4132.586741325858, 4152.252594532983, 4154.563770804052, 4163.209819777495, 3880.2821478026513, 3929.4302326162688, 4079.2657321682086, 4090.3046482097966, 4113.8971525711795, 4059.3505039193883, 4062.939055914164, 4078.286299897506, 4080.612591718815, 4084.979575102135, 3626.9455958160647, 3627.818609069562, 3628.63713628635, 3630.945535816965, 3639.090227443139, 5039.874003149914, 5053.7618283520405, 5071.37994603646, 5166.664166829144, 5184.144616138333, 4649.558291962258, 4661.207594708908, 4663.554298167545, 4674.602658774008, 4694.178518759203, 5425.240466334716, 5426.864328391822, 5431.293931788881, 5436.472040501147, 5467.152591348347, 3669.2294618130227, 3850.1144736710435, 3978.76127432355, 3983.721139520235, 3989.3816458448696, 5641.671413865839, 5652.2195508415125, 5653.0, 5663.1505274208785, 5667.376588575254, 3953.940690889639, 3960.940585891214, 3975.284448799244, 3975.5351681956795, 3984.5019372578427, 3950.150717595731, 4023.114914718757, 4030.214108248922, 4036.345098509597, 4046.817893194813, 4577.130345234395, 4591.839285625054, 4602.171609110325, 4616.9307460387445, 4628.95371046292, 5473.75368108436, 5476.370217424967, 5506.265526359264, 5508.55931525477, 5519.613627046068, 1371.245814801875, 1380.5582213691723, 1395.5603984744773, 1397.3362652739868, 1403.859614038588, 879.3185281406961, 883.5802993578, 887.3699673232078, 888.8177923525661, 899.9775005624781, 4749.857504274808, 4761.357216775691, 4762.380890484214, 4762.642182403062, 4855.684380515255, 5032.798688052437, 5034.622403319766, 5049.747512624427, 5068.873278168002, 5115.2582875483595, 4534.841280555231, 4672.95327046732, 4677.321788340671, 4698.859034228979, 4704.400503828646, 2616.0, 2616.4636249568794, 2620.6593142891684, 2624.9237812496785, 2629.7508683375245, 5049.823256186016, 5058.924116138261, 5079.3650793650795, 5094.414142373675, 5104.719240441737, 4802.27965805132, 4983.50164983506, 4996.6502344836235, 5048.873778155502, 5055.51972562606, 5033.471485494044, 5043.899122017612, 5052.8484145475695, 5074.579117847009, 5079.492050794965, 4845.878853028703, 4915.729634870117, 4952.306677065142, 4952.826651067196, 4956.3804524434445, 5259.47405259471, 5614.29821272341, 5616.6068375213345, 5626.831195064155, 5656.547476201977, 5852.151438041546, 5856.531477481876, 5865.94134058654, 5868.0, 5869.618474799296, 3959.6238357356006, 4060.3097473428998, 4097.7746223957965, 4117.75293482392, 4123.340265557496, 5354.625176237626, 5483.259759932358, 5611.8877622448135, 5652.576056795675, 5657.575681823797, 5421.484958928895, 5438.428964958623, 5442.755076021509, 5454.427285135003, 5491.945080549303, 5483.8080667176455, 5484.698341591251, 5489.478499542537, 5490.258815060076, 5519.254900588369, 5246.265522826884, 5380.757865896122, 5402.595325215394, 5421.593380496557, 5423.210340587518, 5466.398696143341, 5504.146857237135, 5520.889582208413, 5521.1442226454965, 5550.583706221969, 5272.0, 5378.865528361822, 5414.593905457185, 5416.322959630046, 5417.458254174709], "value": 4062.1015083201073, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [739.412167326975, 744.7653988993467, 790.7706765038142, 824.979375515612, 832.6835802395088, 14363.856361436383, 15042.172680502568, 15472.845271547281, 15502.069875807445, 16437.09595972221, 14268.429262829475, 14382.640433989156, 14439.42242310309, 14473.42106315746, 14495.130292182477, 639.1180171363512, 774.8876412920151, 783.298947442039, 795.2961628958385, 798.5767543202084, 778.6029125146188, 779.4115442840647, 779.5283853268747, 780.0756104016758, 780.6174974262627, 820.1962077164383, 821.6179476543406, 822.235321151329, 823.0247157118804, 825.7894236969595, 669.0866966590618, 808.8746244332137, 816.0003995106007, 820.9096999330069, 821.4537332673794, 605.5730709849546, 605.7879742090278, 606.0122001138117, 606.4026933470528, 606.4057223920582, 15306.234688265653, 15335.30991105403, 15336.769948450783, 15337.46318878845, 15360.539183824503, 14667.193304368255, 14990.550283491513, 15246.161461119635, 15460.0, 15573.0, 12873.0, 13049.86950130496, 13380.598582042554, 13675.521356752466, 13756.65608359789, 4477.350784136282, 4486.641068714495, 4496.392986946753, 4515.729056256635, 4624.213883639755, 81739.0, 84465.17487551748, 85481.57259213664, 86226.30066711122, 86544.0, 10959.671209863716, 10978.615748448925, 11111.333320000826, 11162.609308674157, 11264.831027534594, 20028.0, 20066.698999515018, 20092.59814803696, 20109.899450502948, 20131.19475221004, 8356.749297521084, 8440.746777596682, 8450.281726053354, 8809.911900881038, 8816.955915220382, 4780.593649539828, 4934.383202099738, 4938.530839570307, 4961.751912404366, 5113.51421614946, 3547.219611685425, 3718.795466249382, 3725.2735716535017, 3730.9926319893475, 3731.3097077040834, 609.3571282297219, 627.4603840696997, 627.632834791652, 628.8647940692681, 630.0517720830121, 644.1754554170669, 664.3323459922747, 679.9626020568817, 684.3020119478203, 690.492488021304, 8359.373047021498, 8470.322374210049, 8681.956590217009, 9134.589161662776, 9215.723528294162, 590.7784580782206, 592.9229200203946, 649.8886903395247, 658.5916731626422, 690.3959035843637, 4075.083106301118, 4116.238495878272, 4135.17296540693, 4147.896302592399, 4191.476065491814, 97897.51051244698, 100311.0, 102581.48709256406, 111942.0, 120026.39986800184, 95217.0, 95341.52329238309, 95877.52061239649, 95919.36725694721, 96118.0, 54108.458915410345, 54135.0604990742, 55226.0, 55313.1703024455, 83474.58262708648, 9490.525473726148, 9840.242184455983, 9853.753656158653, 9932.851007235042, 10021.749456263651, 50438.0, 51082.74458627683, 52392.0, 52727.20909186442, 52842.73578632082, 66440.33559664342, 70668.64665676639, 73265.26734732585, 73450.0, 73685.6315718418, 12715.0, 12769.61691149267, 12942.158759680591, 12966.675833104247, 13001.609951701465, 14190.929045354707, 14393.712125757636, 14404.207768572829, 14784.556463306119, 15143.545693628768, 13024.218546887218, 13265.137766045176, 13393.397297121848, 13901.443942242196, 13923.721525569634, 12792.232466052066, 13557.525486607921, 13795.310234488035, 14010.719785604435, 14762.48331308399, 12156.878431215575, 12160.75678486443, 12357.0, 12749.043821713223, 12793.104482686123, 10840.403777792297, 11035.724106897393, 11460.968512833884, 11608.245464045149, 11962.46168922418, 10287.43419111956, 11639.41802909868, 11834.644960651194, 11866.584669536525, 12034.879651203375], "value": 7415.470773412296, "unit": "score"}], "name": "dromaeo_css", "value": 7179.372729000398, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 112.0, 112.0, 110.0, 106.0, 111.0, 113.0, 111.0, 112.0, 111.0], "value": 110.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 116.0, 119.0, 187.0, 117.0, 121.0, 143.0, 118.0, 161.0, 122.0], "value": 134.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 159.0, 160.0, 161.0, 162.0, 159.0, 159.0, 162.0, 162.0, 161.0], "value": 160.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 111.0, 76.0, 87.0, 75.0, 74.0, 104.0, 74.0], "value": 82.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 125.0, 84.0, 84.0, 84.0, 115.0, 84.0, 84.0, 125.0], "value": 95.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 116.0, 116.0, 117.0, 117.0, 117.0, 117.0, 118.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 146.0, 145.0, 145.0, 146.0, 145.0, 145.0, 146.0, 146.0], "value": 145.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 50.0, 51.0, 50.0, 50.0, 52.0, 51.0, 49.0, 53.0, 51.0], "value": 51.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 63.0, 61.0, 61.0, 64.0, 63.0, 63.0, 62.0, 61.0, 62.0], "value": 62.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 81.0, 83.0, 78.0, 79.0, 78.0, 78.0, 83.0, 78.0, 78.0], "value": 79.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 123.0, 136.0, 126.0, 122.0, 129.0, 122.0, 120.0, 145.0, 122.0], "value": 127.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 163.0, 165.0, 161.0, 168.0, 166.0, 169.0, 167.0, 166.0], "value": 165.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 64.0, 62.0, 64.0, 63.0, 63.0, 62.0, 62.0, 63.0], "value": 63.0, "unit": "score"}], "name": "kraken", "value": 1488.8999999999999, "alertThreshold": 2.0}]} 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 INFO - # 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.966034Z] 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: 1193s; CPU: 13.0%; Read bytes: 4096; Write bytes: 420335616; Read time: 208; Write time: 254392 20:55:02 INFO - TinderboxPrint: CPU usage
13.0% 20:55:02 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 208 20:55:02 INFO - TinderboxPrint: I/O write bytes / time
420,335,616 / 254,392 20:55:02 INFO - TinderboxPrint: CPU idle
8,279.7 (87.0%) 20:55:02 INFO - TinderboxPrint: CPU user
1,196.3 (12.6%) 20:55:02 INFO - TinderboxPrint: Swap in / out
0 / 0 20:55:02 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 4096; Write bytes: 129368064; Read time: 208; Write time: 83508 20:55:02 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 0; Write bytes: 290967552; Read time: 0; Write time: 170884 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:03 INFO - (blobuploader) - INFO - Open directory for files ... 20:55:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 20:55:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:55:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:55:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.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:08 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: 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 - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 20:55:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:55:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:55:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.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_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f483774e8cfa056949ac20e964a0011fb54427819be4d0d254704abc20c844e58c9fe7a14d2df4eab5d60363f2a7e159395a4b298bb9c94f888fff25f582eae3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/53672fcba4f98344f623e986a219c837323d7a01b3999ea1478303d16f737d437b67efdb5d924afd002b844725e6ce9f3ef851d94cb705ddbe8be91a2d44096b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/057f7bb3d1e22a4b32e91db2d66381c93ec9e0fcd4b484c7e0af9642bbe68f924d600c376b38e7a99e388e9489a370818f62c18a2c3138fe85d608756849d100"} 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_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f483774e8cfa056949ac20e964a0011fb54427819be4d0d254704abc20c844e58c9fe7a14d2df4eab5d60363f2a7e159395a4b298bb9c94f888fff25f582eae3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/53672fcba4f98344f623e986a219c837323d7a01b3999ea1478303d16f737d437b67efdb5d924afd002b844725e6ce9f3ef851d94cb705ddbe8be91a2d44096b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/057f7bb3d1e22a4b32e91db2d66381c93ec9e0fcd4b484c7e0af9642bbe68f924d600c376b38e7a99e388e9489a370818f62c18a2c3138fe85d608756849d100"} 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=1238.281910 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-08-12 20:55:07.366227) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-12 20:55:07.369781) ========= 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=ed14279e38b05397cf4aa391000001a4-1471059002.348362-85883166 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f483774e8cfa056949ac20e964a0011fb54427819be4d0d254704abc20c844e58c9fe7a14d2df4eab5d60363f2a7e159395a4b298bb9c94f888fff25f582eae3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/53672fcba4f98344f623e986a219c837323d7a01b3999ea1478303d16f737d437b67efdb5d924afd002b844725e6ce9f3ef851d94cb705ddbe8be91a2d44096b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/057f7bb3d1e22a4b32e91db2d66381c93ec9e0fcd4b484c7e0af9642bbe68f924d600c376b38e7a99e388e9489a370818f62c18a2c3138fe85d608756849d100"} 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.011416 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_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f483774e8cfa056949ac20e964a0011fb54427819be4d0d254704abc20c844e58c9fe7a14d2df4eab5d60363f2a7e159395a4b298bb9c94f888fff25f582eae3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/53672fcba4f98344f623e986a219c837323d7a01b3999ea1478303d16f737d437b67efdb5d924afd002b844725e6ce9f3ef851d94cb705ddbe8be91a2d44096b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/057f7bb3d1e22a4b32e91db2d66381c93ec9e0fcd4b484c7e0af9642bbe68f924d600c376b38e7a99e388e9489a370818f62c18a2c3138fe85d608756849d100"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-12 20:55:07.395245) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-12 20:55:07.395577) ========= 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=ed14279e38b05397cf4aa391000001a4-1471059002.348362-85883166 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004492 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-12 20:55:07.480193) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-12 20:55:07.480683) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-12 20:55:07.481020) ========= ========= Total master_lag: 0.17 =========