builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-055 starttime: 1462573469.04 results: success (0) buildid: 20160506135800 builduid: 25f8d0b308a64bd4bfe3f1d116779698 revision: 0a55f3f89efd80dadf3d951e1a0d073a66fec9a0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-06 15:24:29.043381) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-06 15:24:29.044176) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-06 15:24:29.044565) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-06 15:24:29.075402) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 15:24:29.075668) ========= 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=82e07478c745e68b1fe4678a000001bc-1462573450.988758-2105385975 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-06 15:24: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.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 230M=0s 2016-05-06 15:24:29 (230 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.150409 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 15:24:29.262809) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 15:24:29.263114) ========= 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=82e07478c745e68b1fe4678a000001bc-1462573450.988758-2105385975 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016870 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 15:24:29.321085) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-06 15:24:29.321402) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 0a55f3f89efd80dadf3d951e1a0d073a66fec9a0 --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 0a55f3f89efd80dadf3d951e1a0d073a66fec9a0 --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=82e07478c745e68b1fe4678a000001bc-1462573450.988758-2105385975 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-06 15:24:29,830 truncating revision to first 12 chars 2016-05-06 15:24:29,830 Setting DEBUG logging. 2016-05-06 15:24:29,830 attempt 1/10 2016-05-06 15:24:29,830 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/0a55f3f89efd?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-06 15:24:31,008 unpacking tar archive at: fx-team-0a55f3f89efd/testing/mozharness/ program finished with exit code 0 elapsedTime=1.458669 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-06 15:24:30.793494) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-06 15:24:30.793832) ========= script_repo_revision: 0a55f3f89efd80dadf3d951e1a0d073a66fec9a0 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-06 15:24:30.794249) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-06 15:24:30.794523) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-06 15:24:30.803025) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-05-06 15:24:30.803305) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=82e07478c745e68b1fe4678a000001bc-1462573450.988758-2105385975 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:24:31 INFO - MultiFileLogger online at 20160506 15:24:31 in /builds/slave/test 15:24:31 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 15:24:31 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:24:31 INFO - {'append_to_log': False, 15:24:31 INFO - 'base_work_dir': '/builds/slave/test', 15:24:31 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 15:24:31 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:24:31 INFO - 'branch': 'Fx-Team-Non-PGO', 15:24:31 INFO - 'buildbot_json_path': 'buildprops.json', 15:24:31 INFO - 'config_files': ('talos/linux_config.py',), 15:24:31 INFO - 'default_actions': ('clobber', 15:24:31 INFO - 'read-buildbot-config', 15:24:31 INFO - 'download-and-extract', 15:24:31 INFO - 'populate-webroot', 15:24:31 INFO - 'create-virtualenv', 15:24:31 INFO - 'install', 15:24:31 INFO - 'run-tests'), 15:24:31 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:24:31 INFO - 'download_minidump_stackwalk': True, 15:24:31 INFO - 'download_symbols': 'ondemand', 15:24:31 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:24:31 INFO - 'tooltool.py': '/tools/tooltool.py', 15:24:31 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:24:31 INFO - '/tools/misc-python/virtualenv.py')}, 15:24:31 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:24:31 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:24:31 INFO - 'installer_path': 'installer.exe', 15:24:31 INFO - 'log_level': 'info', 15:24:31 INFO - 'log_name': 'talos', 15:24:31 INFO - 'log_to_console': True, 15:24:31 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:24:31 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:24:31 INFO - 'opt_config_files': (), 15:24:31 INFO - 'pip_index': False, 15:24:31 INFO - 'sps_profile': False, 15:24:31 INFO - 'sps_profile_interval': 0, 15:24:31 INFO - 'suite': 'dromaeojs-e10s', 15:24:31 INFO - 'system_bits': '32', 15:24:31 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:24:31 INFO - 'title': 'talos-linux64-ix-055', 15:24:31 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:24:31 INFO - 'use_talos_json': True, 15:24:31 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:24:31 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:24:31 INFO - 'work_dir': 'build'} 15:24:31 INFO - ##### 15:24:31 INFO - ##### Running clobber step. 15:24:31 INFO - ##### 15:24:31 INFO - Running pre-action listener: _resource_record_pre_action 15:24:31 INFO - Running main action method: clobber 15:24:31 INFO - rmtree: /builds/slave/test/build 15:24:31 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:24:32 INFO - Running post-action listener: _resource_record_post_action 15:24:32 INFO - ##### 15:24:32 INFO - ##### Finished clobber step (success) 15:24:32 INFO - ##### 15:24:32 INFO - ##### 15:24:32 INFO - ##### Running read-buildbot-config step. 15:24:32 INFO - ##### 15:24:32 INFO - Running pre-action listener: _resource_record_pre_action 15:24:32 INFO - Running main action method: read_buildbot_config 15:24:32 INFO - Using buildbot properties: 15:24:32 INFO - { 15:24:32 INFO - "project": "", 15:24:32 INFO - "product": "firefox", 15:24:32 INFO - "script_repo_revision": "production", 15:24:32 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 15:24:32 INFO - "repository": "", 15:24:32 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 15:24:32 INFO - "buildid": "20160506135800", 15:24:32 INFO - "pgo_build": "False", 15:24:32 INFO - "basedir": "/builds/slave/test", 15:24:32 INFO - "buildnumber": 1488, 15:24:32 INFO - "slavename": "talos-linux64-ix-055", 15:24:32 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 15:24:32 INFO - "platform": "ubuntu64_hw", 15:24:32 INFO - "scheduler": "tests-fx-team-linux64-talos", 15:24:32 INFO - "branch": "fx-team", 15:24:32 INFO - "repo_path": "integration/fx-team", 15:24:32 INFO - "revision": "0a55f3f89efd80dadf3d951e1a0d073a66fec9a0", 15:24:32 INFO - "stage_platform": "linux64", 15:24:32 INFO - "builduid": "25f8d0b308a64bd4bfe3f1d116779698", 15:24:32 INFO - "slavebuilddir": "test" 15:24:32 INFO - } 15:24:32 INFO - Found installer url https://queue.taskcluster.net/v1/task/aQR-sNOyTxaUBvB5rHkzTg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 15:24:32 INFO - Running post-action listener: _resource_record_post_action 15:24:32 INFO - ##### 15:24:32 INFO - ##### Finished read-buildbot-config step (success) 15:24:32 INFO - ##### 15:24:32 INFO - ##### 15:24:32 INFO - ##### Running download-and-extract step. 15:24:32 INFO - ##### 15:24:32 INFO - Running pre-action listener: _resource_record_pre_action 15:24:32 INFO - Running main action method: download_and_extract 15:24:32 INFO - mkdir: /builds/slave/test/build/tests 15:24:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:24:32 INFO - https://queue.taskcluster.net/v1/task/aQR-sNOyTxaUBvB5rHkzTg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 15:24:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aQR-sNOyTxaUBvB5rHkzTg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 15:24:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aQR-sNOyTxaUBvB5rHkzTg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 15:24:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aQR-sNOyTxaUBvB5rHkzTg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 15:24:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aQR-sNOyTxaUBvB5rHkzTg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 15:24:33 INFO - Downloaded 1361 bytes. 15:24:33 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 15:24:33 INFO - Using the following test package requirements: 15:24:33 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 15:24:33 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:24:33 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:24:33 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:24:33 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 15:24:33 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:24:33 INFO - u'jsshell-linux-x86_64.zip'], 15:24:33 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:24:33 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:24:33 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 15:24:33 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:24:33 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:24:33 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:24:33 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:24:33 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:24:33 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:24:33 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:24:33 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:24:33 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:24:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:24:33 INFO - https://queue.taskcluster.net/v1/task/aQR-sNOyTxaUBvB5rHkzTg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:24:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aQR-sNOyTxaUBvB5rHkzTg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 15:24:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aQR-sNOyTxaUBvB5rHkzTg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 15:24:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aQR-sNOyTxaUBvB5rHkzTg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 15:24:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aQR-sNOyTxaUBvB5rHkzTg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:24:34 INFO - Downloaded 22321395 bytes. 15:24:34 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:24:34 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 15:24:35 INFO - Return code: 0 15:24:35 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 15:24:35 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:24:35 INFO - https://queue.taskcluster.net/v1/task/aQR-sNOyTxaUBvB5rHkzTg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:24:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aQR-sNOyTxaUBvB5rHkzTg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 15:24:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aQR-sNOyTxaUBvB5rHkzTg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 15:24:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aQR-sNOyTxaUBvB5rHkzTg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 15:24:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aQR-sNOyTxaUBvB5rHkzTg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:24:44 INFO - Downloaded 22321395 bytes. 15:24:44 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:24:44 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 15:24:45 INFO - Return code: 0 15:24:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:24:45 INFO - https://queue.taskcluster.net/v1/task/aQR-sNOyTxaUBvB5rHkzTg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 15:24:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aQR-sNOyTxaUBvB5rHkzTg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 15:24:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aQR-sNOyTxaUBvB5rHkzTg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 15:24:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aQR-sNOyTxaUBvB5rHkzTg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 15:24:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aQR-sNOyTxaUBvB5rHkzTg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 15:24:46 INFO - Downloaded 10840152 bytes. 15:24:46 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:24:46 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 15:24:46 INFO - Return code: 0 15:24:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:24:46 INFO - https://queue.taskcluster.net/v1/task/aQR-sNOyTxaUBvB5rHkzTg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 15:24:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aQR-sNOyTxaUBvB5rHkzTg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 15:24:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aQR-sNOyTxaUBvB5rHkzTg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 15:24:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aQR-sNOyTxaUBvB5rHkzTg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 15:24:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aQR-sNOyTxaUBvB5rHkzTg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 15:24:48 INFO - Downloaded 54839275 bytes. 15:24:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/aQR-sNOyTxaUBvB5rHkzTg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 15:24:48 INFO - mkdir: /builds/slave/test/properties 15:24:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:24:48 INFO - Writing to file /builds/slave/test/properties/build_url 15:24:48 INFO - Contents: 15:24:48 INFO - build_url:https://queue.taskcluster.net/v1/task/aQR-sNOyTxaUBvB5rHkzTg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 15:24:49 INFO - Running post-action listener: _resource_record_post_action 15:24:49 INFO - Running post-action listener: set_extra_try_arguments 15:24:49 INFO - ##### 15:24:49 INFO - ##### Finished download-and-extract step (success) 15:24:49 INFO - ##### 15:24:49 INFO - ##### 15:24:49 INFO - ##### Running populate-webroot step. 15:24:49 INFO - ##### 15:24:49 INFO - Running pre-action listener: _resource_record_pre_action 15:24:49 INFO - Running main action method: populate_webroot 15:24:49 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:24:49 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:24:49 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:24:49 INFO - '--tppagecycles', 15:24:49 INFO - '7'], 15:24:49 INFO - 'tests': ['tsvgm']}}, 15:24:49 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:24:49 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:24:49 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:24:49 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:24:49 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:24:49 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:24:49 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:24:49 INFO - 'talos_options': ['--disable-e10s'], 15:24:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:24:49 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:24:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:24:49 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:24:49 INFO - 'talos_options': ['--disable-e10s'], 15:24:49 INFO - 'tests': ['damp', 'tps']}, 15:24:49 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:24:49 INFO - 'tests': ['damp', 'tps']}, 15:24:49 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:24:49 INFO - 'tests': ['dromaeo_dom']}, 15:24:49 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:24:49 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:24:49 INFO - 'tests': ['a11yr', 15:24:49 INFO - 'ts_paint', 15:24:49 INFO - 'tpaint', 15:24:49 INFO - 'sessionrestore', 15:24:49 INFO - 'sessionrestore_no_auto_restore', 15:24:49 INFO - 'tabpaint']}, 15:24:49 INFO - 'other-e10s': {'tests': ['a11yr', 15:24:49 INFO - 'ts_paint', 15:24:49 INFO - 'tpaint', 15:24:49 INFO - 'sessionrestore', 15:24:49 INFO - 'sessionrestore_no_auto_restore', 15:24:49 INFO - 'tabpaint']}, 15:24:49 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:24:49 INFO - 'ts_paint', 15:24:49 INFO - 'tpaint', 15:24:49 INFO - 'sessionrestore', 15:24:49 INFO - 'sessionrestore_no_auto_restore', 15:24:49 INFO - 'tabpaint']}, 15:24:49 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:24:49 INFO - 'ts_paint', 15:24:49 INFO - 'tpaint', 15:24:49 INFO - 'sessionrestore', 15:24:49 INFO - 'sessionrestore_no_auto_restore', 15:24:49 INFO - 'tabpaint']}, 15:24:49 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:24:49 INFO - 'tests': ['a11yr', 15:24:49 INFO - 'ts_paint', 15:24:49 INFO - 'tpaint', 15:24:49 INFO - 'sessionrestore', 15:24:49 INFO - 'sessionrestore_no_auto_restore', 15:24:49 INFO - 'tabpaint']}, 15:24:49 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:24:49 INFO - 'tests': ['a11yr', 15:24:49 INFO - 'ts_paint', 15:24:49 INFO - 'tpaint', 15:24:49 INFO - 'sessionrestore', 15:24:49 INFO - 'sessionrestore_no_auto_restore', 15:24:49 INFO - 'tabpaint']}, 15:24:49 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:24:49 INFO - 'tests': ['tsvgx', 15:24:49 INFO - 'tsvgr_opacity', 15:24:49 INFO - 'tart', 15:24:49 INFO - 'tscrollx', 15:24:49 INFO - 'cart']}, 15:24:49 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:24:49 INFO - 'tsvgr_opacity', 15:24:49 INFO - 'tart', 15:24:49 INFO - 'tscrollx', 15:24:49 INFO - 'cart']}, 15:24:49 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:24:49 INFO - 'talos_options': ['--disable-e10s'], 15:24:49 INFO - 'tests': ['tp5o']}, 15:24:49 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:24:49 INFO - 'tests': ['tp5o']}, 15:24:49 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:24:49 INFO - 'talos_options': ['--disable-e10s', 15:24:49 INFO - '--xperf_path', 15:24:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:24:49 INFO - 'tests': ['tp5n']}, 15:24:49 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:24:49 INFO - 'talos_options': ['--xperf_path', 15:24:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:24:49 INFO - 'tests': ['tp5n']}}, 15:24:49 INFO - 'talos.zip': {'path': '', 15:24:49 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:24:49 INFO - Running post-action listener: _resource_record_post_action 15:24:49 INFO - ##### 15:24:49 INFO - ##### Finished populate-webroot step (success) 15:24:49 INFO - ##### 15:24:49 INFO - ##### 15:24:49 INFO - ##### Running create-virtualenv step. 15:24:49 INFO - ##### 15:24:49 INFO - Running pre-action listener: _resource_record_pre_action 15:24:49 INFO - Running main action method: create_virtualenv 15:24:49 INFO - Creating virtualenv /builds/slave/test/build/venv 15:24:49 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 15:24:49 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:24:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:24:49 INFO - Using real prefix '/usr' 15:24:49 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:24:49 INFO - Installing distribute.............................................................................................................................................................................................done. 15:24:51 INFO - Installing pip.................done. 15:24:51 INFO - Return code: 0 15:24:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:24:51 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:24:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:24:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:24:51 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:24:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:24:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:24:51 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 0x7f3a30303f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a3f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b0a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b99410>, '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 0x1b9a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b9a7a0>, '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': '82e07478c745e68b1fe4678a000001bc-1462573450.988758-2105385975', '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 15:24:51 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 15:24:51 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 15:24:51 INFO - Using env: {'DISPLAY': ':0', 15:24:51 INFO - 'HOME': '/home/cltbld', 15:24:51 INFO - 'LANG': 'en_US.UTF-8', 15:24:51 INFO - 'LANGUAGE': 'en_US:en', 15:24:51 INFO - 'LOGNAME': 'cltbld', 15:24:51 INFO - 'MAIL': '/var/mail/cltbld', 15:24:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:24:51 INFO - 'MOZ_NO_REMOTE': '1', 15:24:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:24:51 INFO - 'NO_EM_RESTART': '1', 15:24:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:24:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:24:51 INFO - 'PWD': '/builds/slave/test', 15:24:51 INFO - 'SHELL': '/bin/bash', 15:24:51 INFO - 'SHLVL': '1', 15:24:51 INFO - 'TERM': 'linux', 15:24:51 INFO - 'TMOUT': '86400', 15:24:51 INFO - 'USER': 'cltbld', 15:24:51 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1462573450.988758-2105385975', 15:24:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:24:51 INFO - '_': '/tools/buildbot/bin/python'} 15:24:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:24:51 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 15:24:51 INFO - Cleaning up... 15:24:51 INFO - Return code: 0 15:24:51 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 15:24:51 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:24:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:24:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:24:51 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:24:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:24:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:24: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', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3a30303f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a3f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b0a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b99410>, '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 0x1b9a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b9a7a0>, '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': '82e07478c745e68b1fe4678a000001bc-1462573450.988758-2105385975', '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 15:24: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', 'psutil>=0.7.1'] in /builds/slave/test/build 15:24: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 psutil>=0.7.1 15:24:52 INFO - Using env: {'DISPLAY': ':0', 15:24:52 INFO - 'HOME': '/home/cltbld', 15:24:52 INFO - 'LANG': 'en_US.UTF-8', 15:24:52 INFO - 'LANGUAGE': 'en_US:en', 15:24:52 INFO - 'LOGNAME': 'cltbld', 15:24:52 INFO - 'MAIL': '/var/mail/cltbld', 15:24:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:24:52 INFO - 'MOZ_NO_REMOTE': '1', 15:24:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:24:52 INFO - 'NO_EM_RESTART': '1', 15:24:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:24:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:24:52 INFO - 'PWD': '/builds/slave/test', 15:24:52 INFO - 'SHELL': '/bin/bash', 15:24:52 INFO - 'SHLVL': '1', 15:24:52 INFO - 'TERM': 'linux', 15:24:52 INFO - 'TMOUT': '86400', 15:24:52 INFO - 'USER': 'cltbld', 15:24:52 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1462573450.988758-2105385975', 15:24:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:24:52 INFO - '_': '/tools/buildbot/bin/python'} 15:24:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:24:52 INFO - Downloading/unpacking psutil>=0.7.1 15:24: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 15:24: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 15:24: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 15:24: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 15:24: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 15:24: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 15:24:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:24:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:24:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:24:54 INFO - Installing collected packages: psutil 15:24:54 INFO - Running setup.py install for psutil 15:24:54 INFO - building 'psutil._psutil_linux' extension 15:24:54 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 15:24:54 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 15:24:54 INFO - building 'psutil._psutil_posix' extension 15:24:54 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 15:24:54 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 15:24:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:24:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:24:54 INFO - Successfully installed psutil 15:24:54 INFO - Cleaning up... 15:24:54 INFO - Return code: 0 15:24:54 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 15:24: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:24:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:24:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:24: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:24:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:24:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:24: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', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3a30303f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a3f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b0a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b99410>, '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 0x1b9a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b9a7a0>, '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': '82e07478c745e68b1fe4678a000001bc-1462573450.988758-2105385975', '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 15:24: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 15:24: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 mozsystemmonitor==0.0.0 15:24:54 INFO - Using env: {'DISPLAY': ':0', 15:24:54 INFO - 'HOME': '/home/cltbld', 15:24:54 INFO - 'LANG': 'en_US.UTF-8', 15:24:54 INFO - 'LANGUAGE': 'en_US:en', 15:24:54 INFO - 'LOGNAME': 'cltbld', 15:24:54 INFO - 'MAIL': '/var/mail/cltbld', 15:24:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:24:54 INFO - 'MOZ_NO_REMOTE': '1', 15:24:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:24:54 INFO - 'NO_EM_RESTART': '1', 15:24:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:24:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:24:54 INFO - 'PWD': '/builds/slave/test', 15:24:54 INFO - 'SHELL': '/bin/bash', 15:24:54 INFO - 'SHLVL': '1', 15:24:54 INFO - 'TERM': 'linux', 15:24:54 INFO - 'TMOUT': '86400', 15:24:54 INFO - 'USER': 'cltbld', 15:24:54 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1462573450.988758-2105385975', 15:24:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:24:54 INFO - '_': '/tools/buildbot/bin/python'} 15:24:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:24:54 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 15:24: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 15:24: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 15:24: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 15:24: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 15:24: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 15:24: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 15:24:56 INFO - Downloading mozsystemmonitor-0.0.tar.gz 15:24:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:24:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 15:24:56 INFO - Installing collected packages: mozsystemmonitor 15:24:56 INFO - Running setup.py install for mozsystemmonitor 15:24:56 INFO - Successfully installed mozsystemmonitor 15:24:56 INFO - Cleaning up... 15:24:57 INFO - Return code: 0 15:24:57 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:24: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:24:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:24:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:24: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:24:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:24:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:24: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 0x7f3a30303f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a3f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b0a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b99410>, '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 0x1b9a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b9a7a0>, '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': '82e07478c745e68b1fe4678a000001bc-1462573450.988758-2105385975', '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 15:24: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 15:24: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 15:24:57 INFO - Using env: {'DISPLAY': ':0', 15:24:57 INFO - 'HOME': '/home/cltbld', 15:24:57 INFO - 'LANG': 'en_US.UTF-8', 15:24:57 INFO - 'LANGUAGE': 'en_US:en', 15:24:57 INFO - 'LOGNAME': 'cltbld', 15:24:57 INFO - 'MAIL': '/var/mail/cltbld', 15:24:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:24:57 INFO - 'MOZ_NO_REMOTE': '1', 15:24:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:24:57 INFO - 'NO_EM_RESTART': '1', 15:24:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:24:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:24:57 INFO - 'PWD': '/builds/slave/test', 15:24:57 INFO - 'SHELL': '/bin/bash', 15:24:57 INFO - 'SHLVL': '1', 15:24:57 INFO - 'TERM': 'linux', 15:24:57 INFO - 'TMOUT': '86400', 15:24:57 INFO - 'USER': 'cltbld', 15:24:57 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1462573450.988758-2105385975', 15:24:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:24:57 INFO - '_': '/tools/buildbot/bin/python'} 15:24:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:24:57 INFO - Downloading/unpacking blobuploader==1.2.4 15:24: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 15:24: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 15:24: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 15:24: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 15:24: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 15:24: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 15:24:59 INFO - Downloading blobuploader-1.2.4.tar.gz 15:24:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:24:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:24: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 15:24: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 15:24: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 15:24: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 15:24: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 15:24: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 15:24:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:24:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:24: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 15:24: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 15:24: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 15:24: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 15:24: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 15:24: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 15:24:59 INFO - Downloading docopt-0.6.1.tar.gz 15:24:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:24:59 INFO - Installing collected packages: blobuploader, requests, docopt 15:24:59 INFO - Running setup.py install for blobuploader 15:24:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:24:59 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:24:59 INFO - Running setup.py install for requests 15:25:00 INFO - Running setup.py install for docopt 15:25:00 INFO - Successfully installed blobuploader requests docopt 15:25:00 INFO - Cleaning up... 15:25:00 INFO - Return code: 0 15:25:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:25: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:25:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:25:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:25: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:25:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:25:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:25: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 0x7f3a30303f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a3f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b0a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b99410>, '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 0x1b9a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b9a7a0>, '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': '82e07478c745e68b1fe4678a000001bc-1462573450.988758-2105385975', '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 15:25: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 15:25: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 15:25:00 INFO - Using env: {'DISPLAY': ':0', 15:25:00 INFO - 'HOME': '/home/cltbld', 15:25:00 INFO - 'LANG': 'en_US.UTF-8', 15:25:00 INFO - 'LANGUAGE': 'en_US:en', 15:25:00 INFO - 'LOGNAME': 'cltbld', 15:25:00 INFO - 'MAIL': '/var/mail/cltbld', 15:25:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:25:00 INFO - 'MOZ_NO_REMOTE': '1', 15:25:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:25:00 INFO - 'NO_EM_RESTART': '1', 15:25:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:25:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:25:00 INFO - 'PWD': '/builds/slave/test', 15:25:00 INFO - 'SHELL': '/bin/bash', 15:25:00 INFO - 'SHLVL': '1', 15:25:00 INFO - 'TERM': 'linux', 15:25:00 INFO - 'TMOUT': '86400', 15:25:00 INFO - 'USER': 'cltbld', 15:25:00 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1462573450.988758-2105385975', 15:25:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:25:00 INFO - '_': '/tools/buildbot/bin/python'} 15:25:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:25:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:25:00 INFO - Running setup.py (path:/tmp/pip-tXNlbd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:25:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:25:00 INFO - Running setup.py (path:/tmp/pip-R0d_0o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:25:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:25:00 INFO - Running setup.py (path:/tmp/pip-yZTt4V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:25:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:25:00 INFO - Running setup.py (path:/tmp/pip-ppJ801-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:25:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:25:00 INFO - Running setup.py (path:/tmp/pip-iL29zE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:25:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:25:00 INFO - Running setup.py (path:/tmp/pip-Ps5Vqb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:25:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:25:01 INFO - Running setup.py (path:/tmp/pip-E9J_XL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:25:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:25:01 INFO - Running setup.py (path:/tmp/pip-ytz077-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:25:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:25:01 INFO - Running setup.py (path:/tmp/pip-FQTw18-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:25:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:25:01 INFO - Running setup.py (path:/tmp/pip-9YvU_J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:25:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:25:01 INFO - Running setup.py (path:/tmp/pip-l9UsMA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:25:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:25:01 INFO - Running setup.py (path:/tmp/pip-Qq6Xca-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:25:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:25:01 INFO - Running setup.py (path:/tmp/pip-Rl7EzZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:25:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:25:01 INFO - Running setup.py (path:/tmp/pip-X3STSC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:25:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:25:01 INFO - Running setup.py (path:/tmp/pip-KhSOo2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:25:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:25:01 INFO - Running setup.py (path:/tmp/pip-xN5XPg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:25:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:25:01 INFO - Running setup.py (path:/tmp/pip-rpfkdB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:25:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:25:01 INFO - Running setup.py install for manifestparser 15:25:01 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:25:01 INFO - Running setup.py install for mozcrash 15:25:02 INFO - Running setup.py install for mozdebug 15:25:02 INFO - Running setup.py install for mozdevice 15:25:02 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:25:02 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:25:02 INFO - Running setup.py install for mozfile 15:25:02 INFO - Running setup.py install for mozhttpd 15:25:02 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:25:02 INFO - Running setup.py install for mozinfo 15:25:02 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:25:02 INFO - Running setup.py install for mozInstall 15:25:02 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:25:02 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:25:02 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:25:02 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:25:02 INFO - Running setup.py install for mozleak 15:25:02 INFO - Running setup.py install for mozlog 15:25:02 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:25:02 INFO - Running setup.py install for moznetwork 15:25:02 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:25:02 INFO - Running setup.py install for mozprocess 15:25:03 INFO - Running setup.py install for mozprofile 15:25:03 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:25:03 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:25:03 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:25:03 INFO - Running setup.py install for mozrunner 15:25:03 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:25:03 INFO - Running setup.py install for mozscreenshot 15:25:03 INFO - Running setup.py install for moztest 15:25:03 INFO - Running setup.py install for mozversion 15:25:03 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:25:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:25:03 INFO - Cleaning up... 15:25:03 INFO - Return code: 0 15:25:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:25: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:25:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:25:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:25: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:25:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:25:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:25: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 0x7f3a30303f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a3f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b0a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b99410>, '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 0x1b9a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b9a7a0>, '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': '82e07478c745e68b1fe4678a000001bc-1462573450.988758-2105385975', '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 15:25: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 15:25: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 15:25:03 INFO - Using env: {'DISPLAY': ':0', 15:25:03 INFO - 'HOME': '/home/cltbld', 15:25:03 INFO - 'LANG': 'en_US.UTF-8', 15:25:03 INFO - 'LANGUAGE': 'en_US:en', 15:25:03 INFO - 'LOGNAME': 'cltbld', 15:25:03 INFO - 'MAIL': '/var/mail/cltbld', 15:25:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:25:03 INFO - 'MOZ_NO_REMOTE': '1', 15:25:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:25:03 INFO - 'NO_EM_RESTART': '1', 15:25:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:25:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:25:03 INFO - 'PWD': '/builds/slave/test', 15:25:03 INFO - 'SHELL': '/bin/bash', 15:25:03 INFO - 'SHLVL': '1', 15:25:03 INFO - 'TERM': 'linux', 15:25:03 INFO - 'TMOUT': '86400', 15:25:03 INFO - 'USER': 'cltbld', 15:25:03 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1462573450.988758-2105385975', 15:25:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:25:03 INFO - '_': '/tools/buildbot/bin/python'} 15:25:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:25:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:25:03 INFO - Running setup.py (path:/tmp/pip-Stgq4B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:25:03 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)) 15:25:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:25:03 INFO - Running setup.py (path:/tmp/pip-_YvaNu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:25:03 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)) 15:25:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:25:04 INFO - Running setup.py (path:/tmp/pip-ydTb0H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:25: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)) 15:25:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:25:04 INFO - Running setup.py (path:/tmp/pip-fsa5t3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:25: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)) 15:25:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:25:04 INFO - Running setup.py (path:/tmp/pip-dG6Eia-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:25: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)) 15:25:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:25:04 INFO - Running setup.py (path:/tmp/pip-C_Rz7P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:25: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)) 15:25:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:25:04 INFO - Running setup.py (path:/tmp/pip-yNx43s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:25: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)) 15:25:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:25:04 INFO - Running setup.py (path:/tmp/pip-JKDU_V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:25: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)) 15:25:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:25:04 INFO - Running setup.py (path:/tmp/pip-T2VcyS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:25: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)) 15:25:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:25:04 INFO - Running setup.py (path:/tmp/pip-AmXvcq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:25:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 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)) 15:25:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:25:04 INFO - Running setup.py (path:/tmp/pip-aJo5hU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:25: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)) 15:25:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:25:04 INFO - Running setup.py (path:/tmp/pip-pGPxoP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:25:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 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)) 15:25:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:25:04 INFO - Running setup.py (path:/tmp/pip-pbsE5n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:25: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)) 15:25:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:25:04 INFO - Running setup.py (path:/tmp/pip-gphkFP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:25:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 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)) 15:25:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:25:04 INFO - Running setup.py (path:/tmp/pip-TDmz5V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:25:04 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)) 15:25:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:25:04 INFO - Running setup.py (path:/tmp/pip-0UFDwB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:25:04 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)) 15:25:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:25:05 INFO - Running setup.py (path:/tmp/pip-I4yNcq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:25: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)) 15:25: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)) 15:25: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)) 15:25: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)) 15:25: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)) 15:25: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)) 15:25:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:25: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 15:25: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 15:25: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 15:25: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 15:25: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 15:25: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 15:25:06 INFO - Downloading blessings-1.6.tar.gz 15:25:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:25:07 INFO - Installing collected packages: blessings 15:25:07 INFO - Running setup.py install for blessings 15:25:07 INFO - Successfully installed blessings 15:25:07 INFO - Cleaning up... 15:25:07 INFO - Return code: 0 15:25:07 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:25:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:25:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:25:07 INFO - Reading from file tmpfile_stdout 15:25:07 INFO - Current package versions: 15:25:07 INFO - argparse == 1.2.1 15:25:07 INFO - blessings == 1.6 15:25:07 INFO - blobuploader == 1.2.4 15:25:07 INFO - docopt == 0.6.1 15:25:07 INFO - manifestparser == 1.1 15:25:07 INFO - mozInstall == 1.12 15:25:07 INFO - mozcrash == 0.17 15:25:07 INFO - mozdebug == 0.1 15:25:07 INFO - mozdevice == 0.48 15:25:07 INFO - mozfile == 1.2 15:25:07 INFO - mozhttpd == 0.7 15:25:07 INFO - mozinfo == 0.9 15:25:07 INFO - mozleak == 0.1 15:25:07 INFO - mozlog == 3.1 15:25:07 INFO - moznetwork == 0.27 15:25:07 INFO - mozprocess == 0.22 15:25:07 INFO - mozprofile == 0.28 15:25:07 INFO - mozrunner == 6.11 15:25:07 INFO - mozscreenshot == 0.1 15:25:07 INFO - mozsystemmonitor == 0.0 15:25:07 INFO - moztest == 0.7 15:25:07 INFO - mozversion == 1.4 15:25:07 INFO - psutil == 3.1.1 15:25:07 INFO - requests == 1.2.3 15:25:07 INFO - wsgiref == 0.1.2 15:25:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:25: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:25:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:25:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:25: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:25:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:25:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:25: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 0x7f3a30303f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a3f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b0a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b99410>, '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 0x1b9a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b9a7a0>, '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': '82e07478c745e68b1fe4678a000001bc-1462573450.988758-2105385975', '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 15:25: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 15:25: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 15:25:07 INFO - Using env: {'DISPLAY': ':0', 15:25:07 INFO - 'HOME': '/home/cltbld', 15:25:07 INFO - 'LANG': 'en_US.UTF-8', 15:25:07 INFO - 'LANGUAGE': 'en_US:en', 15:25:07 INFO - 'LOGNAME': 'cltbld', 15:25:07 INFO - 'MAIL': '/var/mail/cltbld', 15:25:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:25:07 INFO - 'MOZ_NO_REMOTE': '1', 15:25:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:25:07 INFO - 'NO_EM_RESTART': '1', 15:25:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:25:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:25:07 INFO - 'PWD': '/builds/slave/test', 15:25:07 INFO - 'SHELL': '/bin/bash', 15:25:07 INFO - 'SHLVL': '1', 15:25:07 INFO - 'TERM': 'linux', 15:25:07 INFO - 'TMOUT': '86400', 15:25:07 INFO - 'USER': 'cltbld', 15:25:07 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1462573450.988758-2105385975', 15:25:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:25:07 INFO - '_': '/tools/buildbot/bin/python'} 15:25:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:25: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)) 15:25: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)) 15:25: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)) 15:25: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)) 15:25: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)) 15:25: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)) 15:25: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)) 15:25: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)) 15:25: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)) 15:25: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)) 15:25: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)) 15:25:07 INFO - Cleaning up... 15:25:07 INFO - Return code: 0 15:25:07 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:25: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:25:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:25:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:25: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:25:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:25:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:25: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 0x7f3a30303f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a3f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b0a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b99410>, '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 0x1b9a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b9a7a0>, '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': '82e07478c745e68b1fe4678a000001bc-1462573450.988758-2105385975', '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 15:25: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 15:25: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 15:25:07 INFO - Using env: {'DISPLAY': ':0', 15:25:07 INFO - 'HOME': '/home/cltbld', 15:25:07 INFO - 'LANG': 'en_US.UTF-8', 15:25:07 INFO - 'LANGUAGE': 'en_US:en', 15:25:07 INFO - 'LOGNAME': 'cltbld', 15:25:07 INFO - 'MAIL': '/var/mail/cltbld', 15:25:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:25:07 INFO - 'MOZ_NO_REMOTE': '1', 15:25:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:25:07 INFO - 'NO_EM_RESTART': '1', 15:25:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:25:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:25:07 INFO - 'PWD': '/builds/slave/test', 15:25:07 INFO - 'SHELL': '/bin/bash', 15:25:07 INFO - 'SHLVL': '1', 15:25:07 INFO - 'TERM': 'linux', 15:25:07 INFO - 'TMOUT': '86400', 15:25:07 INFO - 'USER': 'cltbld', 15:25:07 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1462573450.988758-2105385975', 15:25:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:25:07 INFO - '_': '/tools/buildbot/bin/python'} 15:25:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:25:07 INFO - Downloading/unpacking jsonschema 15:25:07 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 15:25:07 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 15:25:07 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 15:25:07 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 15:25:07 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 15:25:07 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 15:25:09 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:25:09 INFO - Downloading/unpacking functools32 (from jsonschema) 15:25:09 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 15:25:09 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 15:25:09 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 15:25:09 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 15:25:09 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 15:25:09 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 15:25:09 INFO - Downloading functools32-3.2.3-2.tar.gz 15:25:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:25:09 INFO - warning: no files found matching '*.txt' 15:25:09 INFO - no previously-included directories found matching 'build' 15:25:09 INFO - no previously-included directories found matching 'dist' 15:25:09 INFO - no previously-included directories found matching '.git*' 15:25:09 INFO - Installing collected packages: jsonschema, functools32 15:25:10 INFO - Running setup.py install for functools32 15:25:10 INFO - warning: no files found matching '*.txt' 15:25:10 INFO - no previously-included directories found matching 'build' 15:25:10 INFO - no previously-included directories found matching 'dist' 15:25:10 INFO - no previously-included directories found matching '.git*' 15:25:10 INFO - Successfully installed jsonschema functools32 15:25:10 INFO - Cleaning up... 15:25:10 INFO - Return code: 0 15:25:10 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 15:25:10 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:25:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:25:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:25:10 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:25:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:25:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:25:10 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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3a30303f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a3f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b0a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b99410>, '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 0x1b9a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b9a7a0>, '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': '82e07478c745e68b1fe4678a000001bc-1462573450.988758-2105385975', '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 15:25:10 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', 'flake8'] in /builds/slave/test/build 15:25:10 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 flake8 15:25:10 INFO - Using env: {'DISPLAY': ':0', 15:25:10 INFO - 'HOME': '/home/cltbld', 15:25:10 INFO - 'LANG': 'en_US.UTF-8', 15:25:10 INFO - 'LANGUAGE': 'en_US:en', 15:25:10 INFO - 'LOGNAME': 'cltbld', 15:25:10 INFO - 'MAIL': '/var/mail/cltbld', 15:25:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:25:10 INFO - 'MOZ_NO_REMOTE': '1', 15:25:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:25:10 INFO - 'NO_EM_RESTART': '1', 15:25:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:25:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:25:10 INFO - 'PWD': '/builds/slave/test', 15:25:10 INFO - 'SHELL': '/bin/bash', 15:25:10 INFO - 'SHLVL': '1', 15:25:10 INFO - 'TERM': 'linux', 15:25:10 INFO - 'TMOUT': '86400', 15:25:10 INFO - 'USER': 'cltbld', 15:25:10 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1462573450.988758-2105385975', 15:25:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:25:10 INFO - '_': '/tools/buildbot/bin/python'} 15:25:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:25:10 INFO - Downloading/unpacking flake8 15:25:10 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 15:25:10 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 15:25:10 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 15:25:10 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 15:25:10 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 15:25:10 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 15:25:12 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 15:25:12 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 15:25:12 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 15:25:12 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 15:25:12 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 15:25:12 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 15:25:12 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 15:25:12 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 15:25:12 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 15:25:12 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 15:25:12 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 15:25:12 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 15:25:12 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 15:25:12 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 15:25:12 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 15:25:12 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 15:25:12 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 15:25:12 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 15:25:12 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 15:25:12 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 15:25:12 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 15:25:12 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 15:25:12 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 15:25:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 15:25:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:25:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:25:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:25:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:25:12 INFO - no previously-included directories found matching 'docs/_build' 15:25:12 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 15:25:13 INFO - Running setup.py install for pep8 15:25:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:25:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:25:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:25:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:25:13 INFO - no previously-included directories found matching 'docs/_build' 15:25:13 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 15:25:13 INFO - Successfully installed flake8 mccabe pyflakes pep8 15:25:13 INFO - Cleaning up... 15:25:13 INFO - Return code: 0 15:25:13 INFO - Running post-action listener: _resource_record_post_action 15:25:13 INFO - Running post-action listener: _start_resource_monitoring 15:25:13 INFO - Starting resource monitoring. 15:25:13 INFO - ##### 15:25:13 INFO - ##### Finished create-virtualenv step (success) 15:25:13 INFO - ##### 15:25:13 INFO - ##### 15:25:13 INFO - ##### Running install step. 15:25:13 INFO - ##### 15:25:13 INFO - Running pre-action listener: _resource_record_pre_action 15:25:13 INFO - Running main action method: install 15:25:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:25:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:25:13 INFO - Reading from file tmpfile_stdout 15:25:13 INFO - Detecting whether we're running mozinstall >=1.0... 15:25:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:25:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:25:13 INFO - Reading from file tmpfile_stdout 15:25:13 INFO - Output received: 15:25:13 INFO - Usage: mozinstall [options] installer 15:25:13 INFO - Options: 15:25:13 INFO - -h, --help show this help message and exit 15:25:13 INFO - -d DEST, --destination=DEST 15:25:13 INFO - Directory to install application into. [default: 15:25:13 INFO - "/builds/slave/test"] 15:25:13 INFO - --app=APP Application being installed. [default: firefox] 15:25:13 INFO - mkdir: /builds/slave/test/build/application 15:25:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 15:25:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 15:25:29 INFO - Reading from file tmpfile_stdout 15:25:29 INFO - Output received: 15:25:29 INFO - /builds/slave/test/build/application/firefox/firefox 15:25:29 INFO - Running post-action listener: _resource_record_post_action 15:25:29 INFO - ##### 15:25:29 INFO - ##### Finished install step (success) 15:25:29 INFO - ##### 15:25:29 INFO - ##### 15:25:29 INFO - ##### Running run-tests step. 15:25:29 INFO - ##### 15:25:29 INFO - Running pre-action listener: _resource_record_pre_action 15:25:29 INFO - Running main action method: run_tests 15:25:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:25:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:25:29 INFO - Python 2.7.3 15:25:29 INFO - Return code: 0 15:25:29 INFO - grabbing minidump binary from tooltool 15:25:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:25:29 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: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b99410>, '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 0x1b9a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b9a7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:25:29 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 15:25:29 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 15:25:29 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:25:29 INFO - Return code: 0 15:25:29 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:25:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:25:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:25:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:25:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:25:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 15:25:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 15:25:30 INFO - Return code: 0 15:25:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/aQR-sNOyTxaUBvB5rHkzTg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-055', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 15:25:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/aQR-sNOyTxaUBvB5rHkzTg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-055 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 15:25:30 INFO - Using env: {'DISPLAY': ':0', 15:25:30 INFO - 'HOME': '/home/cltbld', 15:25:30 INFO - 'LANG': 'en_US.UTF-8', 15:25:30 INFO - 'LANGUAGE': 'en_US:en', 15:25:30 INFO - 'LOGNAME': 'cltbld', 15:25:30 INFO - 'MAIL': '/var/mail/cltbld', 15:25:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:25:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:25:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:25:30 INFO - 'MOZ_NO_REMOTE': '1', 15:25:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:25:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:25:30 INFO - 'NO_EM_RESTART': '1', 15:25:30 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:25:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:25:30 INFO - 'PWD': '/builds/slave/test', 15:25:30 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:25:30 INFO - 'SHELL': '/bin/bash', 15:25:30 INFO - 'SHLVL': '1', 15:25:30 INFO - 'TERM': 'linux', 15:25:30 INFO - 'TMOUT': '86400', 15:25:30 INFO - 'USER': 'cltbld', 15:25:30 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1462573450.988758-2105385975', 15:25:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:25:30 INFO - '_': '/tools/buildbot/bin/python'} 15:25:30 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/aQR-sNOyTxaUBvB5rHkzTg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-055', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 15:25:30 INFO - mozversion application_buildid: 20160506135800 15:25:30 INFO - mozversion application_changeset: 0a55f3f89efd80dadf3d951e1a0d073a66fec9a0 15:25:30 INFO - mozversion application_display_name: Nightly 15:25:30 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:25:30 INFO - mozversion application_name: Firefox 15:25:30 INFO - mozversion application_remotingname: firefox 15:25:30 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 15:25:30 INFO - mozversion application_vendor: Mozilla 15:25:30 INFO - mozversion application_version: 49.0a1 15:25:30 INFO - mozversion platform_buildid: 20160506135800 15:25:30 INFO - mozversion platform_changeset: 0a55f3f89efd80dadf3d951e1a0d073a66fec9a0 15:25:30 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 15:25:30 INFO - mozversion platform_version: 49.0a1 15:25:30 INFO - using testdate: 1462573530 15:25:30 INFO - actual date: 1462573530 15:25:30 INFO - starting webserver on 'localhost:46571' 15:25:30 INFO - SUITE-START | Running 2 tests 15:25:30 INFO - TEST-START | dromaeo_css 15:25:30 INFO - operating with platform_type : linux_ 15:25:30 INFO - Initialising browser for dromaeo_css test... 15:25:30 INFO - TEST-INFO | started process 14280 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpr10MP4/profile http://localhost:46571/getInfo.html) 15:25:34 INFO - PROCESS | 14280 | 15:25:34 INFO - PROCESS | 14280 | (process:14346): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 15:25:35 INFO - PROCESS | 14280 | __metrics Screen width/height:1600/1200 15:25:35 INFO - PROCESS | 14280 | colorDepth:24 15:25:35 INFO - PROCESS | 14280 | Browser inner width/height: 1024/697 15:25:35 INFO - PROCESS | 14280 | __metrics 15:25:35 ERROR - PROCESS | 14280 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 15:25:36 INFO - TEST-INFO | 14280: exit 0 15:25:36 INFO - Browser initialized. 15:25:36 INFO - Running cycle 1/1 for dromaeo_css test... 15:25:36 INFO - TEST-INFO | started process 14397 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpr10MP4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:25:38 INFO - PROCESS | 14397 | 15:25:38 INFO - PROCESS | 14397 | (process:14458): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 15:25:48 INFO - PROCESS | 14397 | RSS: Main: 164880384 15:25:48 INFO - PROCESS | 14397 | 15:26:38 INFO - PROCESS | 14397 | 1462573598191 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] 15:28:50 INFO - PROCESS | 14397 | Cycle 1(1): loaded http://localhost:46571/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46571/tests/dromaeo/cssquery-ext.html) 15:28:51 INFO - PROCESS | 14397 | RSS: Main: 167964672 15:28:51 INFO - PROCESS | 14397 | 15:31:53 INFO - PROCESS | 14397 | Cycle 1(1): loaded http://localhost:46571/tests/dromaeo/cssquery-ext.html (next: http://localhost:46571/tests/dromaeo/cssquery-jquery.html) 15:31:54 INFO - PROCESS | 14397 | RSS: Main: 167358464 15:31:54 INFO - PROCESS | 14397 | 15:34:55 INFO - PROCESS | 14397 | Cycle 1(1): loaded http://localhost:46571/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46571/tests/dromaeo/cssquery-mootools.html) 15:34:56 INFO - PROCESS | 14397 | RSS: Main: 168558592 15:34:56 INFO - PROCESS | 14397 | 15:37:58 INFO - PROCESS | 14397 | Cycle 1(1): loaded http://localhost:46571/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46571/tests/dromaeo/cssquery-prototype.html) 15:37:59 INFO - PROCESS | 14397 | RSS: Main: 166313984 15:37:59 INFO - PROCESS | 14397 | 15:41:01 INFO - PROCESS | 14397 | Cycle 1(1): loaded http://localhost:46571/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46571/tests/dromaeo/cssquery-yui.html) 15:41:02 INFO - PROCESS | 14397 | RSS: Main: 167432192 15:41:02 INFO - PROCESS | 14397 | 15:44:05 INFO - PROCESS | 14397 | Cycle 1(1): loaded http://localhost:46571/tests/dromaeo/cssquery-yui.html (next: http://localhost:46571/tests/dromaeo/cssquery-dojo.html) 15:44:05 INFO - PROCESS | 14397 | RSS: Main: 169381888 15:44:05 INFO - PROCESS | 14397 | 15:44:05 INFO - PROCESS | 14397 | __start_tp_report 15:44:05 INFO - PROCESS | 14397 | _x_x_mozilla_page_load 15:44:05 INFO - PROCESS | 14397 | _x_x_mozilla_page_load_details 15:44:05 INFO - PROCESS | 14397 | |i|pagename|runs| 15:44:05 INFO - PROCESS | 14397 | |0;dojo.html;2624.750648688375;2682.8658567071643;2689.515887140314;2693.5690289553663;2711.9965612723295;4742.549457801508;4754.64340174487;4777.570018698317;4874.756262186894;4880.731559764212;4608.516105808883;4801.255805350168;4823.324734537167;4860.198067318888;4879.780409881555;4408.140412619532;4440.245158323077;4508.120916421299;4526.660500462462;4538.591526762591;4474.306482495218;4558.794854231551;4574.153781550423;4627;4651.674382793206;4390.846320378771;4441.378207051015;4443.133588950156;4443.977780111095;4517.774111294422;4417.18282117806;4431.135928493945;4452.732836029849;4453.042595841877;4453.844115455943;4441.844535441276;4482.7310361378095;4484.035932274576;4493.820247190109;4527.750973696446;4689.2966055091665;4738.123447162286;4744.620430365597;4759.476457589697;4771.689840160413;5163.870903227412;5188.143956247215;5195.324607801;5198.714070726109;5249.133892907704;5221.451747566489;5229.581633469352;5255.185446255837;5261.342332208474;5310.734463276821;4665.393498845162;4783.569478746929;4799.088173247072;4848.127337079289;4893.828715994923;5192.324997750268;5229.895402091937;5236.0575096483;5242.711650859239;5266.657667251617;5053.494650534991;5075.593952483792;5092.9745351273;5097.388313402415;5114.207297868837;4999.350084489066;5095.668781529189;5137.563307118862;5140.948590514122;5144.9742751286;4974.477679843637;5131.307273518102;5207.843764687065;5213.009528189632;5239.73801309933;5144.6655967362;5175.896482070413;5186.688798672092;5194.558462530652;5272.05103081449;4394.231009573312;4449.9555004450185;4479.932801007987;4488.438945131858;4524.0047189618235;3870.2646497165447;3882.76703397797;3887.5328623272558;3931.1351502669368;3932.724709270381;4494.202558560894;4530.546945305443;4547.226971414867;4555.5899969002285;4590.8163673453355;4962.230854217602;5121.539061484485;5163.07064728345;5173.1464308388695;5177.430482646906;4484.887877803016;4491.461024676994;4505.481869584974;4507.323901414814;4512.05246898155;4566.725996440157;4701.459332176775;4703.670743048022;4710.505396933341;4748.572628463455;4789.8323558675975;4830.879228019257;4842.322074909586;4851.126797176542;4863.294822250825;5171.482851714798;5209.088409528393;5212.035773381936;5213.504717051874;5259.395169555397;4648.395708557866;4766.45185803637;4848.5636292733825;4855.004724031494;4906.8773280668265;5040.924386134137;5063.924041139459;5088.389393272831;5088.491150884882;5129.717865517432;5164.690118592896;5170.564791676025;5173.741312934263;5177.249298851721;5222.582193424441;4868.829590964299;5023.899522009612;5033.773480193327;5055.570276526537;5100.515451032146;4834.685745426536;4859.07677541266;4893.314935909047;4902.558769710743;5168.560672342893;4869.220924652181;4873.195922672861;4881.511848815232;4901.534354236342;4958.206686930074;5086.593072554113;5108.48915108501;5110.872228194325;5113.616478764033;5159.845204643867;4789.425268967746;4903.53416425439;4940.827071052496;4952.925706114339;4957.206846904478 15:44:05 INFO - PROCESS | 14397 | |1;ext.html;559.2422267827094;605.5034871405448;610.685496969061;617.7467238432241;635.3424205946845;39365.60634393655;40389.798051009704;40491.79754101225;40534.39198412026;40562.39156412649;40199.19601607966;40510.18979620406;40887.38668919969;40910.38634420479;41071.58928410723;7897.052353717562;8014;8014.7194848180325;8022.719204827832;8038.035435747689;7817.179196184404;7887.132415434297;7889.250521200477;7892.4869883457395;7918.366530677532;7924.643391047388;7934.047914250298;7946.086200087007;7946.364290856717;7977.521348719096;7913.129555748863;7927.563983980879;7937.841243175133;7942.722004729807;7965.283124518821;7847.725329613493;7875.921240787576;7887.211278872124;7918.960405197995;7925.088614809313;39356.21287574233;39588.40617390742;39596;39736;39866.20267594661;3244.156519304998;3319.2365755876044;3321.9003429897143;3435.3644575753565;3716.9442458363146;30709.385812283854;30902.53646195309;31259.531107033414;31291;32360.514592281135;3285.211549228168;3313.7514686398617;3316.9385796545116;3341;3413.9487907681155;252724.7363763188;253801;254514;255513;255702;29249.268768280537;29740.702592973794;58629.706851466326;58786.41213587809;59152.704236478545;35274.82362588222;35550.28899421997;35570.46644300337;35663.64336356655;35663.821680891946;14216.928915355356;14402.495912643008;14494.275286235646;14504.419823207165;14566.563003109924;11302.717432064264;11322.037626801814;11330.263532870336;11339.943300283447;11389.658310250707;8207.876881846778;8235.8352832943;8323.542205178652;8359.958200209081;8365.870607468036;3274.3123943971555;3274.672532746754;3278.2623909620143;3307.9173020674193;3328.5007248912857;927.4667066436825;948.0898337595985;951.7953639967441;1013.9442330671884;1071.8231491803922;30256.78972841106;30295.848520757256;30530.847345763574;30648.69351306503;30734.69265307363;987.2990176974429;1022.6420752736483;1029.6602121300102;1090.2695194219734;1159.1422347462817;15676.137812420426;16289.592760180853;16434.589135271715;16512.207323899052;16536.173191340386;366309;370347;370466;370559;371003;53852.730736346064;54236.728816355666;54851.451485485435;54932.72533637306;54953;1295.559509766684;1313.1136482874022;1313.954011609589;1316.5984374765596;1329.8138260643518;28119.297017574725;29444.411111778074;29548.556771648873;29725;29971.400571988874;45450;46279.53720462752;46616.7669161652;46667.29999050085;46685.533144669476;339248;340944;341167;341206;342465;26647.600285995337;26920.32699182536;27046.72953270442;27800.860995694893;27879.581806272516;44455.555444446436;44903.775481122386;45881;47623.09507619795;47888.760556197;38588.09720384766;38892;39871.40192897167;40301.596984029784;40744.79627601843;38458.23083538258;38927.221455570165;39475.80262098671;40079;40330;39339;39476.80261598674;39745;40115;40249.19501609893;33211.83394083014;35053.47419788756;35275.82362088276;35569;35646.64353356433;27000.72999269982;27320.726792731817;27375.589366159922;27430;27478.17565473039 15:44:05 INFO - PROCESS | 14397 | |2;jquery.html;376.8228932401771;381.05688421157623;383.092071789858;387.69953286203173;395.9287328280908;15938.72490200784;16815;17071.57321066974;17506.649867002652;17516.73724894126;16142.7578586321;16682.41611543596;16689;16693.916530417362;16766.329346826144;3651.050726811022;5004.824831130911;5186.974065129669;5191.195364718475;5191.506806853343;5587.189857470685;5897.3218079920925;5928.7628494860155;5987.221661184061;6008.218931538916;5058.7976480940715;5379.81170659027;5908.025175846002;5919.319278283009;5928.05151175812;5306.575473962073;5391.973040134794;5410.621256512046;5413.593980451462;5439.265699130626;5400.405955344909;5424.593155513352;5433.510984011418;5457.317835270591;5459.317585301837;12158.088143389281;12412.441440135126;12611.243325400414;12648.241105533605;12677.556285529961;1962.05821205822;1999.740033795612;2010.1155491583802;2063.679831406516;2105.157936825267;9128.132827381389;9250.35247532673;9295.349325547215;9642.614295428244;9662.855057174149;1814.5372929902921;1864.9440516784518;1891.810818918097;1897.354899334233;1913.23470611755;66442;70519.64740176317;70616;70858.64570677113;72137.99999999948;9756.317057805885;9954.950225248973;9958.502074896227;10214.846777298346;10332.638357657446;14037.368318425695;14043.719125617636;14109;14120.293985300694;14146.646333841736;7628.46600737943;7637.15991240963;7718;7722.317388333899;7761.6119194040075;7365.668544915492;7370.373518251009;7486.363659089038;7519.8496030079095;7521.398288136936;3944.881653550398;4342.0664557119735;4347;4418.6023257906945;4482.5069242383315;1779.5551112221945;1831.081718476137;1868.8411485023926;1873.2506997201228;1890.5651700108776;826.3182874128868;883.4522595990398;885.1679421344045;913.584319134792;1015.7105225010837;15831.604209894846;16478.917605411898;16767.262915958632;16793.160341983097;16823.747643785355;893.2452077994085;917.3991035871381;940.6472572785206;942.3168203052869;995.3381001633977;9651.131398174057;9670.371425857296;9704.75738106553;9734.36726612768;9743.805123897482;374396;377577;378166;379802;386779;73243.26756732471;78169.60915195501;78969.60515197387;82273;83156.58421707974;961.8701475300745;967.8354679704327;996.6661168508485;1000.174855744014;1002.2282842211456;15517.37930482768;15541.222938853238;15617.843821562094;15629.531114066596;15992.520224393287;36617.08457288589;36867;37044.814775925945;37920.24159516739;38144.23711525698;49855.252171216736;52645.47354526559;53390.199147013605;53635.51369161148;54136.187957181464;4471.396361491157;4585.28928016158;7048.295170482911;11171;11512.30926144434;11982.940085299866;12465.5013799447;12485;12759.170653907466;12993.740125197632;11303.604373846876;11314.547418103184;11431.828522572334;11544.307341559534;11924.224925379822;11489.540418383505;11552.364619945647;11620.825687614524;11694.239874408137;11766.82349764737;11685.591004314809;11718;11790;11793.882061179622;11811.114166437723;11945.462454189408;12052.397380131133;12111.394430278628;12282.815757763461;12321.93839030799;11571;11607.245529040585;11683.941580292045;11779.528818847493;11826.881731182923 15:44:05 INFO - PROCESS | 14397 | |3;mootools.html;1524.7179271834707;1535.5623647260531;1728.8444040036395;1870.5417172792659;1878.6618408686431;6724.327567243286;7460.813479663005;7465.888011679829;7924.088729796075;7926.524408535492;7765.378769698425;7775.805604859867;7785.493942893708;7822.882656760139;7839.999999999985;2221.0893533651247;2268.9546209075806;2269.069681430614;2272.0230300970575;2274.2494976657663;2190.0692205812547;2210.9778902211015;2258;2263.0155882191216;2263.671767593698;2149.3014770199748;2169.078141789733;2169.4901698100934;2180.890955452229;2220.589190999662;2164.21006332689;2172.3808714516367;2189.0477642225683;2189.6496560550313;2192.9232476863313;2100.390886642872;2150.0969592771075;2153.7738537453497;2160.25471212433;2161.200355868323;7739.845203095907;7751.418643601753;7791.8441631167625;7792.376609871197;7793.532388056678;4356.629686476654;4418.845340413102;4419.955800441987;4442.644588432918;4454.732716037048;2785.9860700696568;2798.790090743202;2838.2904273931517;2846.9430611387866;2871.928201794951;833.4830608292909;838.4214891724752;847.0428415890067;850.2602735620051;856.7558245899888;10051.849222261671;10351.689449316533;10454;10478.423686697228;10492.370457772558;4098.569650186747;4100.815463304159;4185.769782661982;4191.559886211965;4198.03445207604;8461.365397595206;8463.280621147149;8476.237138657427;8487.490750554987;8491.320694344438;4585.220512512814;4585.610223131004;4614.007988282468;4617.630589552828;4629.884252893705;3656.689181419609;4043.9595604043584;4142.1922725068325;4178.561251068655;4234.9364759528635;3480.89557313281;3489.180042689966;3567;3579.2125732339364;3627.9455808162897;1030.4847576211894;1049.228816819637;1054.651964851597;1056.963006294776;1065.472591067411;925.1396201532639;939.7086903060073;945.3713280668416;951.2580187453797;969.8205831921117;5337.172738225581;5414.864628384322;5511.255980442589;5630.831075067755;5687.03320435527;411.868202175301;413.6153377359025;421.43317238314415;425.36408069935646;425.84030988379357;3865;3894.2990261753157;3952.545457272393;3967.0677390813134;3990.4413382126527;8803;9316.767080823034;9350.90649093514;9376;9424.62301507932;9001.144891235323;9217.861732074025;9252.814943701089;9291.58187881547;9335.859962100574;7149.571025738368;7254.528455650471;7298.890516642255;7348.963255183797;7360.190379058299;5225.817096401608;5232.659877108128;5339.252504649275;5394.541463975449;5410.567154627699;8633.784155396166;8663.220310172115;8684;8725.65097396097;8787.340949428946;8332.833343333221;8656.87460630114;8678.305735541267;8768.649254030022;8810.779730506789;6095.207623009158;6617.636030018395;6812.114425124702;6856.862862742618;6955;7604.543727376154;7604.96197519031;7605.771826845204;7638.732644357421;7687.192844751221;6784.7964561063245;7032.507724459443;7052.259512751088;7085.6457177141965;7105.147382314155;6817.625030623363;6874.450043996369;6915.412189963708;6922.5154239202775;6969.9303006969285;6313.526485513513;6333.113364129118;6397.520185986163;6427.710753016032;6433.29233784274;4449.265871131227;4681.555252251031;4794.544518270759;4906.484819094087;4907.828226012072;4949.505049495166;4966.6771659842;4980.950190498049;4988.45127036033;5060.240963855451 15:44:05 INFO - PROCESS | 14397 | |4;prototype.html;301.59887349824737;307.3698917219698;310.51094526121335;310.5497029307504;315.5471897826619;5058.949410505894;5070.163423035199;5074.746262686869;5105.540501354877;5121.28302037715;4965.801367945287;4987.975060124703;4995.825146119886;4995.950040499594;5009.173486374753;3746.550413950316;3795.9620403795884;3912.667423269011;3922.117523557191;3946.3488524393583;3907.433422153786;3926.6858651307825;3928.37146056631;3934.1344904121047;3946.743461674996;3908.335582950891;3917.8041097945134;3917.9216415671813;3921.5490218624936;3921.627445392683;3824.6366595173413;3893.299206142893;3902.122022544933;3927.960720392802;3931.823067961934;3444.3111377724304;3464.3764122457947;3469.9479507807405;3471.836934626903;3473.9652603473896;4772.76136193189;4774.212254977924;4794.520547945178;4796.616270698336;4802.991371811923;4384.807596201899;4419.690621656486;4470.26240670289;4480.036792089716;4491.326301054835;5078.7968481260705;5129.487051294878;5159.74201289934;5165.560927321182;5197.714125723083;3728.4780130781714;3732.981335093334;3750.474933509311;3752.418375151856;3754.3992961126087;5444.646098003656;5447.918281225785;5456.454354564512;5469.097598896177;5473.589480788917;3561.3767590671528;3767.811609419518;3778.7732736035928;3779.848806047782;3779.848806047782;3805.553889521964;3818.312703713358;3840.0975770693863;3846.8461261549223;3848.191879705293;4343.087951530151;4387.934180987288;4398.626116780046;4412.161689279027;4416.4258646375765;5062.974685126551;5179.559737422362;5188.922166167435;5219.060569097599;5231.3199284092825;1280.9487620495263;1283.8523569789593;1285.318781046047;1294.996377807188;1296.9870301297055;821.7904434369198;835.4736515995006;864.2783275964514;874.711345256064;882.3999680217514;4493.932591011137;4551.52209018055;4570.085982803453;4579.496255411902;4616.469106052847;5317.707526086025;5318.97340513295;5329.920051199235;5348.277982472394;5377.655586103474;4390.956090439118;4550.908981820345;4561.863144105682;4579.427571553556;4605.700629459075;2724.6049322848075;2740.8355498669744;2768.0173538393983;2774.389634280455;2792.5113105206506;4862.659613826998;4881.51184881509;4884.755762211875;4887.560119589183;4889.193283108319;5062.594992400673;5335.306410166731;5356.571474282048;5382.811601593926;5392.514673679309;4918.926216106761;4936.901261974812;4940.975295123501;4941.085899108676;4968.782648251202;5129.743512824419;5153.768080436314;5265.183896496049;5272.499112584298;5286.444923283;4922.212446008764;5082;5126.512981266774;5135.845924622267;5139.974300128475;4842.0873754865925;4856.150173719656;4865.756712164449;4865.854024379274;4918.213085906238;3601.119104716269;3630.8729194478065;3678.9080272993388;3701.444783282529;3714.1643130295465;4981.800727970841;5218.860267290393;5298.470152984671;5302.496262855023;5339.733013349394;5068.189089745623;5070.225421102585;5076.568491678248;5086;5124.282600436017;5040.193569028937;5049.899002019865;5080.237964305236;5086.898262034812;5090.745462726923;4803.567678908915;4981.3026176334615;5005.924911126263;5007.744965772277;5156.278121062979;5016.197408414636;5124.692518448905;5270.420253772006;5285.947140528546;5287.154055351125;5051.772670229922;5109.20807274873;5112.769925353442;5120.385553733576;5137.563307118937 15:44:05 INFO - PROCESS | 14397 | |5;yui.html;797.2466019611467;805.0741647105827;807.0718673525445;819.471440920606;820.7373640435063;12196.695082622939;13032.478700851967;13213.141145825515;13231.338433078356;13263.469461221539;12783.680407989805;12841.80737288939;12841.871581284184;12842;12858.742825143492;673.7675501951819;830.5847076461769;861.5907443964098;864.2955990867455;864.844328020956;860.6170254236836;863.8401895649325;866.2420382165606;867.2888231650018;867.8004059066418;917.8714979902819;920.3235621817992;920.6501529418812;922.4096578189964;924.4638109896244;907.2923119966437;907.469130558624;908.0284096017264;909.5088652127843;910.1671970147307;671.4359937652347;672.8082496488478;673.9056532085463;674.2684187656399;675.5777638975641;12891.677708057374;12910.483580656763;12977.480900763958;12997.415116319693;12997.675058123528;12494.81257781134;12591.118621696485;12921.418536165802;13137.474501019948;13340.466381344735;10495.790084198274;10496.317739346994;10573.629922952736;10591;10629.309094908805;3337.2991671748964;3381.1040074380307;3455.3953058214965;3457.2566898116775;3461.048211741791;44571.33143002858;44716;44839.77580112111;44882.77558612219;46796.06407871858;9890.851637225447;10137.138343240907;10171.64399246023;10195.184385249162;10268.486575671186;16154.59613509648;16593.087380194203;16743;18502.352417665315;18514.814851851308;6878.3465570770695;6949.305069493112;7012.544184628085;7022.192447868459;7177;3640.3629364861044;3746.6440688134585;3764.8682296119505;3833.3674943633987;3923.2153569286256;2914.3005678636973;2987.4323878463456;3031.621047369079;3033.514637657964;3034.0442760530364;540.7404445866007;540.8215288954635;549.2365611799602;550.180231455137;556.9498745112959;581.421485621809;653.5163978655761;659.1924892007253;664.6610228783355;668.5220067651652;7745.496542724705;7946.483478573874;7998.48009879356;8159.388045896581;8212.671493140328;554.287740253772;577.1746402644175;632.7152781248457;639.9824279395783;643.4819969924256;3950.881473555798;3986.700997425147;4002;4020;4030.5969403059457;51049;51233.23150152751;52211.73894130581;52279;52575.21137182946;47198.76400617975;47237;47423.76288118537;47433.762831185624;47842.760786195846;39074.21851562953;40152.598474014885;42397;42824;43526;8513.19124683154;8560.101189375275;8650.78373040679;8737.126287371211;8817.426867253864;29035.41929161447;29228.707712922598;29502.852485737432;30580.694193058676;30703.539446908762;34675.826620866734;37427;37528.62242398197;37577.812110940366;37777.244455110194;10754.300970437209;11074.501647426046;11120.833187502032;11193.776124477303;11316.6039188628;11632.534698612299;11789.587364442203;11894.226875253082;12256.75486490283;12349.259044457362;11293.402517420875;11684.182107252751;11717.414129293671;12119;12161.45273462714;10433.426161561187;10642.361458312525;10692.411917344622;11021.283616564897;11135.554577816796;11469.942650286695;11518.36648984314;11593.88406115928;11647;11664;9337.903193572798;9952.502374881082;10054.698359048947;10173.949130254598;10204.897951020395;9684.612615495302;10000.99850224663;10017.749556261151;10098.798024039625;10303.742406439898 15:44:05 INFO - PROCESS | 14397 | __end_tp_report 15:44:05 INFO - PROCESS | 14397 | __start_cc_report 15:44:05 INFO - PROCESS | 14397 | _x_x_mozilla_cycle_collect,375 15:44:05 INFO - PROCESS | 14397 | __end_cc_report 15:44:05 INFO - PROCESS | 14397 | __startTimestamp1462574645274__endTimestamp 15:44:05 INFO - PROCESS | 14397 | 15:44:05 INFO - PROCESS | 14397 | ------- Summary: start ------- 15:44:05 INFO - PROCESS | 14397 | Number of tests: 6 15:44:05 INFO - PROCESS | 14397 | 15:44:05 INFO - PROCESS | 14397 | [#0] dojo.html Cycles:165 Average:4778.43 Median:4863.29 stddev:489.55 (10.1%) stddev-sans-first:460.98 15:44:05 INFO - PROCESS | 14397 | Values: 2624.8 2682.9 2689.5 2693.6 2712.0 4742.5 4754.6 4777.6 4874.8 4880.7 4608.5 4801.3 4823.3 4860.2 4879.8 4408.1 4440.2 4508.1 4526.7 4538.6 4474.3 4558.8 4574.2 4627.0 4651.7 4390.8 4441.4 4443.1 4444.0 4517.8 4417.2 4431.1 4452.7 4453.0 4453.8 4441.8 4482.7 4484.0 4493.8 4527.8 4689.3 4738.1 4744.6 4759.5 4771.7 5163.9 5188.1 5195.3 5198.7 5249.1 5221.5 5229.6 5255.2 5261.3 5310.7 4665.4 4783.6 4799.1 4848.1 4893.8 5192.3 5229.9 5236.1 5242.7 5266.7 5053.5 5075.6 5093.0 5097.4 5114.2 4999.4 5095.7 5137.6 5140.9 5145.0 4974.5 5131.3 5207.8 5213.0 5239.7 5144.7 5175.9 5186.7 5194.6 5272.1 4394.2 4450.0 4479.9 4488.4 4524.0 3870.3 3882.8 3887.5 3931.1 3932.7 4494.2 4530.5 4547.2 4555.6 4590.8 4962.2 5121.5 5163.1 5173.1 5177.4 4484.9 4491.5 4505.5 4507.3 4512.1 4566.7 4701.5 4703.7 4710.5 4748.6 4789.8 4830.9 4842.3 4851.1 4863.3 5171.5 5209.1 5212.0 5213.5 5259.4 4648.4 4766.5 4848.6 4855.0 4906.9 5040.9 5063.9 5088.4 5088.5 5129.7 5164.7 5170.6 5173.7 5177.2 5222.6 4868.8 5023.9 5033.8 5055.6 5100.5 4834.7 4859.1 4893.3 4902.6 5168.6 4869.2 4873.2 4881.5 4901.5 4958.2 5086.6 5108.5 5110.9 5113.6 5159.8 4789.4 4903.5 4940.8 4952.9 4957.2 15:44:05 INFO - PROCESS | 14397 | 15:44:05 INFO - PROCESS | 14397 | [#1] ext.html Cycles:180 Average:47753.82 Median:370781.00 stddev:85656.55 (23.1%) stddev-sans-first:85823.55 15:44:05 INFO - PROCESS | 14397 | Values: 559.2 605.5 610.7 617.7 635.3 39365.6 40389.8 40491.8 40534.4 40562.4 40199.2 40510.2 40887.4 40910.4 41071.6 7897.1 8014.0 8014.7 8022.7 8038.0 7817.2 7887.1 7889.3 7892.5 7918.4 7924.6 7934.0 7946.1 7946.4 7977.5 7913.1 7927.6 7937.8 7942.7 7965.3 7847.7 7875.9 7887.2 7919.0 7925.1 39356.2 39588.4 39596.0 39736.0 39866.2 3244.2 3319.2 3321.9 3435.4 3716.9 30709.4 30902.5 31259.5 31291.0 32360.5 3285.2 3313.8 3316.9 3341.0 3413.9 252724.7 253801.0 254514.0 255513.0 255702.0 29249.3 29740.7 58629.7 58786.4 59152.7 35274.8 35550.3 35570.5 35663.6 35663.8 14216.9 14402.5 14494.3 14504.4 14566.6 11302.7 11322.0 11330.3 11339.9 11389.7 8207.9 8235.8 8323.5 8360.0 8365.9 3274.3 3274.7 3278.3 3307.9 3328.5 927.5 948.1 951.8 1013.9 1071.8 30256.8 30295.8 30530.8 30648.7 30734.7 987.3 1022.6 1029.7 1090.3 1159.1 15676.1 16289.6 16434.6 16512.2 16536.2 366309.0 370347.0 370466.0 370559.0 371003.0 53852.7 54236.7 54851.5 54932.7 54953.0 1295.6 1313.1 1314.0 1316.6 1329.8 28119.3 29444.4 29548.6 29725.0 29971.4 45450.0 46279.5 46616.8 46667.3 46685.5 339248.0 340944.0 341167.0 341206.0 342465.0 26647.6 26920.3 27046.7 27800.9 27879.6 44455.6 44903.8 45881.0 47623.1 47888.8 38588.1 38892.0 39871.4 40301.6 40744.8 38458.2 38927.2 39475.8 40079.0 40330.0 39339.0 39476.8 39745.0 40115.0 40249.2 33211.8 35053.5 35275.8 35569.0 35646.6 27000.7 27320.7 27375.6 27430.0 27478.2 15:44:05 INFO - PROCESS | 14397 | 15:44:05 INFO - PROCESS | 14397 | [#2] jquery.html Cycles:180 Average:24300.04 Median:208861.12 stddev:62751.18 (30.0%) stddev-sans-first:62901.51 15:44:05 INFO - PROCESS | 14397 | Values: 376.8 381.1 383.1 387.7 395.9 15938.7 16815.0 17071.6 17506.6 17516.7 16142.8 16682.4 16689.0 16693.9 16766.3 3651.1 5004.8 5187.0 5191.2 5191.5 5587.2 5897.3 5928.8 5987.2 6008.2 5058.8 5379.8 5908.0 5919.3 5928.1 5306.6 5392.0 5410.6 5413.6 5439.3 5400.4 5424.6 5433.5 5457.3 5459.3 12158.1 12412.4 12611.2 12648.2 12677.6 1962.1 1999.7 2010.1 2063.7 2105.2 9128.1 9250.4 9295.3 9642.6 9662.9 1814.5 1864.9 1891.8 1897.4 1913.2 66442.0 70519.6 70616.0 70858.6 72138.0 9756.3 9955.0 9958.5 10214.8 10332.6 14037.4 14043.7 14109.0 14120.3 14146.6 7628.5 7637.2 7718.0 7722.3 7761.6 7365.7 7370.4 7486.4 7519.8 7521.4 3944.9 4342.1 4347.0 4418.6 4482.5 1779.6 1831.1 1868.8 1873.3 1890.6 826.3 883.5 885.2 913.6 1015.7 15831.6 16478.9 16767.3 16793.2 16823.7 893.2 917.4 940.6 942.3 995.3 9651.1 9670.4 9704.8 9734.4 9743.8 374396.0 377577.0 378166.0 379802.0 386779.0 73243.3 78169.6 78969.6 82273.0 83156.6 961.9 967.8 996.7 1000.2 1002.2 15517.4 15541.2 15617.8 15629.5 15992.5 36617.1 36867.0 37044.8 37920.2 38144.2 49855.3 52645.5 53390.2 53635.5 54136.2 4471.4 4585.3 7048.3 11171.0 11512.3 11982.9 12465.5 12485.0 12759.2 12993.7 11303.6 11314.5 11431.8 11544.3 11924.2 11489.5 11552.4 11620.8 11694.2 11766.8 11685.6 11718.0 11790.0 11793.9 11811.1 11945.5 12052.4 12111.4 12282.8 12321.9 11571.0 11607.2 11683.9 11779.5 11826.9 15:44:05 INFO - PROCESS | 14397 | 15:44:05 INFO - PROCESS | 14397 | [#3] mootools.html Cycles:180 Average:5102.68 Median:5229.24 stddev:2801.66 (53.6%) stddev-sans-first:2796.62 15:44:05 INFO - PROCESS | 14397 | Values: 1524.7 1535.6 1728.8 1870.5 1878.7 6724.3 7460.8 7465.9 7924.1 7926.5 7765.4 7775.8 7785.5 7822.9 7840.0 2221.1 2269.0 2269.1 2272.0 2274.2 2190.1 2211.0 2258.0 2263.0 2263.7 2149.3 2169.1 2169.5 2180.9 2220.6 2164.2 2172.4 2189.0 2189.6 2192.9 2100.4 2150.1 2153.8 2160.3 2161.2 7739.8 7751.4 7791.8 7792.4 7793.5 4356.6 4418.8 4420.0 4442.6 4454.7 2786.0 2798.8 2838.3 2846.9 2871.9 833.5 838.4 847.0 850.3 856.8 10051.8 10351.7 10454.0 10478.4 10492.4 4098.6 4100.8 4185.8 4191.6 4198.0 8461.4 8463.3 8476.2 8487.5 8491.3 4585.2 4585.6 4614.0 4617.6 4629.9 3656.7 4044.0 4142.2 4178.6 4234.9 3480.9 3489.2 3567.0 3579.2 3627.9 1030.5 1049.2 1054.7 1057.0 1065.5 925.1 939.7 945.4 951.3 969.8 5337.2 5414.9 5511.3 5630.8 5687.0 411.9 413.6 421.4 425.4 425.8 3865.0 3894.3 3952.5 3967.1 3990.4 8803.0 9316.8 9350.9 9376.0 9424.6 9001.1 9217.9 9252.8 9291.6 9335.9 7149.6 7254.5 7298.9 7349.0 7360.2 5225.8 5232.7 5339.3 5394.5 5410.6 8633.8 8663.2 8684.0 8725.7 8787.3 8332.8 8656.9 8678.3 8768.6 8810.8 6095.2 6617.6 6812.1 6856.9 6955.0 7604.5 7605.0 7605.8 7638.7 7687.2 6784.8 7032.5 7052.3 7085.6 7105.1 6817.6 6874.5 6915.4 6922.5 6969.9 6313.5 6333.1 6397.5 6427.7 6433.3 4449.3 4681.6 4794.5 4906.5 4907.8 4949.5 4966.7 4981.0 4988.5 5060.2 15:44:05 INFO - PROCESS | 14397 | 15:44:05 INFO - PROCESS | 14397 | [#4] prototype.html Cycles:180 Average:4282.31 Median:4873.68 stddev:1237.83 (25.4%) stddev-sans-first:1204.70 15:44:05 INFO - PROCESS | 14397 | Values: 301.6 307.4 310.5 310.5 315.5 5058.9 5070.2 5074.7 5105.5 5121.3 4965.8 4988.0 4995.8 4996.0 5009.2 3746.6 3796.0 3912.7 3922.1 3946.3 3907.4 3926.7 3928.4 3934.1 3946.7 3908.3 3917.8 3917.9 3921.5 3921.6 3824.6 3893.3 3902.1 3928.0 3931.8 3444.3 3464.4 3469.9 3471.8 3474.0 4772.8 4774.2 4794.5 4796.6 4803.0 4384.8 4419.7 4470.3 4480.0 4491.3 5078.8 5129.5 5159.7 5165.6 5197.7 3728.5 3733.0 3750.5 3752.4 3754.4 5444.6 5447.9 5456.5 5469.1 5473.6 3561.4 3767.8 3778.8 3779.8 3779.8 3805.6 3818.3 3840.1 3846.8 3848.2 4343.1 4387.9 4398.6 4412.2 4416.4 5063.0 5179.6 5188.9 5219.1 5231.3 1280.9 1283.9 1285.3 1295.0 1297.0 821.8 835.5 864.3 874.7 882.4 4493.9 4551.5 4570.1 4579.5 4616.5 5317.7 5319.0 5329.9 5348.3 5377.7 4391.0 4550.9 4561.9 4579.4 4605.7 2724.6 2740.8 2768.0 2774.4 2792.5 4862.7 4881.5 4884.8 4887.6 4889.2 5062.6 5335.3 5356.6 5382.8 5392.5 4918.9 4936.9 4941.0 4941.1 4968.8 5129.7 5153.8 5265.2 5272.5 5286.4 4922.2 5082.0 5126.5 5135.8 5140.0 4842.1 4856.2 4865.8 4865.9 4918.2 3601.1 3630.9 3678.9 3701.4 3714.2 4981.8 5218.9 5298.5 5302.5 5339.7 5068.2 5070.2 5076.6 5086.0 5124.3 5040.2 5049.9 5080.2 5086.9 5090.7 4803.6 4981.3 5005.9 5007.7 5156.3 5016.2 5124.7 5270.4 5285.9 5287.2 5051.8 5109.2 5112.8 5120.4 5137.6 15:44:05 INFO - PROCESS | 14397 | 15:44:05 INFO - PROCESS | 14397 | [#5] yui.html Cycles:180 Average:12900.01 Median:21498.72 stddev:14245.20 (66.3%) stddev-sans-first:14256.16 15:44:05 INFO - PROCESS | 14397 | Values: 797.2 805.1 807.1 819.5 820.7 12196.7 13032.5 13213.1 13231.3 13263.5 12783.7 12841.8 12841.9 12842.0 12858.7 673.8 830.6 861.6 864.3 864.8 860.6 863.8 866.2 867.3 867.8 917.9 920.3 920.7 922.4 924.5 907.3 907.5 908.0 909.5 910.2 671.4 672.8 673.9 674.3 675.6 12891.7 12910.5 12977.5 12997.4 12997.7 12494.8 12591.1 12921.4 13137.5 13340.5 10495.8 10496.3 10573.6 10591.0 10629.3 3337.3 3381.1 3455.4 3457.3 3461.0 44571.3 44716.0 44839.8 44882.8 46796.1 9890.9 10137.1 10171.6 10195.2 10268.5 16154.6 16593.1 16743.0 18502.4 18514.8 6878.3 6949.3 7012.5 7022.2 7177.0 3640.4 3746.6 3764.9 3833.4 3923.2 2914.3 2987.4 3031.6 3033.5 3034.0 540.7 540.8 549.2 550.2 556.9 581.4 653.5 659.2 664.7 668.5 7745.5 7946.5 7998.5 8159.4 8212.7 554.3 577.2 632.7 640.0 643.5 3950.9 3986.7 4002.0 4020.0 4030.6 51049.0 51233.2 52211.7 52279.0 52575.2 47198.8 47237.0 47423.8 47433.8 47842.8 39074.2 40152.6 42397.0 42824.0 43526.0 8513.2 8560.1 8650.8 8737.1 8817.4 29035.4 29228.7 29502.9 30580.7 30703.5 34675.8 37427.0 37528.6 37577.8 37777.2 10754.3 11074.5 11120.8 11193.8 11316.6 11632.5 11789.6 11894.2 12256.8 12349.3 11293.4 11684.2 11717.4 12119.0 12161.5 10433.4 10642.4 10692.4 11021.3 11135.6 11469.9 11518.4 11593.9 11647.0 11664.0 9337.9 9952.5 10054.7 10173.9 10204.9 9684.6 10001.0 10017.7 10098.8 10303.7 15:44:05 INFO - PROCESS | 14397 | -------- Summary: end -------- 15:44:05 INFO - PROCESS | 14397 | 15:44:06 INFO - TEST-INFO | 14397: exit 0 15:44:06 INFO - TEST-OK | dromaeo_css | took 1115527ms 15:44:06 INFO - TEST-START | kraken 15:44:06 INFO - operating with platform_type : linux_ 15:44:06 INFO - Initialising browser for kraken test... 15:44:06 INFO - TEST-INFO | started process 14634 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjrQJcs/profile http://localhost:46571/getInfo.html) 15:44:09 INFO - PROCESS | 14634 | 15:44:09 INFO - PROCESS | 14634 | (process:14703): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 15:44:10 INFO - PROCESS | 14634 | __metrics Screen width/height:1600/1200 15:44:10 INFO - PROCESS | 14634 | colorDepth:24 15:44:10 INFO - PROCESS | 14634 | Browser inner width/height: 1024/697 15:44:10 INFO - PROCESS | 14634 | __metrics 15:44:11 ERROR - PROCESS | 14634 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 15:44:12 INFO - TEST-INFO | 14634: exit 0 15:44:12 INFO - Browser initialized. 15:44:12 INFO - Running cycle 1/1 for kraken test... 15:44:12 INFO - TEST-INFO | started process 14754 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjrQJcs/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:44:14 INFO - PROCESS | 14754 | 15:44:14 INFO - PROCESS | 14754 | (process:14815): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 15:44:24 INFO - PROCESS | 14754 | RSS: Main: 164438016 15:44:24 INFO - PROCESS | 14754 | 15:44:26 INFO - PROCESS | 14754 | Cycle 1(1): loaded http://localhost:46571/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46571/tests/kraken/driver.html?testName=audio-beat-detection) 15:44:27 INFO - PROCESS | 14754 | RSS: Main: 168079360 15:44:27 INFO - PROCESS | 14754 | 15:44:30 INFO - PROCESS | 14754 | Cycle 1(1): loaded http://localhost:46571/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46571/tests/kraken/driver.html?testName=audio-dft) 15:44:31 INFO - PROCESS | 14754 | RSS: Main: 169295872 15:44:31 INFO - PROCESS | 14754 | 15:44:34 INFO - PROCESS | 14754 | Cycle 1(1): loaded http://localhost:46571/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46571/tests/kraken/driver.html?testName=audio-fft) 15:44:34 INFO - PROCESS | 14754 | RSS: Main: 163282944 15:44:34 INFO - PROCESS | 14754 | 15:44:36 INFO - PROCESS | 14754 | Cycle 1(1): loaded http://localhost:46571/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46571/tests/kraken/driver.html?testName=audio-oscillator) 15:44:37 INFO - PROCESS | 14754 | RSS: Main: 163729408 15:44:37 INFO - PROCESS | 14754 | 15:44:39 INFO - PROCESS | 14754 | Cycle 1(1): loaded http://localhost:46571/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46571/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:44:40 INFO - PROCESS | 14754 | RSS: Main: 163999744 15:44:40 INFO - PROCESS | 14754 | 15:44:43 INFO - PROCESS | 14754 | Cycle 1(1): loaded http://localhost:46571/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46571/tests/kraken/driver.html?testName=imaging-darkroom) 15:44:44 INFO - PROCESS | 14754 | RSS: Main: 164675584 15:44:44 INFO - PROCESS | 14754 | 15:44:47 INFO - PROCESS | 14754 | Cycle 1(1): loaded http://localhost:46571/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46571/tests/kraken/driver.html?testName=imaging-desaturate) 15:44:48 INFO - PROCESS | 14754 | RSS: Main: 163590144 15:44:48 INFO - PROCESS | 14754 | 15:44:51 INFO - PROCESS | 14754 | Cycle 1(1): loaded http://localhost:46571/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46571/tests/kraken/driver.html?testName=json-parse-financial) 15:44:52 INFO - PROCESS | 14754 | RSS: Main: 164978688 15:44:52 INFO - PROCESS | 14754 | 15:44:53 INFO - PROCESS | 14754 | Cycle 1(1): loaded http://localhost:46571/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46571/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:44:54 INFO - PROCESS | 14754 | RSS: Main: 164315136 15:44:54 INFO - PROCESS | 14754 | 15:44:56 INFO - PROCESS | 14754 | Cycle 1(1): loaded http://localhost:46571/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46571/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:44:56 INFO - PROCESS | 14754 | RSS: Main: 163823616 15:44:56 INFO - PROCESS | 14754 | 15:44:59 INFO - PROCESS | 14754 | Cycle 1(1): loaded http://localhost:46571/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46571/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:44:59 INFO - PROCESS | 14754 | RSS: Main: 163966976 15:44:59 INFO - PROCESS | 14754 | 15:45:02 INFO - PROCESS | 14754 | Cycle 1(1): loaded http://localhost:46571/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46571/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:45:03 INFO - PROCESS | 14754 | RSS: Main: 164589568 15:45:03 INFO - PROCESS | 14754 | 15:45:06 INFO - PROCESS | 14754 | Cycle 1(1): loaded http://localhost:46571/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46571/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:45:06 INFO - PROCESS | 14754 | RSS: Main: 164413440 15:45:06 INFO - PROCESS | 14754 | 15:45:08 INFO - PROCESS | 14754 | Cycle 1(1): loaded http://localhost:46571/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46571/tests/kraken/driver.html?testName=ai-astar) 15:45:08 INFO - PROCESS | 14754 | RSS: Main: 165859328 15:45:08 INFO - PROCESS | 14754 | 15:45:08 INFO - PROCESS | 14754 | __start_tp_report 15:45:08 INFO - PROCESS | 14754 | _x_x_mozilla_page_load 15:45:08 INFO - PROCESS | 14754 | _x_x_mozilla_page_load_details 15:45:08 INFO - PROCESS | 14754 | |i|pagename|runs| 15:45:08 INFO - PROCESS | 14754 | |0;ai-astar;112;115;108;112;114;114;106;113;112;113 15:45:08 INFO - PROCESS | 14754 | |1;audio-beat-detection;153;133;157;182;135;158;161;134;186;133 15:45:08 INFO - PROCESS | 14754 | |2;audio-dft;161;164;165;170;165;164;164;164;162;162 15:45:08 INFO - PROCESS | 14754 | |3;audio-fft;75;77;77;171;80;77;78;75;168;77 15:45:08 INFO - PROCESS | 14754 | |4;audio-oscillator;94;95;148;93;94;95;152;93;92;148 15:45:08 INFO - PROCESS | 14754 | |5;imaging-gaussian-blur;118;118;117;118;117;117;117;118;117;117 15:45:08 INFO - PROCESS | 14754 | |6;imaging-darkroom;148;147;148;147;147;148;147;147;148;147 15:45:08 INFO - PROCESS | 14754 | |7;imaging-desaturate;95;96;96;96;95;96;96;96;96;95 15:45:08 INFO - PROCESS | 14754 | |8;json-parse-financial;67;67;66;66;66;67;66;82;65;64 15:45:08 INFO - PROCESS | 14754 | |9;json-stringify-tinderbox;64;65;64;64;64;64;65;64;65;64 15:45:08 INFO - PROCESS | 14754 | |10;stanford-crypto-aes;83;85;90;84;82;89;85;83;85;83 15:45:08 INFO - PROCESS | 14754 | |11;stanford-crypto-ccm;138;133;138;136;134;137;140;140;223;141 15:45:08 INFO - PROCESS | 14754 | |12;stanford-crypto-pbkdf2;173;175;174;184;176;171;174;172;174;171 15:45:08 INFO - PROCESS | 14754 | |13;stanford-crypto-sha256-iterative;69;68;67;67;68;67;72;73;66;66 15:45:08 INFO - PROCESS | 14754 | __end_tp_report 15:45:08 INFO - PROCESS | 14754 | __start_cc_report 15:45:08 INFO - PROCESS | 14754 | _x_x_mozilla_cycle_collect,927 15:45:08 INFO - PROCESS | 14754 | __end_cc_report 15:45:08 INFO - PROCESS | 14754 | __startTimestamp1462574708808__endTimestamp 15:45:08 INFO - PROCESS | 14754 | 15:45:08 INFO - PROCESS | 14754 | ------- Summary: start ------- 15:45:08 INFO - PROCESS | 14754 | Number of tests: 14 15:45:08 INFO - PROCESS | 14754 | 15:45:08 INFO - PROCESS | 14754 | [#0] ai-astar Cycles:10 Average:111.90 Median:113.00 stddev:2.81 (2.5%) stddev-sans-first:2.98 15:45:08 INFO - PROCESS | 14754 | Values: 112.0 115.0 108.0 112.0 114.0 114.0 106.0 113.0 112.0 113.0 15:45:08 INFO - PROCESS | 14754 | 15:45:08 INFO - PROCESS | 14754 | [#1] audio-beat-detection Cycles:10 Average:153.20 Median:157.50 stddev:19.78 (12.6%) stddev-sans-first:20.97 15:45:08 INFO - PROCESS | 14754 | Values: 153.0 133.0 157.0 182.0 135.0 158.0 161.0 134.0 186.0 133.0 15:45:08 INFO - PROCESS | 14754 | 15:45:08 INFO - PROCESS | 14754 | [#2] audio-dft Cycles:10 Average:164.10 Median:164.00 stddev:2.47 (1.5%) stddev-sans-first:2.35 15:45:08 INFO - PROCESS | 14754 | Values: 161.0 164.0 165.0 170.0 165.0 164.0 164.0 164.0 162.0 162.0 15:45:08 INFO - PROCESS | 14754 | 15:45:08 INFO - PROCESS | 14754 | [#3] audio-fft Cycles:10 Average:95.50 Median:77.00 stddev:39.03 (50.7%) stddev-sans-first:40.69 15:45:08 INFO - PROCESS | 14754 | Values: 75.0 77.0 77.0 171.0 80.0 77.0 78.0 75.0 168.0 77.0 15:45:08 INFO - PROCESS | 14754 | 15:45:08 INFO - PROCESS | 14754 | [#4] audio-oscillator Cycles:10 Average:110.40 Median:93.50 stddev:26.90 (28.8%) stddev-sans-first:27.87 15:45:08 INFO - PROCESS | 14754 | Values: 94.0 95.0 148.0 93.0 94.0 95.0 152.0 93.0 92.0 148.0 15:45:08 INFO - PROCESS | 14754 | 15:45:08 INFO - PROCESS | 14754 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:117.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 15:45:08 INFO - PROCESS | 14754 | Values: 118.0 118.0 117.0 118.0 117.0 117.0 117.0 118.0 117.0 117.0 15:45:08 INFO - PROCESS | 14754 | 15:45:08 INFO - PROCESS | 14754 | [#6] imaging-darkroom Cycles:10 Average:147.40 Median:147.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 15:45:08 INFO - PROCESS | 14754 | Values: 148.0 147.0 148.0 147.0 147.0 148.0 147.0 147.0 148.0 147.0 15:45:08 INFO - PROCESS | 14754 | 15:45:08 INFO - PROCESS | 14754 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 15:45:08 INFO - PROCESS | 14754 | Values: 95.0 96.0 96.0 96.0 95.0 96.0 96.0 96.0 96.0 95.0 15:45:08 INFO - PROCESS | 14754 | 15:45:08 INFO - PROCESS | 14754 | [#8] json-parse-financial Cycles:10 Average:67.60 Median:66.50 stddev:5.15 (7.7%) stddev-sans-first:5.45 15:45:08 INFO - PROCESS | 14754 | Values: 67.0 67.0 66.0 66.0 66.0 67.0 66.0 82.0 65.0 64.0 15:45:08 INFO - PROCESS | 14754 | 15:45:08 INFO - PROCESS | 14754 | [#9] json-stringify-tinderbox Cycles:10 Average:64.30 Median:64.00 stddev:0.48 (0.8%) stddev-sans-first:0.50 15:45:08 INFO - PROCESS | 14754 | Values: 64.0 65.0 64.0 64.0 64.0 64.0 65.0 64.0 65.0 64.0 15:45:08 INFO - PROCESS | 14754 | 15:45:08 INFO - PROCESS | 14754 | [#10] stanford-crypto-aes Cycles:10 Average:84.90 Median:85.00 stddev:2.64 (3.1%) stddev-sans-first:2.71 15:45:08 INFO - PROCESS | 14754 | Values: 83.0 85.0 90.0 84.0 82.0 89.0 85.0 83.0 85.0 83.0 15:45:08 INFO - PROCESS | 14754 | 15:45:08 INFO - PROCESS | 14754 | [#11] stanford-crypto-ccm Cycles:10 Average:146.00 Median:139.00 stddev:27.18 (19.6%) stddev-sans-first:28.67 15:45:08 INFO - PROCESS | 14754 | Values: 138.0 133.0 138.0 136.0 134.0 137.0 140.0 140.0 223.0 141.0 15:45:08 INFO - PROCESS | 14754 | 15:45:08 INFO - PROCESS | 14754 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.40 Median:174.00 stddev:3.75 (2.2%) stddev-sans-first:3.94 15:45:08 INFO - PROCESS | 14754 | Values: 173.0 175.0 174.0 184.0 176.0 171.0 174.0 172.0 174.0 171.0 15:45:08 INFO - PROCESS | 14754 | 15:45:08 INFO - PROCESS | 14754 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.30 Median:68.00 stddev:2.41 (3.5%) stddev-sans-first:2.54 15:45:08 INFO - PROCESS | 14754 | Values: 69.0 68.0 67.0 67.0 68.0 67.0 72.0 73.0 66.0 66.0 15:45:08 INFO - PROCESS | 14754 | -------- Summary: end -------- 15:45:08 INFO - PROCESS | 14754 | 15:45:09 INFO - TEST-INFO | 14754: exit 0 15:45:09 INFO - TEST-OK | kraken | took 63720ms 15:45:09 INFO - SUITE-END | took 1179s 15:45:09 INFO - Completed test suite (00:19:39) 15:45:09 INFO - javascript benchmark 15:45:10 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2624.750648688375, 2682.8658567071643, 2689.515887140314, 2693.5690289553663, 2711.9965612723295, 4742.549457801508, 4754.64340174487, 4777.570018698317, 4874.756262186894, 4880.731559764212, 4608.516105808883, 4801.255805350168, 4823.324734537167, 4860.198067318888, 4879.780409881555, 4408.140412619532, 4440.245158323077, 4508.120916421299, 4526.660500462462, 4538.591526762591, 4474.306482495218, 4558.794854231551, 4574.153781550423, 4627.0, 4651.674382793206, 4390.846320378771, 4441.378207051015, 4443.133588950156, 4443.977780111095, 4517.774111294422, 4417.18282117806, 4431.135928493945, 4452.732836029849, 4453.042595841877, 4453.844115455943, 4441.844535441276, 4482.7310361378095, 4484.035932274576, 4493.820247190109, 4527.750973696446, 4689.2966055091665, 4738.123447162286, 4744.620430365597, 4759.476457589697, 4771.689840160413, 5163.870903227412, 5188.143956247215, 5195.324607801, 5198.714070726109, 5249.133892907704, 5221.451747566489, 5229.581633469352, 5255.185446255837, 5261.342332208474, 5310.734463276821, 4665.393498845162, 4783.569478746929, 4799.088173247072, 4848.127337079289, 4893.828715994923, 5192.324997750268, 5229.895402091937, 5236.0575096483, 5242.711650859239, 5266.657667251617, 5053.494650534991, 5075.593952483792, 5092.9745351273, 5097.388313402415, 5114.207297868837, 4999.350084489066, 5095.668781529189, 5137.563307118862, 5140.948590514122, 5144.9742751286, 4974.477679843637, 5131.307273518102, 5207.843764687065, 5213.009528189632, 5239.73801309933, 5144.6655967362, 5175.896482070413, 5186.688798672092, 5194.558462530652, 5272.05103081449, 4394.231009573312, 4449.9555004450185, 4479.932801007987, 4488.438945131858, 4524.0047189618235, 3870.2646497165447, 3882.76703397797, 3887.5328623272558, 3931.1351502669368, 3932.724709270381, 4494.202558560894, 4530.546945305443, 4547.226971414867, 4555.5899969002285, 4590.8163673453355, 4962.230854217602, 5121.539061484485, 5163.07064728345, 5173.1464308388695, 5177.430482646906, 4484.887877803016, 4491.461024676994, 4505.481869584974, 4507.323901414814, 4512.05246898155, 4566.725996440157, 4701.459332176775, 4703.670743048022, 4710.505396933341, 4748.572628463455, 4789.8323558675975, 4830.879228019257, 4842.322074909586, 4851.126797176542, 4863.294822250825, 5171.482851714798, 5209.088409528393, 5212.035773381936, 5213.504717051874, 5259.395169555397, 4648.395708557866, 4766.45185803637, 4848.5636292733825, 4855.004724031494, 4906.8773280668265, 5040.924386134137, 5063.924041139459, 5088.389393272831, 5088.491150884882, 5129.717865517432, 5164.690118592896, 5170.564791676025, 5173.741312934263, 5177.249298851721, 5222.582193424441, 4868.829590964299, 5023.899522009612, 5033.773480193327, 5055.570276526537, 5100.515451032146, 4834.685745426536, 4859.07677541266, 4893.314935909047, 4902.558769710743, 5168.560672342893, 4869.220924652181, 4873.195922672861, 4881.511848815232, 4901.534354236342, 4958.206686930074, 5086.593072554113, 5108.48915108501, 5110.872228194325, 5113.616478764033, 5159.845204643867, 4789.425268967746, 4903.53416425439, 4940.827071052496, 4952.925706114339, 4957.206846904478], "value": 4747.6110025803255, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [559.2422267827094, 605.5034871405448, 610.685496969061, 617.7467238432241, 635.3424205946845, 39365.60634393655, 40389.798051009704, 40491.79754101225, 40534.39198412026, 40562.39156412649, 40199.19601607966, 40510.18979620406, 40887.38668919969, 40910.38634420479, 41071.58928410723, 7897.052353717562, 8014.0, 8014.7194848180325, 8022.719204827832, 8038.035435747689, 7817.179196184404, 7887.132415434297, 7889.250521200477, 7892.4869883457395, 7918.366530677532, 7924.643391047388, 7934.047914250298, 7946.086200087007, 7946.364290856717, 7977.521348719096, 7913.129555748863, 7927.563983980879, 7937.841243175133, 7942.722004729807, 7965.283124518821, 7847.725329613493, 7875.921240787576, 7887.211278872124, 7918.960405197995, 7925.088614809313, 39356.21287574233, 39588.40617390742, 39596.0, 39736.0, 39866.20267594661, 3244.156519304998, 3319.2365755876044, 3321.9003429897143, 3435.3644575753565, 3716.9442458363146, 30709.385812283854, 30902.53646195309, 31259.531107033414, 31291.0, 32360.514592281135, 3285.211549228168, 3313.7514686398617, 3316.9385796545116, 3341.0, 3413.9487907681155, 252724.7363763188, 253801.0, 254514.0, 255513.0, 255702.0, 29249.268768280537, 29740.702592973794, 58629.706851466326, 58786.41213587809, 59152.704236478545, 35274.82362588222, 35550.28899421997, 35570.46644300337, 35663.64336356655, 35663.821680891946, 14216.928915355356, 14402.495912643008, 14494.275286235646, 14504.419823207165, 14566.563003109924, 11302.717432064264, 11322.037626801814, 11330.263532870336, 11339.943300283447, 11389.658310250707, 8207.876881846778, 8235.8352832943, 8323.542205178652, 8359.958200209081, 8365.870607468036, 3274.3123943971555, 3274.672532746754, 3278.2623909620143, 3307.9173020674193, 3328.5007248912857, 927.4667066436825, 948.0898337595985, 951.7953639967441, 1013.9442330671884, 1071.8231491803922, 30256.78972841106, 30295.848520757256, 30530.847345763574, 30648.69351306503, 30734.69265307363, 987.2990176974429, 1022.6420752736483, 1029.6602121300102, 1090.2695194219734, 1159.1422347462817, 15676.137812420426, 16289.592760180853, 16434.589135271715, 16512.207323899052, 16536.173191340386, 366309.0, 370347.0, 370466.0, 370559.0, 371003.0, 53852.730736346064, 54236.728816355666, 54851.451485485435, 54932.72533637306, 54953.0, 1295.559509766684, 1313.1136482874022, 1313.954011609589, 1316.5984374765596, 1329.8138260643518, 28119.297017574725, 29444.411111778074, 29548.556771648873, 29725.0, 29971.400571988874, 45450.0, 46279.53720462752, 46616.7669161652, 46667.29999050085, 46685.533144669476, 339248.0, 340944.0, 341167.0, 341206.0, 342465.0, 26647.600285995337, 26920.32699182536, 27046.72953270442, 27800.860995694893, 27879.581806272516, 44455.555444446436, 44903.775481122386, 45881.0, 47623.09507619795, 47888.760556197, 38588.09720384766, 38892.0, 39871.40192897167, 40301.596984029784, 40744.79627601843, 38458.23083538258, 38927.221455570165, 39475.80262098671, 40079.0, 40330.0, 39339.0, 39476.80261598674, 39745.0, 40115.0, 40249.19501609893, 33211.83394083014, 35053.47419788756, 35275.82362088276, 35569.0, 35646.64353356433, 27000.72999269982, 27320.726792731817, 27375.589366159922, 27430.0, 27478.17565473039], "value": 17335.067780654754, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [376.8228932401771, 381.05688421157623, 383.092071789858, 387.69953286203173, 395.9287328280908, 15938.72490200784, 16815.0, 17071.57321066974, 17506.649867002652, 17516.73724894126, 16142.7578586321, 16682.41611543596, 16689.0, 16693.916530417362, 16766.329346826144, 3651.050726811022, 5004.824831130911, 5186.974065129669, 5191.195364718475, 5191.506806853343, 5587.189857470685, 5897.3218079920925, 5928.7628494860155, 5987.221661184061, 6008.218931538916, 5058.7976480940715, 5379.81170659027, 5908.025175846002, 5919.319278283009, 5928.05151175812, 5306.575473962073, 5391.973040134794, 5410.621256512046, 5413.593980451462, 5439.265699130626, 5400.405955344909, 5424.593155513352, 5433.510984011418, 5457.317835270591, 5459.317585301837, 12158.088143389281, 12412.441440135126, 12611.243325400414, 12648.241105533605, 12677.556285529961, 1962.05821205822, 1999.740033795612, 2010.1155491583802, 2063.679831406516, 2105.157936825267, 9128.132827381389, 9250.35247532673, 9295.349325547215, 9642.614295428244, 9662.855057174149, 1814.5372929902921, 1864.9440516784518, 1891.810818918097, 1897.354899334233, 1913.23470611755, 66442.0, 70519.64740176317, 70616.0, 70858.64570677113, 72137.99999999948, 9756.317057805885, 9954.950225248973, 9958.502074896227, 10214.846777298346, 10332.638357657446, 14037.368318425695, 14043.719125617636, 14109.0, 14120.293985300694, 14146.646333841736, 7628.46600737943, 7637.15991240963, 7718.0, 7722.317388333899, 7761.6119194040075, 7365.668544915492, 7370.373518251009, 7486.363659089038, 7519.8496030079095, 7521.398288136936, 3944.881653550398, 4342.0664557119735, 4347.0, 4418.6023257906945, 4482.5069242383315, 1779.5551112221945, 1831.081718476137, 1868.8411485023926, 1873.2506997201228, 1890.5651700108776, 826.3182874128868, 883.4522595990398, 885.1679421344045, 913.584319134792, 1015.7105225010837, 15831.604209894846, 16478.917605411898, 16767.262915958632, 16793.160341983097, 16823.747643785355, 893.2452077994085, 917.3991035871381, 940.6472572785206, 942.3168203052869, 995.3381001633977, 9651.131398174057, 9670.371425857296, 9704.75738106553, 9734.36726612768, 9743.805123897482, 374396.0, 377577.0, 378166.0, 379802.0, 386779.0, 73243.26756732471, 78169.60915195501, 78969.60515197387, 82273.0, 83156.58421707974, 961.8701475300745, 967.8354679704327, 996.6661168508485, 1000.174855744014, 1002.2282842211456, 15517.37930482768, 15541.222938853238, 15617.843821562094, 15629.531114066596, 15992.520224393287, 36617.08457288589, 36867.0, 37044.814775925945, 37920.24159516739, 38144.23711525698, 49855.252171216736, 52645.47354526559, 53390.199147013605, 53635.51369161148, 54136.187957181464, 4471.396361491157, 4585.28928016158, 7048.295170482911, 11171.0, 11512.30926144434, 11982.940085299866, 12465.5013799447, 12485.0, 12759.170653907466, 12993.740125197632, 11303.604373846876, 11314.547418103184, 11431.828522572334, 11544.307341559534, 11924.224925379822, 11489.540418383505, 11552.364619945647, 11620.825687614524, 11694.239874408137, 11766.82349764737, 11685.591004314809, 11718.0, 11790.0, 11793.882061179622, 11811.114166437723, 11945.462454189408, 12052.397380131133, 12111.394430278628, 12282.815757763461, 12321.93839030799, 11571.0, 11607.245529040585, 11683.941580292045, 11779.528818847493, 11826.881731182923], "value": 8493.951698881985, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1524.7179271834707, 1535.5623647260531, 1728.8444040036395, 1870.5417172792659, 1878.6618408686431, 6724.327567243286, 7460.813479663005, 7465.888011679829, 7924.088729796075, 7926.524408535492, 7765.378769698425, 7775.805604859867, 7785.493942893708, 7822.882656760139, 7839.999999999985, 2221.0893533651247, 2268.9546209075806, 2269.069681430614, 2272.0230300970575, 2274.2494976657663, 2190.0692205812547, 2210.9778902211015, 2258.0, 2263.0155882191216, 2263.671767593698, 2149.3014770199748, 2169.078141789733, 2169.4901698100934, 2180.890955452229, 2220.589190999662, 2164.21006332689, 2172.3808714516367, 2189.0477642225683, 2189.6496560550313, 2192.9232476863313, 2100.390886642872, 2150.0969592771075, 2153.7738537453497, 2160.25471212433, 2161.200355868323, 7739.845203095907, 7751.418643601753, 7791.8441631167625, 7792.376609871197, 7793.532388056678, 4356.629686476654, 4418.845340413102, 4419.955800441987, 4442.644588432918, 4454.732716037048, 2785.9860700696568, 2798.790090743202, 2838.2904273931517, 2846.9430611387866, 2871.928201794951, 833.4830608292909, 838.4214891724752, 847.0428415890067, 850.2602735620051, 856.7558245899888, 10051.849222261671, 10351.689449316533, 10454.0, 10478.423686697228, 10492.370457772558, 4098.569650186747, 4100.815463304159, 4185.769782661982, 4191.559886211965, 4198.03445207604, 8461.365397595206, 8463.280621147149, 8476.237138657427, 8487.490750554987, 8491.320694344438, 4585.220512512814, 4585.610223131004, 4614.007988282468, 4617.630589552828, 4629.884252893705, 3656.689181419609, 4043.9595604043584, 4142.1922725068325, 4178.561251068655, 4234.9364759528635, 3480.89557313281, 3489.180042689966, 3567.0, 3579.2125732339364, 3627.9455808162897, 1030.4847576211894, 1049.228816819637, 1054.651964851597, 1056.963006294776, 1065.472591067411, 925.1396201532639, 939.7086903060073, 945.3713280668416, 951.2580187453797, 969.8205831921117, 5337.172738225581, 5414.864628384322, 5511.255980442589, 5630.831075067755, 5687.03320435527, 411.868202175301, 413.6153377359025, 421.43317238314415, 425.36408069935646, 425.84030988379357, 3865.0, 3894.2990261753157, 3952.545457272393, 3967.0677390813134, 3990.4413382126527, 8803.0, 9316.767080823034, 9350.90649093514, 9376.0, 9424.62301507932, 9001.144891235323, 9217.861732074025, 9252.814943701089, 9291.58187881547, 9335.859962100574, 7149.571025738368, 7254.528455650471, 7298.890516642255, 7348.963255183797, 7360.190379058299, 5225.817096401608, 5232.659877108128, 5339.252504649275, 5394.541463975449, 5410.567154627699, 8633.784155396166, 8663.220310172115, 8684.0, 8725.65097396097, 8787.340949428946, 8332.833343333221, 8656.87460630114, 8678.305735541267, 8768.649254030022, 8810.779730506789, 6095.207623009158, 6617.636030018395, 6812.114425124702, 6856.862862742618, 6955.0, 7604.543727376154, 7604.96197519031, 7605.771826845204, 7638.732644357421, 7687.192844751221, 6784.7964561063245, 7032.507724459443, 7052.259512751088, 7085.6457177141965, 7105.147382314155, 6817.625030623363, 6874.450043996369, 6915.412189963708, 6922.5154239202775, 6969.9303006969285, 6313.526485513513, 6333.113364129118, 6397.520185986163, 6427.710753016032, 6433.29233784274, 4449.265871131227, 4681.555252251031, 4794.544518270759, 4906.484819094087, 4907.828226012072, 4949.505049495166, 4966.6771659842, 4980.950190498049, 4988.45127036033, 5060.240963855451], "value": 4067.204974906811, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [301.59887349824737, 307.3698917219698, 310.51094526121335, 310.5497029307504, 315.5471897826619, 5058.949410505894, 5070.163423035199, 5074.746262686869, 5105.540501354877, 5121.28302037715, 4965.801367945287, 4987.975060124703, 4995.825146119886, 4995.950040499594, 5009.173486374753, 3746.550413950316, 3795.9620403795884, 3912.667423269011, 3922.117523557191, 3946.3488524393583, 3907.433422153786, 3926.6858651307825, 3928.37146056631, 3934.1344904121047, 3946.743461674996, 3908.335582950891, 3917.8041097945134, 3917.9216415671813, 3921.5490218624936, 3921.627445392683, 3824.6366595173413, 3893.299206142893, 3902.122022544933, 3927.960720392802, 3931.823067961934, 3444.3111377724304, 3464.3764122457947, 3469.9479507807405, 3471.836934626903, 3473.9652603473896, 4772.76136193189, 4774.212254977924, 4794.520547945178, 4796.616270698336, 4802.991371811923, 4384.807596201899, 4419.690621656486, 4470.26240670289, 4480.036792089716, 4491.326301054835, 5078.7968481260705, 5129.487051294878, 5159.74201289934, 5165.560927321182, 5197.714125723083, 3728.4780130781714, 3732.981335093334, 3750.474933509311, 3752.418375151856, 3754.3992961126087, 5444.646098003656, 5447.918281225785, 5456.454354564512, 5469.097598896177, 5473.589480788917, 3561.3767590671528, 3767.811609419518, 3778.7732736035928, 3779.848806047782, 3779.848806047782, 3805.553889521964, 3818.312703713358, 3840.0975770693863, 3846.8461261549223, 3848.191879705293, 4343.087951530151, 4387.934180987288, 4398.626116780046, 4412.161689279027, 4416.4258646375765, 5062.974685126551, 5179.559737422362, 5188.922166167435, 5219.060569097599, 5231.3199284092825, 1280.9487620495263, 1283.8523569789593, 1285.318781046047, 1294.996377807188, 1296.9870301297055, 821.7904434369198, 835.4736515995006, 864.2783275964514, 874.711345256064, 882.3999680217514, 4493.932591011137, 4551.52209018055, 4570.085982803453, 4579.496255411902, 4616.469106052847, 5317.707526086025, 5318.97340513295, 5329.920051199235, 5348.277982472394, 5377.655586103474, 4390.956090439118, 4550.908981820345, 4561.863144105682, 4579.427571553556, 4605.700629459075, 2724.6049322848075, 2740.8355498669744, 2768.0173538393983, 2774.389634280455, 2792.5113105206506, 4862.659613826998, 4881.51184881509, 4884.755762211875, 4887.560119589183, 4889.193283108319, 5062.594992400673, 5335.306410166731, 5356.571474282048, 5382.811601593926, 5392.514673679309, 4918.926216106761, 4936.901261974812, 4940.975295123501, 4941.085899108676, 4968.782648251202, 5129.743512824419, 5153.768080436314, 5265.183896496049, 5272.499112584298, 5286.444923283, 4922.212446008764, 5082.0, 5126.512981266774, 5135.845924622267, 5139.974300128475, 4842.0873754865925, 4856.150173719656, 4865.756712164449, 4865.854024379274, 4918.213085906238, 3601.119104716269, 3630.8729194478065, 3678.9080272993388, 3701.444783282529, 3714.1643130295465, 4981.800727970841, 5218.860267290393, 5298.470152984671, 5302.496262855023, 5339.733013349394, 5068.189089745623, 5070.225421102585, 5076.568491678248, 5086.0, 5124.282600436017, 5040.193569028937, 5049.899002019865, 5080.237964305236, 5086.898262034812, 5090.745462726923, 4803.567678908915, 4981.3026176334615, 5005.924911126263, 5007.744965772277, 5156.278121062979, 5016.197408414636, 5124.692518448905, 5270.420253772006, 5285.947140528546, 5287.154055351125, 5051.772670229922, 5109.20807274873, 5112.769925353442, 5120.385553733576, 5137.563307118937], "value": 3886.5246812669043, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [797.2466019611467, 805.0741647105827, 807.0718673525445, 819.471440920606, 820.7373640435063, 12196.695082622939, 13032.478700851967, 13213.141145825515, 13231.338433078356, 13263.469461221539, 12783.680407989805, 12841.80737288939, 12841.871581284184, 12842.0, 12858.742825143492, 673.7675501951819, 830.5847076461769, 861.5907443964098, 864.2955990867455, 864.844328020956, 860.6170254236836, 863.8401895649325, 866.2420382165606, 867.2888231650018, 867.8004059066418, 917.8714979902819, 920.3235621817992, 920.6501529418812, 922.4096578189964, 924.4638109896244, 907.2923119966437, 907.469130558624, 908.0284096017264, 909.5088652127843, 910.1671970147307, 671.4359937652347, 672.8082496488478, 673.9056532085463, 674.2684187656399, 675.5777638975641, 12891.677708057374, 12910.483580656763, 12977.480900763958, 12997.415116319693, 12997.675058123528, 12494.81257781134, 12591.118621696485, 12921.418536165802, 13137.474501019948, 13340.466381344735, 10495.790084198274, 10496.317739346994, 10573.629922952736, 10591.0, 10629.309094908805, 3337.2991671748964, 3381.1040074380307, 3455.3953058214965, 3457.2566898116775, 3461.048211741791, 44571.33143002858, 44716.0, 44839.77580112111, 44882.77558612219, 46796.06407871858, 9890.851637225447, 10137.138343240907, 10171.64399246023, 10195.184385249162, 10268.486575671186, 16154.59613509648, 16593.087380194203, 16743.0, 18502.352417665315, 18514.814851851308, 6878.3465570770695, 6949.305069493112, 7012.544184628085, 7022.192447868459, 7177.0, 3640.3629364861044, 3746.6440688134585, 3764.8682296119505, 3833.3674943633987, 3923.2153569286256, 2914.3005678636973, 2987.4323878463456, 3031.621047369079, 3033.514637657964, 3034.0442760530364, 540.7404445866007, 540.8215288954635, 549.2365611799602, 550.180231455137, 556.9498745112959, 581.421485621809, 653.5163978655761, 659.1924892007253, 664.6610228783355, 668.5220067651652, 7745.496542724705, 7946.483478573874, 7998.48009879356, 8159.388045896581, 8212.671493140328, 554.287740253772, 577.1746402644175, 632.7152781248457, 639.9824279395783, 643.4819969924256, 3950.881473555798, 3986.700997425147, 4002.0, 4020.0, 4030.5969403059457, 51049.0, 51233.23150152751, 52211.73894130581, 52279.0, 52575.21137182946, 47198.76400617975, 47237.0, 47423.76288118537, 47433.762831185624, 47842.760786195846, 39074.21851562953, 40152.598474014885, 42397.0, 42824.0, 43526.0, 8513.19124683154, 8560.101189375275, 8650.78373040679, 8737.126287371211, 8817.426867253864, 29035.41929161447, 29228.707712922598, 29502.852485737432, 30580.694193058676, 30703.539446908762, 34675.826620866734, 37427.0, 37528.62242398197, 37577.812110940366, 37777.244455110194, 10754.300970437209, 11074.501647426046, 11120.833187502032, 11193.776124477303, 11316.6039188628, 11632.534698612299, 11789.587364442203, 11894.226875253082, 12256.75486490283, 12349.259044457362, 11293.402517420875, 11684.182107252751, 11717.414129293671, 12119.0, 12161.45273462714, 10433.426161561187, 10642.361458312525, 10692.411917344622, 11021.283616564897, 11135.554577816796, 11469.942650286695, 11518.36648984314, 11593.88406115928, 11647.0, 11664.0, 9337.903193572798, 9952.502374881082, 10054.698359048947, 10173.949130254598, 10204.897951020395, 9684.612615495302, 10000.99850224663, 10017.749556261151, 10098.798024039625, 10303.742406439898], "value": 6163.650844928951, "unit": "score"}], "name": "dromaeo_css", "value": 6390.6123771238745, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 115.0, 108.0, 112.0, 114.0, 114.0, 106.0, 113.0, 112.0, 113.0], "value": 111.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 133.0, 157.0, 182.0, 135.0, 158.0, 161.0, 134.0, 186.0, 133.0], "value": 153.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 164.0, 165.0, 170.0, 165.0, 164.0, 164.0, 164.0, 162.0, 162.0], "value": 164.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 77.0, 171.0, 80.0, 77.0, 78.0, 75.0, 168.0, 77.0], "value": 95.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 148.0, 93.0, 94.0, 95.0, 152.0, 93.0, 92.0, 148.0], "value": 110.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 118.0, 117.0, 117.0, 117.0, 118.0, 117.0, 117.0], "value": 117.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 148.0, 147.0, 147.0, 148.0, 147.0, 147.0, 148.0, 147.0], "value": 147.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 96.0, 96.0, 95.0, 96.0, 96.0, 96.0, 96.0, 95.0], "value": 95.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 66.0, 66.0, 66.0, 67.0, 66.0, 82.0, 65.0, 64.0], "value": 67.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 64.0, 64.0, 64.0, 64.0, 65.0, 64.0, 65.0, 64.0], "value": 64.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 85.0, 90.0, 84.0, 82.0, 89.0, 85.0, 83.0, 85.0, 83.0], "value": 84.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 133.0, 138.0, 136.0, 134.0, 137.0, 140.0, 140.0, 223.0, 141.0], "value": 146.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 175.0, 174.0, 184.0, 176.0, 171.0, 174.0, 172.0, 174.0, 171.0], "value": 174.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 68.0, 67.0, 67.0, 68.0, 67.0, 72.0, 73.0, 66.0, 66.0], "value": 68.3, "unit": "score"}], "name": "kraken", "value": 1601.1000000000001, "alertThreshold": 2.0}]} 15:45:10 INFO - Return code: 0 15:45:10 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 15:45:10 ERROR - # TBPL SUCCESS # 15:45:10 INFO - Running post-action listener: _resource_record_post_action 15:45:10 INFO - ##### 15:45:10 INFO - ##### Finished run-tests step (success) 15:45:10 INFO - ##### 15:45:10 INFO - Running post-run listener: _resource_record_post_run 15:45:11 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 0; Write bytes: 530067456; Read time: 0; Write time: 433448 15:45:11 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 246272000; Read time: 0; Write time: 246972 15:45:11 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 0; Write bytes: 283795456; Read time: 0; Write time: 186476 15:45:11 INFO - Running post-run listener: _upload_blobber_files 15:45:11 INFO - Blob upload gear active. 15:45:11 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:45:11 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 15:45:11 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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 15:45:11 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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 15:45:11 INFO - (blobuploader) - INFO - Open directory for files ... 15:45:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 15:45:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:45:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:45:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 15:45:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:45:12 INFO - (blobuploader) - INFO - Done attempting. 15:45:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 15:45:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:45:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:45:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 15:45:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:45:13 INFO - (blobuploader) - INFO - Done attempting. 15:45:13 INFO - (blobuploader) - INFO - Iteration through files over. 15:45:13 INFO - Return code: 0 15:45:13 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:45:13 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:45:13 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/20708d8250a38f7bd527740a9df3c1bb13f9adf414b79d64c07ce7583c1fed5c33b93cbd3df5fa9fe886d33149bc73976409c1c1c129ecf46a265eda78915ee2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/056340c8c021960e21b7912bbe4727382a06809100a7aeec11060e1bd841c58451ecbf06e91afe8fa5c3554dccaba68c20947aada5f9a03db180ac2990c282b0"} 15:45:13 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:45:13 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:45:13 INFO - Contents: 15:45:13 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/20708d8250a38f7bd527740a9df3c1bb13f9adf414b79d64c07ce7583c1fed5c33b93cbd3df5fa9fe886d33149bc73976409c1c1c129ecf46a265eda78915ee2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/056340c8c021960e21b7912bbe4727382a06809100a7aeec11060e1bd841c58451ecbf06e91afe8fa5c3554dccaba68c20947aada5f9a03db180ac2990c282b0"} 15:45:13 INFO - Running post-run listener: copy_logs_to_upload_dir 15:45:13 INFO - Copying logs to upload dir... 15:45:13 INFO - mkdir: /builds/slave/test/build/upload/logs 15:45:13 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1242.569200 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-05-06 15:45:13.378030) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-06 15:45:13.381248) ========= 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=82e07478c745e68b1fe4678a000001bc-1462573450.988758-2105385975 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/20708d8250a38f7bd527740a9df3c1bb13f9adf414b79d64c07ce7583c1fed5c33b93cbd3df5fa9fe886d33149bc73976409c1c1c129ecf46a265eda78915ee2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/056340c8c021960e21b7912bbe4727382a06809100a7aeec11060e1bd841c58451ecbf06e91afe8fa5c3554dccaba68c20947aada5f9a03db180ac2990c282b0"} build_url:https://queue.taskcluster.net/v1/task/aQR-sNOyTxaUBvB5rHkzTg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011100 build_url: 'https://queue.taskcluster.net/v1/task/aQR-sNOyTxaUBvB5rHkzTg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/20708d8250a38f7bd527740a9df3c1bb13f9adf414b79d64c07ce7583c1fed5c33b93cbd3df5fa9fe886d33149bc73976409c1c1c129ecf46a265eda78915ee2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/056340c8c021960e21b7912bbe4727382a06809100a7aeec11060e1bd841c58451ecbf06e91afe8fa5c3554dccaba68c20947aada5f9a03db180ac2990c282b0"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-06 15:45:13.409274) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 15:45:13.409912) ========= 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=82e07478c745e68b1fe4678a000001bc-1462573450.988758-2105385975 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004419 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 15:45:13.494067) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-06 15:45:13.494635) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-06 15:45:13.495214) ========= ========= Total master_lag: 0.19 =========