builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-016 starttime: 1461598450.22 results: success (0) buildid: 20160425053010 builduid: 1b284a2026d343f4891652ac0f793136 revision: 2e75a8ab94a9331d0f84a4a6edb13a7843e904e8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-25 08:34:10.217542) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-25 08:34:10.218459) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-25 08:34:10.219080) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-25 08:34:10.236883) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 08:34:10.237528) ========= 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=00204705a9daa57ed339a427000001b9-1461598365.783314-952467937 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-25 08:34:10-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.3M=0s 2016-04-25 08:34:10 (46.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.213935 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 08:34:10.466779) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 08:34:10.467146) ========= 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=00204705a9daa57ed339a427000001b9-1461598365.783314-952467937 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018733 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 08:34:10.517269) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 08:34:10.517744) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 2e75a8ab94a9331d0f84a4a6edb13a7843e904e8 --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 2e75a8ab94a9331d0f84a4a6edb13a7843e904e8 --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=00204705a9daa57ed339a427000001b9-1461598365.783314-952467937 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-25 08:34:10,625 truncating revision to first 12 chars 2016-04-25 08:34:10,625 Setting DEBUG logging. 2016-04-25 08:34:10,625 attempt 1/10 2016-04-25 08:34:10,625 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/2e75a8ab94a9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-25 08:34:11,323 unpacking tar archive at: fx-team-2e75a8ab94a9/testing/mozharness/ program finished with exit code 0 elapsedTime=0.973518 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 08:34:11.504889) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-25 08:34:11.505265) ========= script_repo_revision: 2e75a8ab94a9331d0f84a4a6edb13a7843e904e8 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-25 08:34:11.505705) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-25 08:34:11.506019) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-25 08:34:11.516504) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 27 secs) (at 2016-04-25 08:34:11.516825) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=00204705a9daa57ed339a427000001b9-1461598365.783314-952467937 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:34:11 INFO - MultiFileLogger online at 20160425 08:34:11 in /builds/slave/test 08:34:11 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 08:34:11 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:34:11 INFO - {'append_to_log': False, 08:34:11 INFO - 'base_work_dir': '/builds/slave/test', 08:34:11 INFO - 'blob_upload_branch': 'Fx-Team', 08:34:11 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:34:11 INFO - 'branch': 'Fx-Team', 08:34:11 INFO - 'buildbot_json_path': 'buildprops.json', 08:34:11 INFO - 'config_files': ('talos/linux_config.py',), 08:34:11 INFO - 'default_actions': ('clobber', 08:34:11 INFO - 'read-buildbot-config', 08:34:11 INFO - 'download-and-extract', 08:34:11 INFO - 'populate-webroot', 08:34:11 INFO - 'create-virtualenv', 08:34:11 INFO - 'install', 08:34:11 INFO - 'run-tests'), 08:34:11 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:34:11 INFO - 'download_minidump_stackwalk': True, 08:34:11 INFO - 'download_symbols': 'ondemand', 08:34:11 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:34:11 INFO - 'tooltool.py': '/tools/tooltool.py', 08:34:11 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:34:11 INFO - '/tools/misc-python/virtualenv.py')}, 08:34:11 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:34:11 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:34:11 INFO - 'installer_path': 'installer.exe', 08:34:11 INFO - 'log_level': 'info', 08:34:11 INFO - 'log_name': 'talos', 08:34:11 INFO - 'log_to_console': True, 08:34:11 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:34:11 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:34:11 INFO - 'opt_config_files': (), 08:34:11 INFO - 'pip_index': False, 08:34:11 INFO - 'sps_profile': False, 08:34:11 INFO - 'sps_profile_interval': 0, 08:34:11 INFO - 'suite': 'dromaeojs-e10s', 08:34:11 INFO - 'system_bits': '32', 08:34:11 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:34:11 INFO - 'title': 'talos-linux64-ix-016', 08:34:11 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:34:11 INFO - 'use_talos_json': True, 08:34:11 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:34:11 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:34:11 INFO - 'work_dir': 'build'} 08:34:11 INFO - ##### 08:34:11 INFO - ##### Running clobber step. 08:34:11 INFO - ##### 08:34:11 INFO - Running pre-action listener: _resource_record_pre_action 08:34:11 INFO - Running main action method: clobber 08:34:11 INFO - rmtree: /builds/slave/test/build 08:34:11 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:34:12 INFO - Running post-action listener: _resource_record_post_action 08:34:12 INFO - ##### 08:34:12 INFO - ##### Running read-buildbot-config step. 08:34:12 INFO - ##### 08:34:12 INFO - Running pre-action listener: _resource_record_pre_action 08:34:12 INFO - Running main action method: read_buildbot_config 08:34:12 INFO - Using buildbot properties: 08:34:12 INFO - { 08:34:12 INFO - "project": "", 08:34:12 INFO - "product": "firefox", 08:34:12 INFO - "script_repo_revision": "production", 08:34:12 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 08:34:12 INFO - "repository": "", 08:34:12 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 08:34:12 INFO - "buildid": "20160425053010", 08:34:12 INFO - "pgo_build": "True", 08:34:12 INFO - "basedir": "/builds/slave/test", 08:34:12 INFO - "buildnumber": 413, 08:34:12 INFO - "slavename": "talos-linux64-ix-016", 08:34:12 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 08:34:12 INFO - "platform": "ubuntu64_hw", 08:34:12 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 08:34:12 INFO - "branch": "fx-team", 08:34:12 INFO - "repo_path": "integration/fx-team", 08:34:12 INFO - "revision": "2e75a8ab94a9331d0f84a4a6edb13a7843e904e8", 08:34:12 INFO - "stage_platform": "linux64-pgo", 08:34:12 INFO - "builduid": "1b284a2026d343f4891652ac0f793136", 08:34:12 INFO - "slavebuilddir": "test" 08:34:12 INFO - } 08:34:12 INFO - Found installer url https://queue.taskcluster.net/v1/task/M74bwkb4R_e0hzWbKdkNGw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 08:34:12 INFO - Running post-action listener: _resource_record_post_action 08:34:12 INFO - ##### 08:34:12 INFO - ##### Running download-and-extract step. 08:34:12 INFO - ##### 08:34:12 INFO - Running pre-action listener: _resource_record_pre_action 08:34:12 INFO - Running main action method: download_and_extract 08:34:12 INFO - mkdir: /builds/slave/test/build/tests 08:34:12 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')]} 08:34:12 INFO - https://queue.taskcluster.net/v1/task/M74bwkb4R_e0hzWbKdkNGw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 08:34:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M74bwkb4R_e0hzWbKdkNGw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 08:34:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M74bwkb4R_e0hzWbKdkNGw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 08:34:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M74bwkb4R_e0hzWbKdkNGw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 08:34:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M74bwkb4R_e0hzWbKdkNGw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 08:34:13 INFO - Downloaded 1361 bytes. 08:34:13 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 08:34:13 INFO - Using the following test package requirements: 08:34:13 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 08:34:13 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:34:13 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:34:13 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:34:13 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:34:13 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:34:13 INFO - u'jsshell-linux-x86_64.zip'], 08:34:13 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:34:13 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:34:13 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 08:34:13 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:34:13 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:34:13 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:34:13 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:34:13 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:34:13 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:34:13 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:34:13 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:34:13 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:34:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 08:34:13 INFO - https://queue.taskcluster.net/v1/task/M74bwkb4R_e0hzWbKdkNGw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:34:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M74bwkb4R_e0hzWbKdkNGw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 08:34:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M74bwkb4R_e0hzWbKdkNGw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 08:34:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M74bwkb4R_e0hzWbKdkNGw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 08:34:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M74bwkb4R_e0hzWbKdkNGw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:34:14 INFO - Downloaded 23860725 bytes. 08:34:14 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:34:14 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 08:34:15 INFO - Return code: 0 08:34:15 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 08:34:15 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')]} 08:34:15 INFO - https://queue.taskcluster.net/v1/task/M74bwkb4R_e0hzWbKdkNGw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:34:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M74bwkb4R_e0hzWbKdkNGw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 08:34:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M74bwkb4R_e0hzWbKdkNGw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 08:34:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M74bwkb4R_e0hzWbKdkNGw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 08:34:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M74bwkb4R_e0hzWbKdkNGw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:34:17 INFO - Downloaded 23860725 bytes. 08:34:17 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:34:17 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 08:34:18 INFO - Return code: 0 08:34:18 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')]} 08:34:18 INFO - https://queue.taskcluster.net/v1/task/M74bwkb4R_e0hzWbKdkNGw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:34:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M74bwkb4R_e0hzWbKdkNGw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 08:34:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M74bwkb4R_e0hzWbKdkNGw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 08:34:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M74bwkb4R_e0hzWbKdkNGw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 08:34:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M74bwkb4R_e0hzWbKdkNGw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 08:34:19 INFO - Downloaded 10840145 bytes. 08:34:19 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:34:19 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 08:34:19 INFO - Return code: 0 08:34:19 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')]} 08:34:19 INFO - https://queue.taskcluster.net/v1/task/M74bwkb4R_e0hzWbKdkNGw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:34:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M74bwkb4R_e0hzWbKdkNGw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 08:34:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M74bwkb4R_e0hzWbKdkNGw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 08:34:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M74bwkb4R_e0hzWbKdkNGw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 08:34:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M74bwkb4R_e0hzWbKdkNGw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 08:34:21 INFO - Downloaded 58359114 bytes. 08:34:21 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/M74bwkb4R_e0hzWbKdkNGw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 08:34:21 INFO - mkdir: /builds/slave/test/properties 08:34:21 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:34:21 INFO - Writing to file /builds/slave/test/properties/build_url 08:34:21 INFO - Contents: 08:34:21 INFO - build_url:https://queue.taskcluster.net/v1/task/M74bwkb4R_e0hzWbKdkNGw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 08:34:22 INFO - Running post-action listener: _resource_record_post_action 08:34:22 INFO - Running post-action listener: set_extra_try_arguments 08:34:22 INFO - ##### 08:34:22 INFO - ##### Running populate-webroot step. 08:34:22 INFO - ##### 08:34:22 INFO - Running pre-action listener: _resource_record_pre_action 08:34:22 INFO - Running main action method: populate_webroot 08:34:22 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:34:22 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:34:22 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:34:22 INFO - '--tppagecycles', 08:34:22 INFO - '7'], 08:34:22 INFO - 'tests': ['tsvgm']}}, 08:34:22 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:34:22 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:34:22 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:34:22 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:34:22 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:34:22 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:34:22 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:34:22 INFO - 'talos_options': ['--disable-e10s'], 08:34:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:34:22 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:34:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:34:22 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:34:22 INFO - 'talos_options': ['--disable-e10s'], 08:34:22 INFO - 'tests': ['damp', 'tps']}, 08:34:22 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:34:22 INFO - 'tests': ['damp', 'tps']}, 08:34:22 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:34:22 INFO - 'tests': ['dromaeo_dom']}, 08:34:22 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:34:22 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:34:22 INFO - 'tests': ['a11yr', 08:34:22 INFO - 'ts_paint', 08:34:22 INFO - 'tpaint', 08:34:22 INFO - 'sessionrestore', 08:34:22 INFO - 'sessionrestore_no_auto_restore', 08:34:22 INFO - 'tabpaint']}, 08:34:22 INFO - 'other-e10s': {'tests': ['a11yr', 08:34:22 INFO - 'ts_paint', 08:34:22 INFO - 'tpaint', 08:34:22 INFO - 'sessionrestore', 08:34:22 INFO - 'sessionrestore_no_auto_restore', 08:34:22 INFO - 'tabpaint']}, 08:34:22 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:34:22 INFO - 'ts_paint', 08:34:22 INFO - 'tpaint', 08:34:22 INFO - 'sessionrestore', 08:34:22 INFO - 'sessionrestore_no_auto_restore', 08:34:22 INFO - 'tabpaint']}, 08:34:22 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:34:22 INFO - 'ts_paint', 08:34:22 INFO - 'tpaint', 08:34:22 INFO - 'sessionrestore', 08:34:22 INFO - 'sessionrestore_no_auto_restore', 08:34:22 INFO - 'tabpaint']}, 08:34:22 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:34:22 INFO - 'tests': ['a11yr', 08:34:22 INFO - 'ts_paint', 08:34:22 INFO - 'tpaint', 08:34:22 INFO - 'sessionrestore', 08:34:22 INFO - 'sessionrestore_no_auto_restore', 08:34:22 INFO - 'tabpaint']}, 08:34:22 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:34:22 INFO - 'tests': ['a11yr', 08:34:22 INFO - 'ts_paint', 08:34:22 INFO - 'tpaint', 08:34:22 INFO - 'sessionrestore', 08:34:22 INFO - 'sessionrestore_no_auto_restore', 08:34:22 INFO - 'tabpaint']}, 08:34:22 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:34:22 INFO - 'tests': ['tsvgx', 08:34:22 INFO - 'tsvgr_opacity', 08:34:22 INFO - 'tart', 08:34:22 INFO - 'tscrollx', 08:34:22 INFO - 'cart']}, 08:34:22 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:34:22 INFO - 'tsvgr_opacity', 08:34:22 INFO - 'tart', 08:34:22 INFO - 'tscrollx', 08:34:22 INFO - 'cart']}, 08:34:22 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:34:22 INFO - 'talos_options': ['--disable-e10s'], 08:34:22 INFO - 'tests': ['tp5o']}, 08:34:22 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:34:22 INFO - 'tests': ['tp5o']}, 08:34:22 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:34:22 INFO - 'talos_options': ['--disable-e10s', 08:34:22 INFO - '--xperf_path', 08:34:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:34:22 INFO - 'tests': ['tp5n']}, 08:34:22 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:34:22 INFO - 'talos_options': ['--xperf_path', 08:34:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:34:22 INFO - 'tests': ['tp5n']}}, 08:34:22 INFO - 'talos.zip': {'path': '', 08:34:22 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:34:22 INFO - Running post-action listener: _resource_record_post_action 08:34:22 INFO - ##### 08:34:22 INFO - ##### Running create-virtualenv step. 08:34:22 INFO - ##### 08:34:22 INFO - Running pre-action listener: _resource_record_pre_action 08:34:22 INFO - Running main action method: create_virtualenv 08:34:22 INFO - Creating virtualenv /builds/slave/test/build/venv 08:34:22 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 08:34:22 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:34:22 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:34:22 INFO - Using real prefix '/usr' 08:34:22 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:34:22 INFO - Installing distribute.............................................................................................................................................................................................done. 08:34:24 INFO - Installing pip.................done. 08:34:24 INFO - Return code: 0 08:34:24 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:34:24 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')]} 08:34:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:34:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:34:24 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')]} 08:34:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:34:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:34:24 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 0x7eff6e7e4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25e78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26b25a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2741410>, '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 0x2742310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27427a0>, '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': '00204705a9daa57ed339a427000001b9-1461598365.783314-952467937', '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 08:34:24 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 08:34:24 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 08:34:24 INFO - Using env: {'DISPLAY': ':0', 08:34:24 INFO - 'HOME': '/home/cltbld', 08:34:24 INFO - 'LANG': 'en_US.UTF-8', 08:34:24 INFO - 'LANGUAGE': 'en_US:en', 08:34:24 INFO - 'LOGNAME': 'cltbld', 08:34:24 INFO - 'MAIL': '/var/mail/cltbld', 08:34:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:34:24 INFO - 'MOZ_NO_REMOTE': '1', 08:34:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:34:24 INFO - 'NO_EM_RESTART': '1', 08:34:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:34:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:34:24 INFO - 'PWD': '/builds/slave/test', 08:34:24 INFO - 'SHELL': '/bin/bash', 08:34:24 INFO - 'SHLVL': '1', 08:34:24 INFO - 'TERM': 'linux', 08:34:24 INFO - 'TMOUT': '86400', 08:34:24 INFO - 'USER': 'cltbld', 08:34:24 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1461598365.783314-952467937', 08:34:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:34:24 INFO - '_': '/tools/buildbot/bin/python'} 08:34:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:34:24 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 08:34:24 INFO - Cleaning up... 08:34:24 INFO - Return code: 0 08:34:24 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 08:34:24 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')]} 08:34:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:34:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:34:24 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')]} 08:34:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:34:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:34:24 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 0x7eff6e7e4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25e78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26b25a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2741410>, '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 0x2742310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27427a0>, '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': '00204705a9daa57ed339a427000001b9-1461598365.783314-952467937', '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 08:34:24 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 08:34:24 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 08:34:24 INFO - Using env: {'DISPLAY': ':0', 08:34:24 INFO - 'HOME': '/home/cltbld', 08:34:24 INFO - 'LANG': 'en_US.UTF-8', 08:34:24 INFO - 'LANGUAGE': 'en_US:en', 08:34:24 INFO - 'LOGNAME': 'cltbld', 08:34:24 INFO - 'MAIL': '/var/mail/cltbld', 08:34:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:34:24 INFO - 'MOZ_NO_REMOTE': '1', 08:34:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:34:24 INFO - 'NO_EM_RESTART': '1', 08:34:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:34:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:34:24 INFO - 'PWD': '/builds/slave/test', 08:34:24 INFO - 'SHELL': '/bin/bash', 08:34:24 INFO - 'SHLVL': '1', 08:34:24 INFO - 'TERM': 'linux', 08:34:24 INFO - 'TMOUT': '86400', 08:34:24 INFO - 'USER': 'cltbld', 08:34:24 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1461598365.783314-952467937', 08:34:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:34:24 INFO - '_': '/tools/buildbot/bin/python'} 08:34:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:34:25 INFO - Downloading/unpacking psutil>=0.7.1 08:34:25 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 08:34:25 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 08:34:25 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 08:34:25 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 08:34:25 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 08:34:25 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 08:34:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:34:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:34:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:34:27 INFO - Installing collected packages: psutil 08:34:27 INFO - Running setup.py install for psutil 08:34:27 INFO - building 'psutil._psutil_linux' extension 08:34:27 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 08:34:27 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 08:34:27 INFO - building 'psutil._psutil_posix' extension 08:34:27 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 08:34:27 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 08:34:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:34:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:34:27 INFO - Successfully installed psutil 08:34:27 INFO - Cleaning up... 08:34:27 INFO - Return code: 0 08:34:27 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 08:34:27 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')]} 08:34:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:34:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:34:27 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')]} 08:34:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:34:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:34:27 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 0x7eff6e7e4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25e78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26b25a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2741410>, '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 0x2742310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27427a0>, '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': '00204705a9daa57ed339a427000001b9-1461598365.783314-952467937', '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 08:34:27 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 08:34:27 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 08:34:27 INFO - Using env: {'DISPLAY': ':0', 08:34:27 INFO - 'HOME': '/home/cltbld', 08:34:27 INFO - 'LANG': 'en_US.UTF-8', 08:34:27 INFO - 'LANGUAGE': 'en_US:en', 08:34:27 INFO - 'LOGNAME': 'cltbld', 08:34:27 INFO - 'MAIL': '/var/mail/cltbld', 08:34:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:34:27 INFO - 'MOZ_NO_REMOTE': '1', 08:34:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:34:27 INFO - 'NO_EM_RESTART': '1', 08:34:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:34:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:34:27 INFO - 'PWD': '/builds/slave/test', 08:34:27 INFO - 'SHELL': '/bin/bash', 08:34:27 INFO - 'SHLVL': '1', 08:34:27 INFO - 'TERM': 'linux', 08:34:27 INFO - 'TMOUT': '86400', 08:34:27 INFO - 'USER': 'cltbld', 08:34:27 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1461598365.783314-952467937', 08:34:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:34:27 INFO - '_': '/tools/buildbot/bin/python'} 08:34:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:34:27 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 08:34:27 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 08:34:27 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 08:34:27 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 08:34:27 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 08:34:27 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 08:34:27 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 08:34:29 INFO - Downloading mozsystemmonitor-0.0.tar.gz 08:34:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:34:29 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 08:34:29 INFO - Installing collected packages: mozsystemmonitor 08:34:29 INFO - Running setup.py install for mozsystemmonitor 08:34:29 INFO - Successfully installed mozsystemmonitor 08:34:29 INFO - Cleaning up... 08:34:29 INFO - Return code: 0 08:34:29 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:34: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')]} 08:34:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:34:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:34: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')]} 08:34:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:34:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:34:29 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 0x7eff6e7e4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25e78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26b25a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2741410>, '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 0x2742310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27427a0>, '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': '00204705a9daa57ed339a427000001b9-1461598365.783314-952467937', '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 08:34:29 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 08:34:29 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 08:34:29 INFO - Using env: {'DISPLAY': ':0', 08:34:29 INFO - 'HOME': '/home/cltbld', 08:34:29 INFO - 'LANG': 'en_US.UTF-8', 08:34:29 INFO - 'LANGUAGE': 'en_US:en', 08:34:29 INFO - 'LOGNAME': 'cltbld', 08:34:29 INFO - 'MAIL': '/var/mail/cltbld', 08:34:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:34:29 INFO - 'MOZ_NO_REMOTE': '1', 08:34:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:34:29 INFO - 'NO_EM_RESTART': '1', 08:34:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:34:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:34:29 INFO - 'PWD': '/builds/slave/test', 08:34:29 INFO - 'SHELL': '/bin/bash', 08:34:29 INFO - 'SHLVL': '1', 08:34:29 INFO - 'TERM': 'linux', 08:34:29 INFO - 'TMOUT': '86400', 08:34:29 INFO - 'USER': 'cltbld', 08:34:29 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1461598365.783314-952467937', 08:34:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:34:29 INFO - '_': '/tools/buildbot/bin/python'} 08:34:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:34:30 INFO - Downloading/unpacking blobuploader==1.2.4 08:34:30 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 08:34:30 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 08:34:30 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 08:34:30 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 08:34:30 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 08:34:30 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 08:34:31 INFO - Downloading blobuploader-1.2.4.tar.gz 08:34:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:34:32 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:34:32 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 08:34:32 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 08:34:32 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 08:34:32 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 08:34:32 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 08:34:32 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 08:34:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:34:32 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:34:32 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 08:34:32 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 08:34:32 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 08:34:32 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 08:34:32 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 08:34:32 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 08:34:32 INFO - Downloading docopt-0.6.1.tar.gz 08:34:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:34:32 INFO - Installing collected packages: blobuploader, requests, docopt 08:34:32 INFO - Running setup.py install for blobuploader 08:34:32 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:34:32 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:34:32 INFO - Running setup.py install for requests 08:34:33 INFO - Running setup.py install for docopt 08:34:33 INFO - Successfully installed blobuploader requests docopt 08:34:33 INFO - Cleaning up... 08:34:33 INFO - Return code: 0 08:34:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:34:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 08:34:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:34:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:34:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 08:34:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:34:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:34:33 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 0x7eff6e7e4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25e78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26b25a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2741410>, '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 0x2742310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27427a0>, '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': '00204705a9daa57ed339a427000001b9-1461598365.783314-952467937', '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 08:34:33 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 08:34:33 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 08:34:33 INFO - Using env: {'DISPLAY': ':0', 08:34:33 INFO - 'HOME': '/home/cltbld', 08:34:33 INFO - 'LANG': 'en_US.UTF-8', 08:34:33 INFO - 'LANGUAGE': 'en_US:en', 08:34:33 INFO - 'LOGNAME': 'cltbld', 08:34:33 INFO - 'MAIL': '/var/mail/cltbld', 08:34:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:34:33 INFO - 'MOZ_NO_REMOTE': '1', 08:34:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:34:33 INFO - 'NO_EM_RESTART': '1', 08:34:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:34:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:34:33 INFO - 'PWD': '/builds/slave/test', 08:34:33 INFO - 'SHELL': '/bin/bash', 08:34:33 INFO - 'SHLVL': '1', 08:34:33 INFO - 'TERM': 'linux', 08:34:33 INFO - 'TMOUT': '86400', 08:34:33 INFO - 'USER': 'cltbld', 08:34:33 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1461598365.783314-952467937', 08:34:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:34:33 INFO - '_': '/tools/buildbot/bin/python'} 08:34:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:34:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:34:33 INFO - Running setup.py (path:/tmp/pip-F_TAer-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:34:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:34:33 INFO - Running setup.py (path:/tmp/pip-Ma4TR3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:34:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:34:33 INFO - Running setup.py (path:/tmp/pip-FKZl63-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:34:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:34:33 INFO - Running setup.py (path:/tmp/pip-vMBPP8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:34:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:34:33 INFO - Running setup.py (path:/tmp/pip-DRPh94-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:34:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:34:33 INFO - Running setup.py (path:/tmp/pip-pQNmmo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:34:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:34:33 INFO - Running setup.py (path:/tmp/pip-HZnWg5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:34:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:34:34 INFO - Running setup.py (path:/tmp/pip-6Lp9Qh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:34:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:34:34 INFO - Running setup.py (path:/tmp/pip-1F4G0L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:34:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:34:34 INFO - Running setup.py (path:/tmp/pip-GwiMus-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:34:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:34:34 INFO - Running setup.py (path:/tmp/pip-AuRpZ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:34:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:34:34 INFO - Running setup.py (path:/tmp/pip-j9qVDx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:34:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:34:34 INFO - Running setup.py (path:/tmp/pip-dTzqcC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:34:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:34:34 INFO - Running setup.py (path:/tmp/pip-gBU1bY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:34:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:34:34 INFO - Running setup.py (path:/tmp/pip-ubC5xp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:34:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:34:34 INFO - Running setup.py (path:/tmp/pip-cJI7Le-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:34:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:34:34 INFO - Running setup.py (path:/tmp/pip-jVUS4r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:34:34 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:34:34 INFO - Running setup.py install for manifestparser 08:34:34 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:34:34 INFO - Running setup.py install for mozcrash 08:34:34 INFO - Running setup.py install for mozdebug 08:34:35 INFO - Running setup.py install for mozdevice 08:34:35 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:34:35 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:34:35 INFO - Running setup.py install for mozfile 08:34:35 INFO - Running setup.py install for mozhttpd 08:34:35 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:34:35 INFO - Running setup.py install for mozinfo 08:34:35 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:34:35 INFO - Running setup.py install for mozInstall 08:34:35 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:34:35 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:34:35 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:34:35 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:34:35 INFO - Running setup.py install for mozleak 08:34:35 INFO - Running setup.py install for mozlog 08:34:35 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:34:35 INFO - Running setup.py install for moznetwork 08:34:35 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:34:35 INFO - Running setup.py install for mozprocess 08:34:36 INFO - Running setup.py install for mozprofile 08:34:36 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:34:36 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:34:36 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:34:36 INFO - Running setup.py install for mozrunner 08:34:36 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:34:36 INFO - Running setup.py install for mozscreenshot 08:34:36 INFO - Running setup.py install for moztest 08:34:36 INFO - Running setup.py install for mozversion 08:34:36 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:34:36 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:34:36 INFO - Cleaning up... 08:34:36 INFO - Return code: 0 08:34:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:34:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 08:34:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:34:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:34:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 08:34:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:34:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:34:36 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 0x7eff6e7e4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25e78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26b25a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2741410>, '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 0x2742310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27427a0>, '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': '00204705a9daa57ed339a427000001b9-1461598365.783314-952467937', '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 08:34:36 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 08:34:36 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 08:34:36 INFO - Using env: {'DISPLAY': ':0', 08:34:36 INFO - 'HOME': '/home/cltbld', 08:34:36 INFO - 'LANG': 'en_US.UTF-8', 08:34:36 INFO - 'LANGUAGE': 'en_US:en', 08:34:36 INFO - 'LOGNAME': 'cltbld', 08:34:36 INFO - 'MAIL': '/var/mail/cltbld', 08:34:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:34:36 INFO - 'MOZ_NO_REMOTE': '1', 08:34:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:34:36 INFO - 'NO_EM_RESTART': '1', 08:34:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:34:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:34:36 INFO - 'PWD': '/builds/slave/test', 08:34:36 INFO - 'SHELL': '/bin/bash', 08:34:36 INFO - 'SHLVL': '1', 08:34:36 INFO - 'TERM': 'linux', 08:34:36 INFO - 'TMOUT': '86400', 08:34:36 INFO - 'USER': 'cltbld', 08:34:36 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1461598365.783314-952467937', 08:34:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:34:36 INFO - '_': '/tools/buildbot/bin/python'} 08:34:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:34:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:34:36 INFO - Running setup.py (path:/tmp/pip-vsWL1j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:34:36 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)) 08:34:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:34:36 INFO - Running setup.py (path:/tmp/pip-oKvyfs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:34:36 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)) 08:34:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:34:36 INFO - Running setup.py (path:/tmp/pip-Li7zBM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:34:37 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)) 08:34:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:34:37 INFO - Running setup.py (path:/tmp/pip-qNrSCz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:34:37 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)) 08:34:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:34:37 INFO - Running setup.py (path:/tmp/pip-D8JXhV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:34:37 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)) 08:34:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:34:37 INFO - Running setup.py (path:/tmp/pip-v7jkbk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:34:37 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)) 08:34:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:34:37 INFO - Running setup.py (path:/tmp/pip-QdihDQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:34:37 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)) 08:34:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:34:37 INFO - Running setup.py (path:/tmp/pip-aQIuW6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:34:37 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)) 08:34:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:34:37 INFO - Running setup.py (path:/tmp/pip-ALsFhT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:34:37 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)) 08:34:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:34:37 INFO - Running setup.py (path:/tmp/pip-PVZOu2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:34:37 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)) 08:34:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:34:37 INFO - Running setup.py (path:/tmp/pip-VLmP8F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:34:37 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)) 08:34:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:34:37 INFO - Running setup.py (path:/tmp/pip-37h0q2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:34:37 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)) 08:34:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:34:37 INFO - Running setup.py (path:/tmp/pip-cfHEIO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:34:37 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)) 08:34:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:34:37 INFO - Running setup.py (path:/tmp/pip-Y7B5hl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:34:37 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)) 08:34:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:34:37 INFO - Running setup.py (path:/tmp/pip-2x78Sg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:34:37 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)) 08:34:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:34:37 INFO - Running setup.py (path:/tmp/pip-uQkRYf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:34:37 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)) 08:34:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:34:37 INFO - Running setup.py (path:/tmp/pip-HYO6hM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:34:38 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)) 08:34:38 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)) 08:34:38 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)) 08:34:38 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)) 08:34:38 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)) 08:34:38 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)) 08:34:38 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:34:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:34:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:34:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:34:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:34:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:34:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:34:39 INFO - Downloading blessings-1.6.tar.gz 08:34:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:34:39 INFO - Installing collected packages: blessings 08:34:39 INFO - Running setup.py install for blessings 08:34:40 INFO - Successfully installed blessings 08:34:40 INFO - Cleaning up... 08:34:40 INFO - Return code: 0 08:34:40 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:34:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:34:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:34:40 INFO - Reading from file tmpfile_stdout 08:34:40 INFO - Current package versions: 08:34:40 INFO - argparse == 1.2.1 08:34:40 INFO - blessings == 1.6 08:34:40 INFO - blobuploader == 1.2.4 08:34:40 INFO - docopt == 0.6.1 08:34:40 INFO - manifestparser == 1.1 08:34:40 INFO - mozInstall == 1.12 08:34:40 INFO - mozcrash == 0.17 08:34:40 INFO - mozdebug == 0.1 08:34:40 INFO - mozdevice == 0.48 08:34:40 INFO - mozfile == 1.2 08:34:40 INFO - mozhttpd == 0.7 08:34:40 INFO - mozinfo == 0.9 08:34:40 INFO - mozleak == 0.1 08:34:40 INFO - mozlog == 3.1 08:34:40 INFO - moznetwork == 0.27 08:34:40 INFO - mozprocess == 0.22 08:34:40 INFO - mozprofile == 0.28 08:34:40 INFO - mozrunner == 6.11 08:34:40 INFO - mozscreenshot == 0.1 08:34:40 INFO - mozsystemmonitor == 0.0 08:34:40 INFO - moztest == 0.7 08:34:40 INFO - mozversion == 1.4 08:34:40 INFO - psutil == 3.1.1 08:34:40 INFO - requests == 1.2.3 08:34:40 INFO - wsgiref == 0.1.2 08:34:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:34:40 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')]} 08:34:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:34:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:34:40 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')]} 08:34:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:34:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:34:40 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 0x7eff6e7e4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25e78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26b25a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2741410>, '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 0x2742310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27427a0>, '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': '00204705a9daa57ed339a427000001b9-1461598365.783314-952467937', '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 08:34:40 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 08:34:40 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 08:34:40 INFO - Using env: {'DISPLAY': ':0', 08:34:40 INFO - 'HOME': '/home/cltbld', 08:34:40 INFO - 'LANG': 'en_US.UTF-8', 08:34:40 INFO - 'LANGUAGE': 'en_US:en', 08:34:40 INFO - 'LOGNAME': 'cltbld', 08:34:40 INFO - 'MAIL': '/var/mail/cltbld', 08:34:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:34:40 INFO - 'MOZ_NO_REMOTE': '1', 08:34:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:34:40 INFO - 'NO_EM_RESTART': '1', 08:34:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:34:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:34:40 INFO - 'PWD': '/builds/slave/test', 08:34:40 INFO - 'SHELL': '/bin/bash', 08:34:40 INFO - 'SHLVL': '1', 08:34:40 INFO - 'TERM': 'linux', 08:34:40 INFO - 'TMOUT': '86400', 08:34:40 INFO - 'USER': 'cltbld', 08:34:40 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1461598365.783314-952467937', 08:34:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:34:40 INFO - '_': '/tools/buildbot/bin/python'} 08:34:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:34:40 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)) 08:34:40 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)) 08:34:40 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)) 08:34:40 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)) 08:34:40 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)) 08:34:40 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)) 08:34:40 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)) 08:34:40 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)) 08:34:40 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)) 08:34:40 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)) 08:34:40 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)) 08:34:40 INFO - Cleaning up... 08:34:40 INFO - Return code: 0 08:34:40 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:34:40 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')]} 08:34:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:34:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:34:40 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')]} 08:34:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:34:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:34:40 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 0x7eff6e7e4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25e78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26b25a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2741410>, '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 0x2742310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27427a0>, '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': '00204705a9daa57ed339a427000001b9-1461598365.783314-952467937', '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 08:34:40 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 08:34:40 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 08:34:40 INFO - Using env: {'DISPLAY': ':0', 08:34:40 INFO - 'HOME': '/home/cltbld', 08:34:40 INFO - 'LANG': 'en_US.UTF-8', 08:34:40 INFO - 'LANGUAGE': 'en_US:en', 08:34:40 INFO - 'LOGNAME': 'cltbld', 08:34:40 INFO - 'MAIL': '/var/mail/cltbld', 08:34:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:34:40 INFO - 'MOZ_NO_REMOTE': '1', 08:34:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:34:40 INFO - 'NO_EM_RESTART': '1', 08:34:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:34:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:34:40 INFO - 'PWD': '/builds/slave/test', 08:34:40 INFO - 'SHELL': '/bin/bash', 08:34:40 INFO - 'SHLVL': '1', 08:34:40 INFO - 'TERM': 'linux', 08:34:40 INFO - 'TMOUT': '86400', 08:34:40 INFO - 'USER': 'cltbld', 08:34:40 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1461598365.783314-952467937', 08:34:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:34:40 INFO - '_': '/tools/buildbot/bin/python'} 08:34:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:34:40 INFO - Downloading/unpacking jsonschema 08:34:40 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 08:34:40 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 08:34:40 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 08:34:40 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 08:34:40 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 08:34:40 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 08:34:42 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:34:42 INFO - Downloading/unpacking functools32 (from jsonschema) 08:34:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:34:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:34:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:34:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:34:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:34:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:34:42 INFO - Downloading functools32-3.2.3-2.tar.gz 08:34:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:34:42 INFO - warning: no files found matching '*.txt' 08:34:42 INFO - no previously-included directories found matching 'build' 08:34:42 INFO - no previously-included directories found matching 'dist' 08:34:42 INFO - no previously-included directories found matching '.git*' 08:34:42 INFO - Installing collected packages: jsonschema, functools32 08:34:42 INFO - Running setup.py install for functools32 08:34:43 INFO - warning: no files found matching '*.txt' 08:34:43 INFO - no previously-included directories found matching 'build' 08:34:43 INFO - no previously-included directories found matching 'dist' 08:34:43 INFO - no previously-included directories found matching '.git*' 08:34:43 INFO - Successfully installed jsonschema functools32 08:34:43 INFO - Cleaning up... 08:34:43 INFO - Return code: 0 08:34:43 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 08:34:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 08:34:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:34:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:34:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 08:34:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:34:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:34:43 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 0x7eff6e7e4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25e78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26b25a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2741410>, '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 0x2742310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27427a0>, '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': '00204705a9daa57ed339a427000001b9-1461598365.783314-952467937', '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 08:34:43 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 08:34:43 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 08:34:43 INFO - Using env: {'DISPLAY': ':0', 08:34:43 INFO - 'HOME': '/home/cltbld', 08:34:43 INFO - 'LANG': 'en_US.UTF-8', 08:34:43 INFO - 'LANGUAGE': 'en_US:en', 08:34:43 INFO - 'LOGNAME': 'cltbld', 08:34:43 INFO - 'MAIL': '/var/mail/cltbld', 08:34:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:34:43 INFO - 'MOZ_NO_REMOTE': '1', 08:34:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:34:43 INFO - 'NO_EM_RESTART': '1', 08:34:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:34:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:34:43 INFO - 'PWD': '/builds/slave/test', 08:34:43 INFO - 'SHELL': '/bin/bash', 08:34:43 INFO - 'SHLVL': '1', 08:34:43 INFO - 'TERM': 'linux', 08:34:43 INFO - 'TMOUT': '86400', 08:34:43 INFO - 'USER': 'cltbld', 08:34:43 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1461598365.783314-952467937', 08:34:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:34:43 INFO - '_': '/tools/buildbot/bin/python'} 08:34:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:34:43 INFO - Downloading/unpacking flake8 08:34:43 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 08:34:43 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 08:34:43 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 08:34:43 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 08:34:43 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 08:34:43 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 08:34:45 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:34:45 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:34:45 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 08:34:45 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 08:34:45 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 08:34:45 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 08:34:45 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 08:34:45 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 08:34:45 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:34:45 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:34:45 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 08:34:45 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 08:34:45 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 08:34:45 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 08:34:45 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 08:34:45 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 08:34:45 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:34:45 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 08:34:45 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 08:34:45 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 08:34:45 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 08:34:45 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 08:34:45 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 08:34:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 08:34:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:34:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:34:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:34:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:34:45 INFO - no previously-included directories found matching 'docs/_build' 08:34:45 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:34:45 INFO - Running setup.py install for pep8 08:34:46 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:34:46 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:34:46 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:34:46 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:34:46 INFO - no previously-included directories found matching 'docs/_build' 08:34:46 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 08:34:46 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:34:46 INFO - Cleaning up... 08:34:46 INFO - Return code: 0 08:34:46 INFO - Running post-action listener: _resource_record_post_action 08:34:46 INFO - Running post-action listener: _start_resource_monitoring 08:34:46 INFO - Starting resource monitoring. 08:34:46 INFO - ##### 08:34:46 INFO - ##### Running install step. 08:34:46 INFO - ##### 08:34:46 INFO - Running pre-action listener: _resource_record_pre_action 08:34:46 INFO - Running main action method: install 08:34:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:34:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:34:46 INFO - Reading from file tmpfile_stdout 08:34:46 INFO - Detecting whether we're running mozinstall >=1.0... 08:34:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:34:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:34:46 INFO - Reading from file tmpfile_stdout 08:34:46 INFO - Output received: 08:34:46 INFO - Usage: mozinstall [options] installer 08:34:46 INFO - Options: 08:34:46 INFO - -h, --help show this help message and exit 08:34:46 INFO - -d DEST, --destination=DEST 08:34:46 INFO - Directory to install application into. [default: 08:34:46 INFO - "/builds/slave/test"] 08:34:46 INFO - --app=APP Application being installed. [default: firefox] 08:34:46 INFO - mkdir: /builds/slave/test/build/application 08:34:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 08:34:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 08:35:03 INFO - Reading from file tmpfile_stdout 08:35:03 INFO - Output received: 08:35:03 INFO - /builds/slave/test/build/application/firefox/firefox 08:35:03 INFO - Running post-action listener: _resource_record_post_action 08:35:03 INFO - ##### 08:35:03 INFO - ##### Running run-tests step. 08:35:03 INFO - ##### 08:35:03 INFO - Running pre-action listener: _resource_record_pre_action 08:35:03 INFO - Running main action method: run_tests 08:35:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:35:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:35:03 INFO - Python 2.7.3 08:35:03 INFO - Return code: 0 08:35:03 INFO - grabbing minidump binary from tooltool 08:35:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 08:35:03 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 0x2741410>, '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 0x2742310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27427a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:35:03 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 08:35:03 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 08:35:03 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:35:03 INFO - Return code: 0 08:35:03 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:35:03 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:35:03 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:35:03 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:35:03 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:35:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 08:35:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 08:35:04 INFO - Return code: 0 08:35:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/M74bwkb4R_e0hzWbKdkNGw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-016', '--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 08:35:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/M74bwkb4R_e0hzWbKdkNGw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-016 --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 08:35:04 INFO - Using env: {'DISPLAY': ':0', 08:35:04 INFO - 'HOME': '/home/cltbld', 08:35:04 INFO - 'LANG': 'en_US.UTF-8', 08:35:04 INFO - 'LANGUAGE': 'en_US:en', 08:35:04 INFO - 'LOGNAME': 'cltbld', 08:35:04 INFO - 'MAIL': '/var/mail/cltbld', 08:35:04 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:35:04 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:35:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:35:04 INFO - 'MOZ_NO_REMOTE': '1', 08:35:04 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:35:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:35:04 INFO - 'NO_EM_RESTART': '1', 08:35:04 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:35:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:35:04 INFO - 'PWD': '/builds/slave/test', 08:35:04 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:35:04 INFO - 'SHELL': '/bin/bash', 08:35:04 INFO - 'SHLVL': '1', 08:35:04 INFO - 'TERM': 'linux', 08:35:04 INFO - 'TMOUT': '86400', 08:35:04 INFO - 'USER': 'cltbld', 08:35:04 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1461598365.783314-952467937', 08:35:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:35:04 INFO - '_': '/tools/buildbot/bin/python'} 08:35:04 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/M74bwkb4R_e0hzWbKdkNGw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-016', '--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 08:35:04 INFO - mozversion application_buildid: 20160425053010 08:35:04 INFO - mozversion application_changeset: 2e75a8ab94a9331d0f84a4a6edb13a7843e904e8 08:35:04 INFO - mozversion application_display_name: Nightly 08:35:04 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:35:04 INFO - mozversion application_name: Firefox 08:35:04 INFO - mozversion application_remotingname: firefox 08:35:04 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 08:35:04 INFO - mozversion application_vendor: Mozilla 08:35:04 INFO - mozversion application_version: 48.0a1 08:35:04 INFO - mozversion platform_buildid: 20160425053010 08:35:04 INFO - mozversion platform_changeset: 2e75a8ab94a9331d0f84a4a6edb13a7843e904e8 08:35:04 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 08:35:04 INFO - mozversion platform_version: 48.0a1 08:35:04 INFO - using testdate: 1461598504 08:35:04 INFO - actual date: 1461598504 08:35:04 INFO - starting webserver on 'localhost:35136' 08:35:04 INFO - SUITE-START | Running 2 tests 08:35:04 INFO - TEST-START | dromaeo_css 08:35:04 INFO - operating with platform_type : linux_ 08:35:04 INFO - Initialising browser for dromaeo_css test... 08:35:04 INFO - TEST-INFO | started process 6342 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbmKILX/profile http://localhost:35136/getInfo.html) 08:35:08 INFO - PROCESS | 6342 | 08:35:08 INFO - PROCESS | 6342 | (process:6413): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 08:35:08 INFO - PROCESS | 6342 | __metrics Screen width/height:1600/1200 08:35:08 INFO - PROCESS | 6342 | colorDepth:24 08:35:08 INFO - PROCESS | 6342 | Browser inner width/height: 1024/697 08:35:08 INFO - PROCESS | 6342 | __metrics 08:35:09 ERROR - PROCESS | 6342 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 08:35:10 INFO - TEST-INFO | 6342: exit 0 08:35:10 INFO - Browser initialized. 08:35:10 INFO - Running cycle 1/1 for dromaeo_css test... 08:35:10 INFO - TEST-INFO | started process 6464 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbmKILX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:35:12 INFO - PROCESS | 6464 | 08:35:12 INFO - PROCESS | 6464 | (process:6524): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 08:35:22 INFO - PROCESS | 6464 | RSS: Main: 164814848 08:35:22 INFO - PROCESS | 6464 | 08:36:11 INFO - PROCESS | 6464 | 1461598571712 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] 08:38:19 INFO - PROCESS | 6464 | Cycle 1(1): loaded http://localhost:35136/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35136/tests/dromaeo/cssquery-ext.html) 08:38:20 INFO - PROCESS | 6464 | RSS: Main: 170242048 08:38:20 INFO - PROCESS | 6464 | 08:41:22 INFO - PROCESS | 6464 | Cycle 1(1): loaded http://localhost:35136/tests/dromaeo/cssquery-ext.html (next: http://localhost:35136/tests/dromaeo/cssquery-jquery.html) 08:41:23 INFO - PROCESS | 6464 | RSS: Main: 166621184 08:41:23 INFO - PROCESS | 6464 | 08:44:24 INFO - PROCESS | 6464 | Cycle 1(1): loaded http://localhost:35136/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35136/tests/dromaeo/cssquery-mootools.html) 08:44:25 INFO - PROCESS | 6464 | RSS: Main: 167780352 08:44:25 INFO - PROCESS | 6464 | 08:47:27 INFO - PROCESS | 6464 | Cycle 1(1): loaded http://localhost:35136/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35136/tests/dromaeo/cssquery-prototype.html) 08:47:27 INFO - PROCESS | 6464 | RSS: Main: 165527552 08:47:27 INFO - PROCESS | 6464 | 08:50:30 INFO - PROCESS | 6464 | Cycle 1(1): loaded http://localhost:35136/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35136/tests/dromaeo/cssquery-yui.html) 08:50:30 INFO - PROCESS | 6464 | RSS: Main: 167067648 08:50:30 INFO - PROCESS | 6464 | 08:53:33 INFO - PROCESS | 6464 | Cycle 1(1): loaded http://localhost:35136/tests/dromaeo/cssquery-yui.html (next: http://localhost:35136/tests/dromaeo/cssquery-dojo.html) 08:53:33 INFO - PROCESS | 6464 | RSS: Main: 168943616 08:53:33 INFO - PROCESS | 6464 | 08:53:33 INFO - PROCESS | 6464 | __start_tp_report 08:53:33 INFO - PROCESS | 6464 | _x_x_mozilla_page_load 08:53:33 INFO - PROCESS | 6464 | _x_x_mozilla_page_load_details 08:53:33 INFO - PROCESS | 6464 | |i|pagename|runs| 08:53:33 INFO - PROCESS | 6464 | |0;dojo.html;3110.1758034120953;3178.825164615946;3202.50361194015;3243.9351212975757;3252.756043296752;5301.416844147141;5303.787848486066;5306.628536002477;5334.706591137486;5385.165299378597;5255.474452554743;5456.454354564542;5541.972290138544;5559.221708960748;5578.721063946797;4872.293517439969;4903.803847846082;4946.629002824785;4968.726720030397;5008.098542262392;488.1356265307977;4938.506149385051;5004.199328107504;5009.799608015675;5045.318881950945;4965.726885021322;4977.104121258172;4995.375578052744;5005.924911126336;5048.6465947383695;4966.950330496685;5009.699418034929;5041.344625198737;5074.096736161878;5101.438841727407;4919.163742163805;4961.454240033593;4972.204447288416;4975.626827987915;5032.370953630796;5337.893242135136;5402.567794576425;5410.648203414121;5444.346678398578;5505.201745746845;5742.425757424266;5838.241028666289;5868.853278668067;5874.383189765099;5905.084711869667;5889.146073819272;5899.144624029492;5906.468417842415;5909.556783241274;5936.050231962865;5485.75314110862;5491.28613280275;5496;5499.175123731432;5508.4491550845;5800.419958004166;5885.205497257815;5891.116332550152;5895.764169433261;5982.790602328898;5635.267415236075;5663.348714897757;5672.631278966854;5694.060480020833;5718.799842005593;5765.1640512125505;5773.076307790818;5779.24869766936;5779.2775903012125;5821.679807610622;5675.971620141873;5702.942970570324;5745.052066409079;5759.625624334405;5769.971150144306;5614.382417934024;5756.107803290497;5807.796727114531;5832.795852145155;5876.236089308362;4298;4346.1090476452255;4367.5632436756705;4374.868753937387;4378.64970802335;3887.3391523441082;3891.494105766289;3915.275674000262;3955.3473676843573;3956.723029387915;5554.50009499147;5556.527695145877;5559.16612508127;5571.164325351148;5580.86047848807;5711.914321285184;5798.666306749471;5828.213191219131;5860.794872179454;5914.290285165807;5413.458654134555;5617.21359009739;5655.151727240865;5695.943040569624;5698.572607054404;4950.504949505021;4955;4966.428860680996;4966.925496117561;5002.124628190052;5779.826605201851;5964.045752679551;5973.581849270509;6000.159977603139;6019.398060194033;5866.560007999417;5902.5277977762535;5904.763809447574;5938.079597662369;5990.071538911476;5996.2504686914135;6054.636721796706;6057.939420605738;6060.181875446935;6065.272167339947;5512.145617429305;5709.800156994485;5735.254416925773;5749.080147176432;5750.856228594319;5905.055191169392;5912.526997840077;5925.140854575976;5931.7627294907725;5993.940060599338;5765.5675824314185;5767.884642307215;5770.451807078321;5771;5798.739056742541;5621.915671264853;5720.141978703228;5755.366909639853;5763.884722305615;5764.510016648632;5613.298337707786;5616.747246374005;5629.831105066854;5645.379008309164;5671.631343962629;5687.857803554944;5696.914546281726;5724.542036637143;5768.7404066817935;5776.797812076557;5567.053600887778;5632.802851900164;5658.7736490541565;5673.489385955118;5741.13882917549 08:53:33 INFO - PROCESS | 6464 | |1;ext.html;602.4397310501232;645.8030300758267;655.7967030220632;664.6211659354169;678.074428405227;37232.06919827002;38253.42619860704;38362.42456363153;38452.61547384525;38474;38724.41913371302;39300.21399572007;39342.606573934325;39532.20935581287;39564.802175989076;8461.703840365588;8616.956915215414;8654.134586541359;8676.52279124648;8732.781680457976;8644.049154592989;8754.080821513744;8766.079561646031;8772.298216142693;8772.868406973868;8757.430767000125;8833.20501154896;8845.911540884605;8846.911530884705;8849;8727.650893964234;8741.650333986632;8808.03111657717;8809.779755506164;8827.029026807046;8496;8602.87095693565;8640.092790257058;8642.61108250124;8679.392442529026;38217.808910955544;38432.423513647314;38433;38801.22397552033;38847.22305553873;3349.514320423525;3472.635373285794;3478.9826050869583;3550.609432962372;3940.7241493095494;31953.520697189328;32252.193695157574;32762.508562371346;32817.3436531268;32880.83559582211;3880.844766209348;3924.9215015699524;4019.577944315834;4020.356742921148;4036.7577945323374;266063;267150.66424667946;267404;269249;269454;32152;57843.71078144582;58028;58159.4184058154;58384.41615583875;34621;34667.4799878002;34696;34714;34960;12427.627171184879;12574.371281435891;12620.495180192873;12642.747145057232;12657.43041563132;11067.612633557948;11114.888851111386;11130.777384452265;11136;11154.442277886235;8446.155384461505;8497.575121243914;8565.871511927326;8637.481751094954;8742.91257087421;3274.885379011723;3294.40700673881;3322.817245051497;3347.4811404232382;3349.8325083745717;1114.509615769059;1141.5034460009922;1184.2420850655587;1204.4459548607563;1227.5212667059855;31711.207219819687;32170;32597.348053038808;32937.341253175284;33181.50227746586;1110.0120892405766;1194.4796479428398;1194.635636130971;1200.6458094862037;1212.0848759186758;15180.392784288726;15346.693066138838;15411.614709632124;15465.458708945358;15844.44544440939;363632;370453;370869;371149;371932;51513.74243128835;53479.73260133752;53538.464615354125;53786.46213537815;53951.460485394644;1385.5081446086494;1397.0360451288577;1411.2238268952035;1413.1662319231702;1488.9627759306104;29359.853200734713;30140.397192056476;31162.799988015206;31661.8416907914;32142.67857321397;56310.15534767064;57382.7130864343;57530;57567;57720;462196;472481;473211;473401;475583;43391;43423;43801.12397752091;44251.557484424746;44391.55608444003;48505.75747121242;48596.514034859196;48628.75685621549;49771.50228497814;49999.25001124913;40756.79621601873;41222.79388603038;41238.58761412468;41404.1719165621;42744.78627606842;39932.402703891516;40970.79514602408;41426;41633.58366416297;42211.577884220766;37371.6262837379;38438.80780596191;38497;38734.2253154941;41846.58153418427;30231.093067208018;32227.194320142185;32275;32408.513872292406;32755.508667370486;26062.478750425264;28014.937834014363;28062.719372806012;28148.71851281543;28182.2954426141 08:53:33 INFO - PROCESS | 6464 | |2;jquery.html;391.37966323377447;394.68228076398526;401.53221496956047;401.8151650240889;401.98794036178924;14012.439502419891;17898;18614.90692546537;18726.90636546817;19492.317768878092;18218.81781182188;18776.812231877677;18898.338558150466;18925.52686182846;18941.621167576675;5595.21666966625;5602.21568980341;5801.854953626151;5815.214945982301;5845.707714614252;5770.6249093808765;5770.855728606776;5783.219265399181;5785.566082543805;5786.768529258825;5589.776408943638;5726.513246374042;5740.024195886688;5746.770129194827;5759.683217423061;5505.917411238835;5646.068398714207;5714.914276285859;5722.79970201043;5739.426057394248;5084.262781896604;5100.846974590768;5110.9744451277875;5120.743962801882;5144.717040562768;21416.678749818766;21711.45721356963;22039.228626997978;22558.661620075713;23004.424889377733;2389.2712722619594;2418.310781427285;2453.1904471524354;2487.5522405966917;2791.1626512046305;14289.071210371396;14317.140971541741;14353.06705064178;14595.854041459555;14753.852461475355;1946.5036415714044;1947.8149575790278;1989.9308304823933;2021.9595608087902;2033.6441122803599;76904.61547692282;77276;77473.22526774717;78796.60601697012;79218.20781792166;10459;10566.682999510027;10592.364458132537;10676.83984740214;10710.518026688818;12246.203996740183;13837.377318020714;14592.854071459362;15029.473968411054;15131.54605361841;7544.924550754422;7570.280823321776;7648.464607477535;7777.144514103444;7790.5325680459355;6983.546069505567;7100.60946647929;7169;7214.603196824225;7347.33873951347;6505.642189679613;6576.309487503839;6577.901331480031;6669.199696036507;6707.798766036929;1862.5436767991928;1896.345760712552;1906.609145125246;1919.7024461208534;1941.2138084075689;954.71358592422;1044.0968562193648;1073.2229390254772;1077.8922107789158;1161.3670549550516;18431.07844607764;18786.154623041995;19272.747271427314;19351.322703705304;19619.117139728747;1051.495282264502;1058.4760543531002;1062.628080171949;1079.082779637302;1080.6109800471825;10621.415822129857;10829.458527073615;10884.673459796219;10918.126549875991;11024.559017639365;494338;501558;505852;506370;541870;82128;82448;86224;86711;87465.56267218624;1009.2228983682523;1018.6587493189865;1077.375122429005;1085.6634443322596;1092.4046394714899;16377.344906203618;16509.257083431035;16512.66974660524;16792.748108778134;16794.244259008618;28714.85642571774;35417.468737969466;37836.62163378331;38028;38137.61862381452;48405.75797120992;48994;49527.75236123941;49601.50398495969;49779.25331119964;8028.357731381592;8221.876671849808;8294.668213271643;8309.6676132954;8384.622691978753;8676.606857046554;9695.951520242354;9731.464769437465;13168.275744834125;13342.332883355599;11796.115291353011;11953;12086.13151059183;12104.213226140273;12129.514819407124;11368.772624547628;11421.600243991421;11488.597899073493;11707;11885.881141188478;9091.54542272897;12064.396780161132;12197.878021219674;12213.755724885275;12233.204841685261;8503.787405314917;8540.786480338042;8568.40021198535;8586.313094952513;8811.779705507157;10419.739506512398;11983;12020.158588899043;12188.817167742314;12197.695057623276 08:53:33 INFO - PROCESS | 6464 | |3;mootools.html;1508.6756347385312;1525.8485535395093;1676.4048762689245;1766.7261574455963;1820.4811628685827;7719.228077192278;8145.959270203648;8437.789055273606;8559.914400855982;8610.18203270689;8489.533075680834;8524.659013639446;8535.487870727746;8538.91461085389;8585.399022068457;2267.1384873747993;2287.142321629389;2307;2315.7452680205165;2321.2688003279;2256.4133325335447;2277.146070223666;2289.8053665438456;2298.850574712647;2304.51605162916;2293;2301.6777651128855;2303.09027933966;2316.4787922717337;2319.744828068911;2232.7097477328007;2238.6194346961056;2241.8430709850318;2242.8093612042994;2248.808851247646;2183.1813070098715;2189.4526368407896;2195.6047911375945;2207.1171531387413;2210.5910406574835;8322.250997410201;8503.872441913314;8508.404411691185;8511.787205319855;8528;5049.798008079672;5179.067767801795;5187.19598462239;5198.480151984809;5246.134387826004;3085.7839951203423;3179.72972297355;3272.4764037754085;3279.8032118072992;3305.603327600679;979.2264111352023;981.0728861226144;988.8516722491612;1039.085604667895;1043.087298613713;11441.656750297421;11465.369404682739;11473.5984240552;11567.13246506507;11584.131190160771;4373.868783936487;4376.452943382077;4474.418325617649;4508.887277818081;4571.062932098912;9840.753981150528;9842.065003824626;9846.507674616241;9849.704508864603;9858.802823943624;5083.974580127149;5160.483951604884;5187.325647665779;5209.114450543417;5229.947700523022;4098;4638.907221855544;4727.456342520585;4758.1673207188605;4821.0839940411915;3819.427085937132;3866;3918;3925.9214815703526;3965.6629186518894;1222.248317284881;1260.3005332040805;1262.0786825617167;1270.9364531773374;1285.575759999198;947.9146876781123;999.5502024089044;1003.8895721470633;1009.6920439265947;1016.0956748493846;5956.315023772322;5989.64062156272;5991.370906054802;6074.787382441682;6271.247450305901;944.8850356579302;947.6398968391967;966.5215718219526;978.8889610292227;1012.3116280928891;4076.8369265229653;4177.164567086595;4194.161167766398;4224.978875105605;4232.661387089025;10266;10696.62561810333;10768.3538987661;10774.599302090677;10815.35107893529;10067.194624430029;10416.791664166674;10583.57665693379;10684;10726.892731072745;7725.806854828675;7809.68761249555;7830.8433831323055;7851.528908265523;7915.960420197862;5747.971260143672;5964.373740757158;5972.13404056418;6082.2701275847185;6152.384761523812;9539.809203816023;9794.069563391466;9872;9872.35829671069;9928.602855885683;9889.307748457826;9915.20678345745;10040.14658754014;10063.446510441996;10094.697159085239;7021.403180729695;7433.8141546461775;7626.923730762622;7657.88513172314;7737.5744334062165;8109.189081091844;8119.75640730779;8163.632636531252;8219.753407397788;8225.629846657035;7238.746643867439;7436.665350059152;7482.1021477423055;7574.962125189339;7590.354819840155;7259;7384.889226661497;7403.851922961403;7458.328750412489;7468.813279668052;6638.701258443285;6656.134702488645;6665.366790154928;6704.363085506869;6723.394894459522;5126.641135120506;5179.1454410021925;5207.2449494823795;5281.207818827206;5361.678299302054;5138.229265610188;5223.085959956917;5256.842294731164;5423.3491980962535;5426.321709786277 08:53:33 INFO - PROCESS | 6464 | |4;prototype.html;324.701274827159;324.7418302449552;328.06828606756807;331.24310949480434;331.55240425425677;5463.071277882759;5543.889122217553;5546.69493177875;5561.249231353766;5624.212610234566;5424.683809866324;5446.210299506569;5458.563314934806;5462.481064298895;5462.7268636568215;4067.6339129478342;4138.97930510347;4264.744115353089;4265.488141423034;4271.295236286024;4245.745255284677;4248.978755106235;4256.638185754199;4258.701890867641;4262.339337402707;4238.580075674653;4253.2131555662145;4258.254805409057;4279.443672322594;4302.88125087478;4005.8798236052967;4221.451211342536;4222.78886055696;4228.302330115527;4269.743815371087;3661.505696730934;3667.5782285037294;3674.6141655126094;3726.850925962958;3730.2539492101687;5285.7885684572575;5325.174597937326;5341.359036915556;5346.278252435949;5372.247885296062;4605.286180642006;4845.297431872359;4875.366202393701;4876.122297986361;4888.560029597318;5711.885762284731;5726.828195154152;5774.307083150049;5806.506446951972;5807.477327040587;4060.2285565742413;4076.2051399977017;4087.0804069084516;4099.795010249505;4112;5923.644581325091;5990.101484777319;6003.609765365237;6017.217761690996;6067.817965460999;4053.466583385384;4114.259433301974;4135.7518548887165;4159.376093585986;4159.91680166395;4225.767582782976;4231.048014196843;4236.809343579546;4237.322028475429;4248.171606536757;4714.5521175488275;4859.34398856157;4862.902741945212;4891.5353041461;4906.901861962812;5800.8259752207505;5824.805914787458;5834.774697313527;5873.383294754075;5881.176635271066;1505.0819000409742;1521.7108749337813;1528.8318284988643;1530.8239552451387;1533.7699345098101;918.3342076994126;988.3476905242505;997.4514017290606;1001.9849702254472;1010.989010989011;5923.289205295392;5951.761929522857;5958.463738263577;5969.910451343233;5972.462478376967;6363;6377.74489020434;6381.649009304533;6411.711472983727;6451;5809.419058094241;5957.195778569924;5970.13433052205;5981;5995.550333724988;3383.2725963917874;3392.406328892434;3413.9075495841093;3415.197428604276;3430.073880052372;6335.334789847;6453.903191452132;6483;6576.276609572943;6578.111954886125;6357.237131544151;6425.293217746044;6467.773627923094;6481.48148148147;6520.510961677893;6283.465905398092;6525.804225873231;6546.803595892131;6552.541322107407;6577.974131899285;6257.874842503215;6280.497560195082;6287.559870808999;6295.213098362705;6337.841553961188;6136.662483563447;6239.720857224349;6283.96858015707;6287.685615719287;6287.937120628735;6422.775202867877;6566.6388348639375;6570.967145164243;6594.70323835419;6599.571027883172;4357.847475338348;4372.431583894074;4398.714083584557;4403.757793321398;4407.823687052611;6268.749250029948;6272.5922815016875;6357.586756860789;6369.8726025480155;6371.39471750183;6124.234470691164;6138.83362161188;6163.445289923929;6183.536234782319;6196.8140955769595;5939.663575695434;6091.969540152271;6106.6336019838955;6165.6743800083195;6196.845078873064;5444.237806706985;5637.887242255214;5757.81203142803;5767.087620751494;6008.639481631116;5836.620619659709;5862.677552734641;5865.237519122657;5867.73843623623;5893.410658934073;5554.2779438672715;5692.601517893708;5756.539476841759;5774.682392468455;5784.681842498535 08:53:33 INFO - PROCESS | 6464 | |5;yui.html;660.2572106380322;662.7249691378079;678.5928442934239;699.5837476701361;768.4044865229448;12378;12440.813387799168;12515.374231288433;12537.749245015095;12951.74096518069;12018.819717704242;12877.227366358025;12981.805272920914;13089.083764136514;13102.93448532756;680.8672308899767;789.5302295134386;808.7897146741846;812.2730156509949;816.5345752920838;813.4143416739938;813.5647428625657;815.1970309245388;815.9224873636995;817.0562999735315;848.1603212819326;854.974350769478;855.7475544714324;856.1823458597056;856.1951765340591;844.995775021121;845.5941148248844;848.6350869126273;849.3714651158099;850.1880703927765;613.0956838662981;615.5014438304987;615.8645098078416;617.043582447205;619.8233503451495;11554.884451155465;11596.130290228266;11638.301701897828;11653.592124275694;11666.416679166008;12730.872691273154;12944.15862968904;12980.740385192337;13010.042612574372;13094.214347139203;9338.57976391064;9514.38156519824;9562.952185239099;9613.759656008586;9689.51552422383;3697.7596456230526;3702.4816525686156;3745.8127093645207;3754.155315054091;3784.4323351497496;49941.50058499405;50943;51617.741911290206;51700.48299516994;59369.70315148397;9991.900080999243;10089.394636321844;10202.183825293958;10293.53679084443;10323.587056517656;16057.197140142945;16061;16148.838511614733;16180;16203.108829014282;7323.890141647879;7349.595772232578;7418.96290518544;7474.140473845578;7632.542047477058;4501.459824820977;4506.031203291308;4521.321801729767;4542.273236282179;4566.56617621332;3097.241175911916;3139.6232452105437;3154.3533575616943;3163.2724473371254;3169.2869104451315;592.0172513627358;593.5577994394117;600.3576173494406;606.1634943777559;609.3114780298234;698.1412862179548;703.7712743358429;715.4634024481638;720.8810546259808;721.7077083781077;8749.518776467228;8932.330075244383;8933.419327743675;8934.248284466625;9083.36416450842;646.9971544106616;654.7642848574509;676.0231465532258;682.4847240333517;702.578452928239;4112.588741125864;4223.408722778813;4239.936400953989;4263.275243208662;4286.37847512109;64041.67979160074;67865;68236.6588167056;68326;68443.31556684469;56437.7178114115;58652;58930.70534647385;59010.704946474994;60528.39471605315;52071.479285207424;52256;52603;53533;53619.463805362226;7858.449908506578;7885.684572617031;7929.405294603043;8171.305439037748;8278.668853245803;33888.81389151368;34587.13532161716;34623.13442163966;34660.30679386449;34798.82600586981;47262.291065633355;47646.28530572113;47854.28218576655;48642.51357486522;49108;10353.119984801377;10633.89366106329;10641.616589843581;10701.625443109453;11321.830172547583;12119.75760484803;12213.694657633274;12232.75534489323;12292.631221063382;12427.751444970869;11408.828867566826;11536.480858361227;11930.642080737593;11983.940080299542;12060.698482538006;10937.56249750001;11185.888141118485;11286.887131128911;11326.660200194008;11910.166288360078;11753.706157346134;11828.526858925547;11842.644720658394;11946.76106477883;12065.879341206475;9731.56207970629;9890.258230632588;9923.801523969336;9955.552000160154;10192.337498062601;10194.286399951932;10327.741806454598;10347.172226222036;10396.220283478619;10457.843132353173 08:53:33 INFO - PROCESS | 6464 | __end_tp_report 08:53:33 INFO - PROCESS | 6464 | __start_cc_report 08:53:33 INFO - PROCESS | 6464 | _x_x_mozilla_cycle_collect,345 08:53:33 INFO - PROCESS | 6464 | __end_cc_report 08:53:33 INFO - PROCESS | 6464 | __startTimestamp1461599613367__endTimestamp 08:53:33 INFO - PROCESS | 6464 | 08:53:33 INFO - PROCESS | 6464 | ------- Summary: start ------- 08:53:33 INFO - PROCESS | 6464 | Number of tests: 6 08:53:33 INFO - PROCESS | 6464 | 08:53:33 INFO - PROCESS | 6464 | [#0] dojo.html Cycles:165 Average:5390.46 Median:5655.15 stddev:726.87 (12.9%) stddev-sans-first:706.75 08:53:33 INFO - PROCESS | 6464 | Values: 3110.2 3178.8 3202.5 3243.9 3252.8 5301.4 5303.8 5306.6 5334.7 5385.2 5255.5 5456.5 5542.0 5559.2 5578.7 4872.3 4903.8 4946.6 4968.7 5008.1 488.1 4938.5 5004.2 5009.8 5045.3 4965.7 4977.1 4995.4 5005.9 5048.6 4967.0 5009.7 5041.3 5074.1 5101.4 4919.2 4961.5 4972.2 4975.6 5032.4 5337.9 5402.6 5410.6 5444.3 5505.2 5742.4 5838.2 5868.9 5874.4 5905.1 5889.1 5899.1 5906.5 5909.6 5936.1 5485.8 5491.3 5496.0 5499.2 5508.4 5800.4 5885.2 5891.1 5895.8 5982.8 5635.3 5663.3 5672.6 5694.1 5718.8 5765.2 5773.1 5779.2 5779.3 5821.7 5676.0 5702.9 5745.1 5759.6 5770.0 5614.4 5756.1 5807.8 5832.8 5876.2 4298.0 4346.1 4367.6 4374.9 4378.6 3887.3 3891.5 3915.3 3955.3 3956.7 5554.5 5556.5 5559.2 5571.2 5580.9 5711.9 5798.7 5828.2 5860.8 5914.3 5413.5 5617.2 5655.2 5695.9 5698.6 4950.5 4955.0 4966.4 4966.9 5002.1 5779.8 5964.0 5973.6 6000.2 6019.4 5866.6 5902.5 5904.8 5938.1 5990.1 5996.3 6054.6 6057.9 6060.2 6065.3 5512.1 5709.8 5735.3 5749.1 5750.9 5905.1 5912.5 5925.1 5931.8 5993.9 5765.6 5767.9 5770.5 5771.0 5798.7 5621.9 5720.1 5755.4 5763.9 5764.5 5613.3 5616.7 5629.8 5645.4 5671.6 5687.9 5696.9 5724.5 5768.7 5776.8 5567.1 5632.8 5658.8 5673.5 5741.1 08:53:33 INFO - PROCESS | 6464 | 08:53:33 INFO - PROCESS | 6464 | [#1] ext.html Cycles:180 Average:52775.05 Median:38610.71 stddev:100306.76 (259.8%) stddev-sans-first:100511.66 08:53:33 INFO - PROCESS | 6464 | Values: 602.4 645.8 655.8 664.6 678.1 37232.1 38253.4 38362.4 38452.6 38474.0 38724.4 39300.2 39342.6 39532.2 39564.8 8461.7 8617.0 8654.1 8676.5 8732.8 8644.0 8754.1 8766.1 8772.3 8772.9 8757.4 8833.2 8845.9 8846.9 8849.0 8727.7 8741.7 8808.0 8809.8 8827.0 8496.0 8602.9 8640.1 8642.6 8679.4 38217.8 38432.4 38433.0 38801.2 38847.2 3349.5 3472.6 3479.0 3550.6 3940.7 31953.5 32252.2 32762.5 32817.3 32880.8 3880.8 3924.9 4019.6 4020.4 4036.8 266063.0 267150.7 267404.0 269249.0 269454.0 32152.0 57843.7 58028.0 58159.4 58384.4 34621.0 34667.5 34696.0 34714.0 34960.0 12427.6 12574.4 12620.5 12642.7 12657.4 11067.6 11114.9 11130.8 11136.0 11154.4 8446.2 8497.6 8565.9 8637.5 8742.9 3274.9 3294.4 3322.8 3347.5 3349.8 1114.5 1141.5 1184.2 1204.4 1227.5 31711.2 32170.0 32597.3 32937.3 33181.5 1110.0 1194.5 1194.6 1200.6 1212.1 15180.4 15346.7 15411.6 15465.5 15844.4 363632.0 370453.0 370869.0 371149.0 371932.0 51513.7 53479.7 53538.5 53786.5 53951.5 1385.5 1397.0 1411.2 1413.2 1489.0 29359.9 30140.4 31162.8 31661.8 32142.7 56310.2 57382.7 57530.0 57567.0 57720.0 462196.0 472481.0 473211.0 473401.0 475583.0 43391.0 43423.0 43801.1 44251.6 44391.6 48505.8 48596.5 48628.8 49771.5 49999.3 40756.8 41222.8 41238.6 41404.2 42744.8 39932.4 40970.8 41426.0 41633.6 42211.6 37371.6 38438.8 38497.0 38734.2 41846.6 30231.1 32227.2 32275.0 32408.5 32755.5 26062.5 28014.9 28062.7 28148.7 28182.3 08:53:33 INFO - PROCESS | 6464 | 08:53:33 INFO - PROCESS | 6464 | [#2] jquery.html Cycles:180 Average:28787.35 Median:2403.79 stddev:83755.75 (3484.3%) stddev-sans-first:83963.57 08:53:33 INFO - PROCESS | 6464 | Values: 391.4 394.7 401.5 401.8 402.0 14012.4 17898.0 18614.9 18726.9 19492.3 18218.8 18776.8 18898.3 18925.5 18941.6 5595.2 5602.2 5801.9 5815.2 5845.7 5770.6 5770.9 5783.2 5785.6 5786.8 5589.8 5726.5 5740.0 5746.8 5759.7 5505.9 5646.1 5714.9 5722.8 5739.4 5084.3 5100.8 5111.0 5120.7 5144.7 21416.7 21711.5 22039.2 22558.7 23004.4 2389.3 2418.3 2453.2 2487.6 2791.2 14289.1 14317.1 14353.1 14595.9 14753.9 1946.5 1947.8 1989.9 2022.0 2033.6 76904.6 77276.0 77473.2 78796.6 79218.2 10459.0 10566.7 10592.4 10676.8 10710.5 12246.2 13837.4 14592.9 15029.5 15131.5 7544.9 7570.3 7648.5 7777.1 7790.5 6983.5 7100.6 7169.0 7214.6 7347.3 6505.6 6576.3 6577.9 6669.2 6707.8 1862.5 1896.3 1906.6 1919.7 1941.2 954.7 1044.1 1073.2 1077.9 1161.4 18431.1 18786.2 19272.7 19351.3 19619.1 1051.5 1058.5 1062.6 1079.1 1080.6 10621.4 10829.5 10884.7 10918.1 11024.6 494338.0 501558.0 505852.0 506370.0 541870.0 82128.0 82448.0 86224.0 86711.0 87465.6 1009.2 1018.7 1077.4 1085.7 1092.4 16377.3 16509.3 16512.7 16792.7 16794.2 28714.9 35417.5 37836.6 38028.0 38137.6 48405.8 48994.0 49527.8 49601.5 49779.3 8028.4 8221.9 8294.7 8309.7 8384.6 8676.6 9696.0 9731.5 13168.3 13342.3 11796.1 11953.0 12086.1 12104.2 12129.5 11368.8 11421.6 11488.6 11707.0 11885.9 9091.5 12064.4 12197.9 12213.8 12233.2 8503.8 8540.8 8568.4 8586.3 8811.8 10419.7 11983.0 12020.2 12188.8 12197.7 08:53:33 INFO - PROCESS | 6464 | 08:53:33 INFO - PROCESS | 6464 | [#3] mootools.html Cycles:180 Average:5643.18 Median:5183.17 stddev:3147.23 (60.7%) stddev-sans-first:3140.73 08:53:33 INFO - PROCESS | 6464 | Values: 1508.7 1525.8 1676.4 1766.7 1820.5 7719.2 8146.0 8437.8 8559.9 8610.2 8489.5 8524.7 8535.5 8538.9 8585.4 2267.1 2287.1 2307.0 2315.7 2321.3 2256.4 2277.1 2289.8 2298.9 2304.5 2293.0 2301.7 2303.1 2316.5 2319.7 2232.7 2238.6 2241.8 2242.8 2248.8 2183.2 2189.5 2195.6 2207.1 2210.6 8322.3 8503.9 8508.4 8511.8 8528.0 5049.8 5179.1 5187.2 5198.5 5246.1 3085.8 3179.7 3272.5 3279.8 3305.6 979.2 981.1 988.9 1039.1 1043.1 11441.7 11465.4 11473.6 11567.1 11584.1 4373.9 4376.5 4474.4 4508.9 4571.1 9840.8 9842.1 9846.5 9849.7 9858.8 5084.0 5160.5 5187.3 5209.1 5229.9 4098.0 4638.9 4727.5 4758.2 4821.1 3819.4 3866.0 3918.0 3925.9 3965.7 1222.2 1260.3 1262.1 1270.9 1285.6 947.9 999.6 1003.9 1009.7 1016.1 5956.3 5989.6 5991.4 6074.8 6271.2 944.9 947.6 966.5 978.9 1012.3 4076.8 4177.2 4194.2 4225.0 4232.7 10266.0 10696.6 10768.4 10774.6 10815.4 10067.2 10416.8 10583.6 10684.0 10726.9 7725.8 7809.7 7830.8 7851.5 7916.0 5748.0 5964.4 5972.1 6082.3 6152.4 9539.8 9794.1 9872.0 9872.4 9928.6 9889.3 9915.2 10040.1 10063.4 10094.7 7021.4 7433.8 7626.9 7657.9 7737.6 8109.2 8119.8 8163.6 8219.8 8225.6 7238.7 7436.7 7482.1 7575.0 7590.4 7259.0 7384.9 7403.9 7458.3 7468.8 6638.7 6656.1 6665.4 6704.4 6723.4 5126.6 5179.1 5207.2 5281.2 5361.7 5138.2 5223.1 5256.8 5423.3 5426.3 08:53:33 INFO - PROCESS | 6464 | 08:53:33 INFO - PROCESS | 6464 | [#4] prototype.html Cycles:180 Average:4999.94 Median:5702.24 stddev:1535.22 (26.9%) stddev-sans-first:1498.88 08:53:33 INFO - PROCESS | 6464 | Values: 324.7 324.7 328.1 331.2 331.6 5463.1 5543.9 5546.7 5561.2 5624.2 5424.7 5446.2 5458.6 5462.5 5462.7 4067.6 4139.0 4264.7 4265.5 4271.3 4245.7 4249.0 4256.6 4258.7 4262.3 4238.6 4253.2 4258.3 4279.4 4302.9 4005.9 4221.5 4222.8 4228.3 4269.7 3661.5 3667.6 3674.6 3726.9 3730.3 5285.8 5325.2 5341.4 5346.3 5372.2 4605.3 4845.3 4875.4 4876.1 4888.6 5711.9 5726.8 5774.3 5806.5 5807.5 4060.2 4076.2 4087.1 4099.8 4112.0 5923.6 5990.1 6003.6 6017.2 6067.8 4053.5 4114.3 4135.8 4159.4 4159.9 4225.8 4231.0 4236.8 4237.3 4248.2 4714.6 4859.3 4862.9 4891.5 4906.9 5800.8 5824.8 5834.8 5873.4 5881.2 1505.1 1521.7 1528.8 1530.8 1533.8 918.3 988.3 997.5 1002.0 1011.0 5923.3 5951.8 5958.5 5969.9 5972.5 6363.0 6377.7 6381.6 6411.7 6451.0 5809.4 5957.2 5970.1 5981.0 5995.6 3383.3 3392.4 3413.9 3415.2 3430.1 6335.3 6453.9 6483.0 6576.3 6578.1 6357.2 6425.3 6467.8 6481.5 6520.5 6283.5 6525.8 6546.8 6552.5 6578.0 6257.9 6280.5 6287.6 6295.2 6337.8 6136.7 6239.7 6284.0 6287.7 6287.9 6422.8 6566.6 6571.0 6594.7 6599.6 4357.8 4372.4 4398.7 4403.8 4407.8 6268.7 6272.6 6357.6 6369.9 6371.4 6124.2 6138.8 6163.4 6183.5 6196.8 5939.7 6092.0 6106.6 6165.7 6196.8 5444.2 5637.9 5757.8 5767.1 6008.6 5836.6 5862.7 5865.2 5867.7 5893.4 5554.3 5692.6 5756.5 5774.7 5784.7 08:53:33 INFO - PROCESS | 6464 | 08:53:33 INFO - PROCESS | 6464 | [#5] yui.html Cycles:180 Average:14581.60 Median:50442.25 stddev:18039.42 (35.8%) stddev-sans-first:18059.74 08:53:33 INFO - PROCESS | 6464 | Values: 660.3 662.7 678.6 699.6 768.4 12378.0 12440.8 12515.4 12537.7 12951.7 12018.8 12877.2 12981.8 13089.1 13102.9 680.9 789.5 808.8 812.3 816.5 813.4 813.6 815.2 815.9 817.1 848.2 855.0 855.7 856.2 856.2 845.0 845.6 848.6 849.4 850.2 613.1 615.5 615.9 617.0 619.8 11554.9 11596.1 11638.3 11653.6 11666.4 12730.9 12944.2 12980.7 13010.0 13094.2 9338.6 9514.4 9563.0 9613.8 9689.5 3697.8 3702.5 3745.8 3754.2 3784.4 49941.5 50943.0 51617.7 51700.5 59369.7 9991.9 10089.4 10202.2 10293.5 10323.6 16057.2 16061.0 16148.8 16180.0 16203.1 7323.9 7349.6 7419.0 7474.1 7632.5 4501.5 4506.0 4521.3 4542.3 4566.6 3097.2 3139.6 3154.4 3163.3 3169.3 592.0 593.6 600.4 606.2 609.3 698.1 703.8 715.5 720.9 721.7 8749.5 8932.3 8933.4 8934.2 9083.4 647.0 654.8 676.0 682.5 702.6 4112.6 4223.4 4239.9 4263.3 4286.4 64041.7 67865.0 68236.7 68326.0 68443.3 56437.7 58652.0 58930.7 59010.7 60528.4 52071.5 52256.0 52603.0 53533.0 53619.5 7858.4 7885.7 7929.4 8171.3 8278.7 33888.8 34587.1 34623.1 34660.3 34798.8 47262.3 47646.3 47854.3 48642.5 49108.0 10353.1 10633.9 10641.6 10701.6 11321.8 12119.8 12213.7 12232.8 12292.6 12427.8 11408.8 11536.5 11930.6 11983.9 12060.7 10937.6 11185.9 11286.9 11326.7 11910.2 11753.7 11828.5 11842.6 11946.8 12065.9 9731.6 9890.3 9923.8 9955.6 10192.3 10194.3 10327.7 10347.2 10396.2 10457.8 08:53:33 INFO - PROCESS | 6464 | -------- Summary: end -------- 08:53:33 INFO - PROCESS | 6464 | 08:53:34 INFO - TEST-INFO | 6464: exit 0 08:53:34 INFO - TEST-OK | dromaeo_css | took 1109864ms 08:53:34 INFO - TEST-START | kraken 08:53:34 INFO - operating with platform_type : linux_ 08:53:34 INFO - Initialising browser for kraken test... 08:53:34 INFO - TEST-INFO | started process 6695 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcPlCqU/profile http://localhost:35136/getInfo.html) 08:53:37 INFO - PROCESS | 6695 | 08:53:37 INFO - PROCESS | 6695 | (process:6763): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 08:53:38 INFO - PROCESS | 6695 | __metrics Screen width/height:1600/1200 08:53:38 INFO - PROCESS | 6695 | colorDepth:24 08:53:38 INFO - PROCESS | 6695 | Browser inner width/height: 1024/697 08:53:38 INFO - PROCESS | 6695 | __metrics 08:53:39 ERROR - PROCESS | 6695 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 08:53:40 INFO - TEST-INFO | 6695: exit 0 08:53:40 INFO - Browser initialized. 08:53:40 INFO - Running cycle 1/1 for kraken test... 08:53:40 INFO - TEST-INFO | started process 6814 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcPlCqU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:53:41 INFO - PROCESS | 6814 | 08:53:41 INFO - PROCESS | 6814 | (process:6874): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 08:53:51 INFO - PROCESS | 6814 | RSS: Main: 164802560 08:53:51 INFO - PROCESS | 6814 | 08:53:54 INFO - PROCESS | 6814 | Cycle 1(1): loaded http://localhost:35136/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35136/tests/kraken/driver.html?testName=audio-beat-detection) 08:53:55 INFO - PROCESS | 6814 | RSS: Main: 169078784 08:53:55 INFO - PROCESS | 6814 | 08:53:57 INFO - PROCESS | 6814 | Cycle 1(1): loaded http://localhost:35136/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35136/tests/kraken/driver.html?testName=audio-dft) 08:53:58 INFO - PROCESS | 6814 | RSS: Main: 172556288 08:53:58 INFO - PROCESS | 6814 | 08:54:01 INFO - PROCESS | 6814 | Cycle 1(1): loaded http://localhost:35136/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35136/tests/kraken/driver.html?testName=audio-fft) 08:54:02 INFO - PROCESS | 6814 | RSS: Main: 162820096 08:54:02 INFO - PROCESS | 6814 | 08:54:04 INFO - PROCESS | 6814 | Cycle 1(1): loaded http://localhost:35136/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35136/tests/kraken/driver.html?testName=audio-oscillator) 08:54:04 INFO - PROCESS | 6814 | RSS: Main: 163033088 08:54:04 INFO - PROCESS | 6814 | 08:54:07 INFO - PROCESS | 6814 | Cycle 1(1): loaded http://localhost:35136/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35136/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:54:07 INFO - PROCESS | 6814 | RSS: Main: 164409344 08:54:07 INFO - PROCESS | 6814 | 08:54:10 INFO - PROCESS | 6814 | Cycle 1(1): loaded http://localhost:35136/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35136/tests/kraken/driver.html?testName=imaging-darkroom) 08:54:11 INFO - PROCESS | 6814 | RSS: Main: 165056512 08:54:11 INFO - PROCESS | 6814 | 08:54:14 INFO - PROCESS | 6814 | Cycle 1(1): loaded http://localhost:35136/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35136/tests/kraken/driver.html?testName=imaging-desaturate) 08:54:15 INFO - PROCESS | 6814 | RSS: Main: 167231488 08:54:15 INFO - PROCESS | 6814 | 08:54:18 INFO - PROCESS | 6814 | Cycle 1(1): loaded http://localhost:35136/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35136/tests/kraken/driver.html?testName=json-parse-financial) 08:54:18 INFO - PROCESS | 6814 | RSS: Main: 168198144 08:54:18 INFO - PROCESS | 6814 | 08:54:20 INFO - PROCESS | 6814 | Cycle 1(1): loaded http://localhost:35136/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35136/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:54:21 INFO - PROCESS | 6814 | RSS: Main: 167813120 08:54:21 INFO - PROCESS | 6814 | 08:54:22 INFO - PROCESS | 6814 | Cycle 1(1): loaded http://localhost:35136/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35136/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:54:23 INFO - PROCESS | 6814 | RSS: Main: 167370752 08:54:23 INFO - PROCESS | 6814 | 08:54:25 INFO - PROCESS | 6814 | Cycle 1(1): loaded http://localhost:35136/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35136/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:54:26 INFO - PROCESS | 6814 | RSS: Main: 168136704 08:54:26 INFO - PROCESS | 6814 | 08:54:28 INFO - PROCESS | 6814 | Cycle 1(1): loaded http://localhost:35136/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35136/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:54:29 INFO - PROCESS | 6814 | RSS: Main: 168337408 08:54:29 INFO - PROCESS | 6814 | 08:54:32 INFO - PROCESS | 6814 | Cycle 1(1): loaded http://localhost:35136/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35136/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:54:32 INFO - PROCESS | 6814 | RSS: Main: 168546304 08:54:32 INFO - PROCESS | 6814 | 08:54:34 INFO - PROCESS | 6814 | Cycle 1(1): loaded http://localhost:35136/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35136/tests/kraken/driver.html?testName=ai-astar) 08:54:34 INFO - PROCESS | 6814 | RSS: Main: 169758720 08:54:34 INFO - PROCESS | 6814 | 08:54:34 INFO - PROCESS | 6814 | __start_tp_report 08:54:34 INFO - PROCESS | 6814 | _x_x_mozilla_page_load 08:54:34 INFO - PROCESS | 6814 | _x_x_mozilla_page_load_details 08:54:34 INFO - PROCESS | 6814 | |i|pagename|runs| 08:54:34 INFO - PROCESS | 6814 | |0;ai-astar;112;107;111;110;112;125;112;114;111;111 08:54:34 INFO - PROCESS | 6814 | |1;audio-beat-detection;163;129;162;180;131;157;156;129;188;130 08:54:34 INFO - PROCESS | 6814 | |2;audio-dft;163;162;164;164;161;164;167;164;166;162 08:54:34 INFO - PROCESS | 6814 | |3;audio-fft;76;75;74;161;73;77;76;76;167;73 08:54:34 INFO - PROCESS | 6814 | |4;audio-oscillator;93;94;145;94;94;92;140;92;93;146 08:54:34 INFO - PROCESS | 6814 | |5;imaging-gaussian-blur;117;118;118;118;117;117;117;117;123;117 08:54:34 INFO - PROCESS | 6814 | |6;imaging-darkroom;146;147;147;147;147;146;147;151;146;146 08:54:34 INFO - PROCESS | 6814 | |7;imaging-desaturate;97;96;95;96;95;94;95;94;95;95 08:54:34 INFO - PROCESS | 6814 | |8;json-parse-financial;58;60;58;58;58;58;58;80;57;55 08:54:34 INFO - PROCESS | 6814 | |9;json-stringify-tinderbox;61;61;60;61;62;61;61;63;61;61 08:54:34 INFO - PROCESS | 6814 | |10;stanford-crypto-aes;83;76;76;78;76;78;77;78;86;79 08:54:34 INFO - PROCESS | 6814 | |11;stanford-crypto-ccm;127;127;124;124;134;131;123;122;156;125 08:54:34 INFO - PROCESS | 6814 | |12;stanford-crypto-pbkdf2;164;165;166;167;165;170;165;165;166;164 08:54:34 INFO - PROCESS | 6814 | |13;stanford-crypto-sha256-iterative;72;67;69;67;68;66;66;68;68;67 08:54:34 INFO - PROCESS | 6814 | __end_tp_report 08:54:34 INFO - PROCESS | 6814 | __start_cc_report 08:54:34 INFO - PROCESS | 6814 | _x_x_mozilla_cycle_collect,848 08:54:34 INFO - PROCESS | 6814 | __end_cc_report 08:54:34 INFO - PROCESS | 6814 | __startTimestamp1461599674867__endTimestamp 08:54:34 INFO - PROCESS | 6814 | 08:54:34 INFO - PROCESS | 6814 | ------- Summary: start ------- 08:54:34 INFO - PROCESS | 6814 | Number of tests: 14 08:54:34 INFO - PROCESS | 6814 | 08:54:34 INFO - PROCESS | 6814 | [#0] ai-astar Cycles:10 Average:112.50 Median:112.00 stddev:4.74 (4.2%) stddev-sans-first:5.03 08:54:34 INFO - PROCESS | 6814 | Values: 112.0 107.0 111.0 110.0 112.0 125.0 112.0 114.0 111.0 111.0 08:54:34 INFO - PROCESS | 6814 | 08:54:34 INFO - PROCESS | 6814 | [#1] audio-beat-detection Cycles:10 Average:152.50 Median:159.50 stddev:21.92 (13.7%) stddev-sans-first:22.91 08:54:34 INFO - PROCESS | 6814 | Values: 163.0 129.0 162.0 180.0 131.0 157.0 156.0 129.0 188.0 130.0 08:54:34 INFO - PROCESS | 6814 | 08:54:34 INFO - PROCESS | 6814 | [#2] audio-dft Cycles:10 Average:163.70 Median:164.00 stddev:1.83 (1.1%) stddev-sans-first:1.92 08:54:34 INFO - PROCESS | 6814 | Values: 163.0 162.0 164.0 164.0 161.0 164.0 167.0 164.0 166.0 162.0 08:54:34 INFO - PROCESS | 6814 | 08:54:34 INFO - PROCESS | 6814 | [#3] audio-fft Cycles:10 Average:92.80 Median:75.50 stddev:37.58 (49.8%) stddev-sans-first:39.36 08:54:34 INFO - PROCESS | 6814 | Values: 76.0 75.0 74.0 161.0 73.0 77.0 76.0 76.0 167.0 73.0 08:54:34 INFO - PROCESS | 6814 | 08:54:34 INFO - PROCESS | 6814 | [#4] audio-oscillator Cycles:10 Average:108.30 Median:93.00 stddev:24.46 (26.3%) stddev-sans-first:25.31 08:54:34 INFO - PROCESS | 6814 | Values: 93.0 94.0 145.0 94.0 94.0 92.0 140.0 92.0 93.0 146.0 08:54:34 INFO - PROCESS | 6814 | 08:54:34 INFO - PROCESS | 6814 | [#5] imaging-gaussian-blur Cycles:10 Average:117.90 Median:117.50 stddev:1.85 (1.6%) stddev-sans-first:1.94 08:54:34 INFO - PROCESS | 6814 | Values: 117.0 118.0 118.0 118.0 117.0 117.0 117.0 117.0 123.0 117.0 08:54:34 INFO - PROCESS | 6814 | 08:54:34 INFO - PROCESS | 6814 | [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.00 stddev:1.49 (1.0%) stddev-sans-first:1.54 08:54:34 INFO - PROCESS | 6814 | Values: 146.0 147.0 147.0 147.0 147.0 146.0 147.0 151.0 146.0 146.0 08:54:34 INFO - PROCESS | 6814 | 08:54:34 INFO - PROCESS | 6814 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.92 (1.0%) stddev-sans-first:0.71 08:54:34 INFO - PROCESS | 6814 | Values: 97.0 96.0 95.0 96.0 95.0 94.0 95.0 94.0 95.0 95.0 08:54:34 INFO - PROCESS | 6814 | 08:54:34 INFO - PROCESS | 6814 | [#8] json-parse-financial Cycles:10 Average:60.00 Median:58.00 stddev:7.13 (12.3%) stddev-sans-first:7.53 08:54:34 INFO - PROCESS | 6814 | Values: 58.0 60.0 58.0 58.0 58.0 58.0 58.0 80.0 57.0 55.0 08:54:34 INFO - PROCESS | 6814 | 08:54:34 INFO - PROCESS | 6814 | [#9] json-stringify-tinderbox Cycles:10 Average:61.20 Median:61.00 stddev:0.79 (1.3%) stddev-sans-first:0.83 08:54:34 INFO - PROCESS | 6814 | Values: 61.0 61.0 60.0 61.0 62.0 61.0 61.0 63.0 61.0 61.0 08:54:34 INFO - PROCESS | 6814 | 08:54:34 INFO - PROCESS | 6814 | [#10] stanford-crypto-aes Cycles:10 Average:78.70 Median:78.00 stddev:3.30 (4.2%) stddev-sans-first:3.11 08:54:34 INFO - PROCESS | 6814 | Values: 83.0 76.0 76.0 78.0 76.0 78.0 77.0 78.0 86.0 79.0 08:54:34 INFO - PROCESS | 6814 | 08:54:34 INFO - PROCESS | 6814 | [#11] stanford-crypto-ccm Cycles:10 Average:129.30 Median:127.00 stddev:10.09 (7.9%) stddev-sans-first:10.67 08:54:34 INFO - PROCESS | 6814 | Values: 127.0 127.0 124.0 124.0 134.0 131.0 123.0 122.0 156.0 125.0 08:54:34 INFO - PROCESS | 6814 | 08:54:34 INFO - PROCESS | 6814 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.70 Median:165.50 stddev:1.77 (1.1%) stddev-sans-first:1.76 08:54:34 INFO - PROCESS | 6814 | Values: 164.0 165.0 166.0 167.0 165.0 170.0 165.0 165.0 166.0 164.0 08:54:34 INFO - PROCESS | 6814 | 08:54:34 INFO - PROCESS | 6814 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.80 Median:68.00 stddev:1.75 (2.6%) stddev-sans-first:1.00 08:54:34 INFO - PROCESS | 6814 | Values: 72.0 67.0 69.0 67.0 68.0 66.0 66.0 68.0 68.0 67.0 08:54:34 INFO - PROCESS | 6814 | -------- Summary: end -------- 08:54:34 INFO - PROCESS | 6814 | 08:54:35 INFO - TEST-INFO | 6814: exit 0 08:54:35 INFO - TEST-OK | kraken | took 61737ms 08:54:35 INFO - SUITE-END | took 1171s 08:54:36 INFO - Completed test suite (00:19:31) 08:54:36 INFO - javascript benchmark 08:54:36 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3110.1758034120953, 3178.825164615946, 3202.50361194015, 3243.9351212975757, 3252.756043296752, 5301.416844147141, 5303.787848486066, 5306.628536002477, 5334.706591137486, 5385.165299378597, 5255.474452554743, 5456.454354564542, 5541.972290138544, 5559.221708960748, 5578.721063946797, 4872.293517439969, 4903.803847846082, 4946.629002824785, 4968.726720030397, 5008.098542262392, 488.1356265307977, 4938.506149385051, 5004.199328107504, 5009.799608015675, 5045.318881950945, 4965.726885021322, 4977.104121258172, 4995.375578052744, 5005.924911126336, 5048.6465947383695, 4966.950330496685, 5009.699418034929, 5041.344625198737, 5074.096736161878, 5101.438841727407, 4919.163742163805, 4961.454240033593, 4972.204447288416, 4975.626827987915, 5032.370953630796, 5337.893242135136, 5402.567794576425, 5410.648203414121, 5444.346678398578, 5505.201745746845, 5742.425757424266, 5838.241028666289, 5868.853278668067, 5874.383189765099, 5905.084711869667, 5889.146073819272, 5899.144624029492, 5906.468417842415, 5909.556783241274, 5936.050231962865, 5485.75314110862, 5491.28613280275, 5496.0, 5499.175123731432, 5508.4491550845, 5800.419958004166, 5885.205497257815, 5891.116332550152, 5895.764169433261, 5982.790602328898, 5635.267415236075, 5663.348714897757, 5672.631278966854, 5694.060480020833, 5718.799842005593, 5765.1640512125505, 5773.076307790818, 5779.24869766936, 5779.2775903012125, 5821.679807610622, 5675.971620141873, 5702.942970570324, 5745.052066409079, 5759.625624334405, 5769.971150144306, 5614.382417934024, 5756.107803290497, 5807.796727114531, 5832.795852145155, 5876.236089308362, 4298.0, 4346.1090476452255, 4367.5632436756705, 4374.868753937387, 4378.64970802335, 3887.3391523441082, 3891.494105766289, 3915.275674000262, 3955.3473676843573, 3956.723029387915, 5554.50009499147, 5556.527695145877, 5559.16612508127, 5571.164325351148, 5580.86047848807, 5711.914321285184, 5798.666306749471, 5828.213191219131, 5860.794872179454, 5914.290285165807, 5413.458654134555, 5617.21359009739, 5655.151727240865, 5695.943040569624, 5698.572607054404, 4950.504949505021, 4955.0, 4966.428860680996, 4966.925496117561, 5002.124628190052, 5779.826605201851, 5964.045752679551, 5973.581849270509, 6000.159977603139, 6019.398060194033, 5866.560007999417, 5902.5277977762535, 5904.763809447574, 5938.079597662369, 5990.071538911476, 5996.2504686914135, 6054.636721796706, 6057.939420605738, 6060.181875446935, 6065.272167339947, 5512.145617429305, 5709.800156994485, 5735.254416925773, 5749.080147176432, 5750.856228594319, 5905.055191169392, 5912.526997840077, 5925.140854575976, 5931.7627294907725, 5993.940060599338, 5765.5675824314185, 5767.884642307215, 5770.451807078321, 5771.0, 5798.739056742541, 5621.915671264853, 5720.141978703228, 5755.366909639853, 5763.884722305615, 5764.510016648632, 5613.298337707786, 5616.747246374005, 5629.831105066854, 5645.379008309164, 5671.631343962629, 5687.857803554944, 5696.914546281726, 5724.542036637143, 5768.7404066817935, 5776.797812076557, 5567.053600887778, 5632.802851900164, 5658.7736490541565, 5673.489385955118, 5741.13882917549], "value": 5343.662376500171, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [602.4397310501232, 645.8030300758267, 655.7967030220632, 664.6211659354169, 678.074428405227, 37232.06919827002, 38253.42619860704, 38362.42456363153, 38452.61547384525, 38474.0, 38724.41913371302, 39300.21399572007, 39342.606573934325, 39532.20935581287, 39564.802175989076, 8461.703840365588, 8616.956915215414, 8654.134586541359, 8676.52279124648, 8732.781680457976, 8644.049154592989, 8754.080821513744, 8766.079561646031, 8772.298216142693, 8772.868406973868, 8757.430767000125, 8833.20501154896, 8845.911540884605, 8846.911530884705, 8849.0, 8727.650893964234, 8741.650333986632, 8808.03111657717, 8809.779755506164, 8827.029026807046, 8496.0, 8602.87095693565, 8640.092790257058, 8642.61108250124, 8679.392442529026, 38217.808910955544, 38432.423513647314, 38433.0, 38801.22397552033, 38847.22305553873, 3349.514320423525, 3472.635373285794, 3478.9826050869583, 3550.609432962372, 3940.7241493095494, 31953.520697189328, 32252.193695157574, 32762.508562371346, 32817.3436531268, 32880.83559582211, 3880.844766209348, 3924.9215015699524, 4019.577944315834, 4020.356742921148, 4036.7577945323374, 266063.0, 267150.66424667946, 267404.0, 269249.0, 269454.0, 32152.0, 57843.71078144582, 58028.0, 58159.4184058154, 58384.41615583875, 34621.0, 34667.4799878002, 34696.0, 34714.0, 34960.0, 12427.627171184879, 12574.371281435891, 12620.495180192873, 12642.747145057232, 12657.43041563132, 11067.612633557948, 11114.888851111386, 11130.777384452265, 11136.0, 11154.442277886235, 8446.155384461505, 8497.575121243914, 8565.871511927326, 8637.481751094954, 8742.91257087421, 3274.885379011723, 3294.40700673881, 3322.817245051497, 3347.4811404232382, 3349.8325083745717, 1114.509615769059, 1141.5034460009922, 1184.2420850655587, 1204.4459548607563, 1227.5212667059855, 31711.207219819687, 32170.0, 32597.348053038808, 32937.341253175284, 33181.50227746586, 1110.0120892405766, 1194.4796479428398, 1194.635636130971, 1200.6458094862037, 1212.0848759186758, 15180.392784288726, 15346.693066138838, 15411.614709632124, 15465.458708945358, 15844.44544440939, 363632.0, 370453.0, 370869.0, 371149.0, 371932.0, 51513.74243128835, 53479.73260133752, 53538.464615354125, 53786.46213537815, 53951.460485394644, 1385.5081446086494, 1397.0360451288577, 1411.2238268952035, 1413.1662319231702, 1488.9627759306104, 29359.853200734713, 30140.397192056476, 31162.799988015206, 31661.8416907914, 32142.67857321397, 56310.15534767064, 57382.7130864343, 57530.0, 57567.0, 57720.0, 462196.0, 472481.0, 473211.0, 473401.0, 475583.0, 43391.0, 43423.0, 43801.12397752091, 44251.557484424746, 44391.55608444003, 48505.75747121242, 48596.514034859196, 48628.75685621549, 49771.50228497814, 49999.25001124913, 40756.79621601873, 41222.79388603038, 41238.58761412468, 41404.1719165621, 42744.78627606842, 39932.402703891516, 40970.79514602408, 41426.0, 41633.58366416297, 42211.577884220766, 37371.6262837379, 38438.80780596191, 38497.0, 38734.2253154941, 41846.58153418427, 30231.093067208018, 32227.194320142185, 32275.0, 32408.513872292406, 32755.508667370486, 26062.478750425264, 28014.937834014363, 28062.719372806012, 28148.71851281543, 28182.2954426141], "value": 18418.437511667227, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [391.37966323377447, 394.68228076398526, 401.53221496956047, 401.8151650240889, 401.98794036178924, 14012.439502419891, 17898.0, 18614.90692546537, 18726.90636546817, 19492.317768878092, 18218.81781182188, 18776.812231877677, 18898.338558150466, 18925.52686182846, 18941.621167576675, 5595.21666966625, 5602.21568980341, 5801.854953626151, 5815.214945982301, 5845.707714614252, 5770.6249093808765, 5770.855728606776, 5783.219265399181, 5785.566082543805, 5786.768529258825, 5589.776408943638, 5726.513246374042, 5740.024195886688, 5746.770129194827, 5759.683217423061, 5505.917411238835, 5646.068398714207, 5714.914276285859, 5722.79970201043, 5739.426057394248, 5084.262781896604, 5100.846974590768, 5110.9744451277875, 5120.743962801882, 5144.717040562768, 21416.678749818766, 21711.45721356963, 22039.228626997978, 22558.661620075713, 23004.424889377733, 2389.2712722619594, 2418.310781427285, 2453.1904471524354, 2487.5522405966917, 2791.1626512046305, 14289.071210371396, 14317.140971541741, 14353.06705064178, 14595.854041459555, 14753.852461475355, 1946.5036415714044, 1947.8149575790278, 1989.9308304823933, 2021.9595608087902, 2033.6441122803599, 76904.61547692282, 77276.0, 77473.22526774717, 78796.60601697012, 79218.20781792166, 10459.0, 10566.682999510027, 10592.364458132537, 10676.83984740214, 10710.518026688818, 12246.203996740183, 13837.377318020714, 14592.854071459362, 15029.473968411054, 15131.54605361841, 7544.924550754422, 7570.280823321776, 7648.464607477535, 7777.144514103444, 7790.5325680459355, 6983.546069505567, 7100.60946647929, 7169.0, 7214.603196824225, 7347.33873951347, 6505.642189679613, 6576.309487503839, 6577.901331480031, 6669.199696036507, 6707.798766036929, 1862.5436767991928, 1896.345760712552, 1906.609145125246, 1919.7024461208534, 1941.2138084075689, 954.71358592422, 1044.0968562193648, 1073.2229390254772, 1077.8922107789158, 1161.3670549550516, 18431.07844607764, 18786.154623041995, 19272.747271427314, 19351.322703705304, 19619.117139728747, 1051.495282264502, 1058.4760543531002, 1062.628080171949, 1079.082779637302, 1080.6109800471825, 10621.415822129857, 10829.458527073615, 10884.673459796219, 10918.126549875991, 11024.559017639365, 494338.0, 501558.0, 505852.0, 506370.0, 541870.0, 82128.0, 82448.0, 86224.0, 86711.0, 87465.56267218624, 1009.2228983682523, 1018.6587493189865, 1077.375122429005, 1085.6634443322596, 1092.4046394714899, 16377.344906203618, 16509.257083431035, 16512.66974660524, 16792.748108778134, 16794.244259008618, 28714.85642571774, 35417.468737969466, 37836.62163378331, 38028.0, 38137.61862381452, 48405.75797120992, 48994.0, 49527.75236123941, 49601.50398495969, 49779.25331119964, 8028.357731381592, 8221.876671849808, 8294.668213271643, 8309.6676132954, 8384.622691978753, 8676.606857046554, 9695.951520242354, 9731.464769437465, 13168.275744834125, 13342.332883355599, 11796.115291353011, 11953.0, 12086.13151059183, 12104.213226140273, 12129.514819407124, 11368.772624547628, 11421.600243991421, 11488.597899073493, 11707.0, 11885.881141188478, 9091.54542272897, 12064.396780161132, 12197.878021219674, 12213.755724885275, 12233.204841685261, 8503.787405314917, 8540.786480338042, 8568.40021198535, 8586.313094952513, 8811.779705507157, 10419.739506512398, 11983.0, 12020.158588899043, 12188.817167742314, 12197.695057623276], "value": 9165.011350194362, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1508.6756347385312, 1525.8485535395093, 1676.4048762689245, 1766.7261574455963, 1820.4811628685827, 7719.228077192278, 8145.959270203648, 8437.789055273606, 8559.914400855982, 8610.18203270689, 8489.533075680834, 8524.659013639446, 8535.487870727746, 8538.91461085389, 8585.399022068457, 2267.1384873747993, 2287.142321629389, 2307.0, 2315.7452680205165, 2321.2688003279, 2256.4133325335447, 2277.146070223666, 2289.8053665438456, 2298.850574712647, 2304.51605162916, 2293.0, 2301.6777651128855, 2303.09027933966, 2316.4787922717337, 2319.744828068911, 2232.7097477328007, 2238.6194346961056, 2241.8430709850318, 2242.8093612042994, 2248.808851247646, 2183.1813070098715, 2189.4526368407896, 2195.6047911375945, 2207.1171531387413, 2210.5910406574835, 8322.250997410201, 8503.872441913314, 8508.404411691185, 8511.787205319855, 8528.0, 5049.798008079672, 5179.067767801795, 5187.19598462239, 5198.480151984809, 5246.134387826004, 3085.7839951203423, 3179.72972297355, 3272.4764037754085, 3279.8032118072992, 3305.603327600679, 979.2264111352023, 981.0728861226144, 988.8516722491612, 1039.085604667895, 1043.087298613713, 11441.656750297421, 11465.369404682739, 11473.5984240552, 11567.13246506507, 11584.131190160771, 4373.868783936487, 4376.452943382077, 4474.418325617649, 4508.887277818081, 4571.062932098912, 9840.753981150528, 9842.065003824626, 9846.507674616241, 9849.704508864603, 9858.802823943624, 5083.974580127149, 5160.483951604884, 5187.325647665779, 5209.114450543417, 5229.947700523022, 4098.0, 4638.907221855544, 4727.456342520585, 4758.1673207188605, 4821.0839940411915, 3819.427085937132, 3866.0, 3918.0, 3925.9214815703526, 3965.6629186518894, 1222.248317284881, 1260.3005332040805, 1262.0786825617167, 1270.9364531773374, 1285.575759999198, 947.9146876781123, 999.5502024089044, 1003.8895721470633, 1009.6920439265947, 1016.0956748493846, 5956.315023772322, 5989.64062156272, 5991.370906054802, 6074.787382441682, 6271.247450305901, 944.8850356579302, 947.6398968391967, 966.5215718219526, 978.8889610292227, 1012.3116280928891, 4076.8369265229653, 4177.164567086595, 4194.161167766398, 4224.978875105605, 4232.661387089025, 10266.0, 10696.62561810333, 10768.3538987661, 10774.599302090677, 10815.35107893529, 10067.194624430029, 10416.791664166674, 10583.57665693379, 10684.0, 10726.892731072745, 7725.806854828675, 7809.68761249555, 7830.8433831323055, 7851.528908265523, 7915.960420197862, 5747.971260143672, 5964.373740757158, 5972.13404056418, 6082.2701275847185, 6152.384761523812, 9539.809203816023, 9794.069563391466, 9872.0, 9872.35829671069, 9928.602855885683, 9889.307748457826, 9915.20678345745, 10040.14658754014, 10063.446510441996, 10094.697159085239, 7021.403180729695, 7433.8141546461775, 7626.923730762622, 7657.88513172314, 7737.5744334062165, 8109.189081091844, 8119.75640730779, 8163.632636531252, 8219.753407397788, 8225.629846657035, 7238.746643867439, 7436.665350059152, 7482.1021477423055, 7574.962125189339, 7590.354819840155, 7259.0, 7384.889226661497, 7403.851922961403, 7458.328750412489, 7468.813279668052, 6638.701258443285, 6656.134702488645, 6665.366790154928, 6704.363085506869, 6723.394894459522, 5126.641135120506, 5179.1454410021925, 5207.2449494823795, 5281.207818827206, 5361.678299302054, 5138.229265610188, 5223.085959956917, 5256.842294731164, 5423.3491980962535, 5426.321709786277], "value": 4543.950413986002, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [324.701274827159, 324.7418302449552, 328.06828606756807, 331.24310949480434, 331.55240425425677, 5463.071277882759, 5543.889122217553, 5546.69493177875, 5561.249231353766, 5624.212610234566, 5424.683809866324, 5446.210299506569, 5458.563314934806, 5462.481064298895, 5462.7268636568215, 4067.6339129478342, 4138.97930510347, 4264.744115353089, 4265.488141423034, 4271.295236286024, 4245.745255284677, 4248.978755106235, 4256.638185754199, 4258.701890867641, 4262.339337402707, 4238.580075674653, 4253.2131555662145, 4258.254805409057, 4279.443672322594, 4302.88125087478, 4005.8798236052967, 4221.451211342536, 4222.78886055696, 4228.302330115527, 4269.743815371087, 3661.505696730934, 3667.5782285037294, 3674.6141655126094, 3726.850925962958, 3730.2539492101687, 5285.7885684572575, 5325.174597937326, 5341.359036915556, 5346.278252435949, 5372.247885296062, 4605.286180642006, 4845.297431872359, 4875.366202393701, 4876.122297986361, 4888.560029597318, 5711.885762284731, 5726.828195154152, 5774.307083150049, 5806.506446951972, 5807.477327040587, 4060.2285565742413, 4076.2051399977017, 4087.0804069084516, 4099.795010249505, 4112.0, 5923.644581325091, 5990.101484777319, 6003.609765365237, 6017.217761690996, 6067.817965460999, 4053.466583385384, 4114.259433301974, 4135.7518548887165, 4159.376093585986, 4159.91680166395, 4225.767582782976, 4231.048014196843, 4236.809343579546, 4237.322028475429, 4248.171606536757, 4714.5521175488275, 4859.34398856157, 4862.902741945212, 4891.5353041461, 4906.901861962812, 5800.8259752207505, 5824.805914787458, 5834.774697313527, 5873.383294754075, 5881.176635271066, 1505.0819000409742, 1521.7108749337813, 1528.8318284988643, 1530.8239552451387, 1533.7699345098101, 918.3342076994126, 988.3476905242505, 997.4514017290606, 1001.9849702254472, 1010.989010989011, 5923.289205295392, 5951.761929522857, 5958.463738263577, 5969.910451343233, 5972.462478376967, 6363.0, 6377.74489020434, 6381.649009304533, 6411.711472983727, 6451.0, 5809.419058094241, 5957.195778569924, 5970.13433052205, 5981.0, 5995.550333724988, 3383.2725963917874, 3392.406328892434, 3413.9075495841093, 3415.197428604276, 3430.073880052372, 6335.334789847, 6453.903191452132, 6483.0, 6576.276609572943, 6578.111954886125, 6357.237131544151, 6425.293217746044, 6467.773627923094, 6481.48148148147, 6520.510961677893, 6283.465905398092, 6525.804225873231, 6546.803595892131, 6552.541322107407, 6577.974131899285, 6257.874842503215, 6280.497560195082, 6287.559870808999, 6295.213098362705, 6337.841553961188, 6136.662483563447, 6239.720857224349, 6283.96858015707, 6287.685615719287, 6287.937120628735, 6422.775202867877, 6566.6388348639375, 6570.967145164243, 6594.70323835419, 6599.571027883172, 4357.847475338348, 4372.431583894074, 4398.714083584557, 4403.757793321398, 4407.823687052611, 6268.749250029948, 6272.5922815016875, 6357.586756860789, 6369.8726025480155, 6371.39471750183, 6124.234470691164, 6138.83362161188, 6163.445289923929, 6183.536234782319, 6196.8140955769595, 5939.663575695434, 6091.969540152271, 6106.6336019838955, 6165.6743800083195, 6196.845078873064, 5444.237806706985, 5637.887242255214, 5757.81203142803, 5767.087620751494, 6008.639481631116, 5836.620619659709, 5862.677552734641, 5865.237519122657, 5867.73843623623, 5893.410658934073, 5554.2779438672715, 5692.601517893708, 5756.539476841759, 5774.682392468455, 5784.681842498535], "value": 4505.217743641209, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [660.2572106380322, 662.7249691378079, 678.5928442934239, 699.5837476701361, 768.4044865229448, 12378.0, 12440.813387799168, 12515.374231288433, 12537.749245015095, 12951.74096518069, 12018.819717704242, 12877.227366358025, 12981.805272920914, 13089.083764136514, 13102.93448532756, 680.8672308899767, 789.5302295134386, 808.7897146741846, 812.2730156509949, 816.5345752920838, 813.4143416739938, 813.5647428625657, 815.1970309245388, 815.9224873636995, 817.0562999735315, 848.1603212819326, 854.974350769478, 855.7475544714324, 856.1823458597056, 856.1951765340591, 844.995775021121, 845.5941148248844, 848.6350869126273, 849.3714651158099, 850.1880703927765, 613.0956838662981, 615.5014438304987, 615.8645098078416, 617.043582447205, 619.8233503451495, 11554.884451155465, 11596.130290228266, 11638.301701897828, 11653.592124275694, 11666.416679166008, 12730.872691273154, 12944.15862968904, 12980.740385192337, 13010.042612574372, 13094.214347139203, 9338.57976391064, 9514.38156519824, 9562.952185239099, 9613.759656008586, 9689.51552422383, 3697.7596456230526, 3702.4816525686156, 3745.8127093645207, 3754.155315054091, 3784.4323351497496, 49941.50058499405, 50943.0, 51617.741911290206, 51700.48299516994, 59369.70315148397, 9991.900080999243, 10089.394636321844, 10202.183825293958, 10293.53679084443, 10323.587056517656, 16057.197140142945, 16061.0, 16148.838511614733, 16180.0, 16203.108829014282, 7323.890141647879, 7349.595772232578, 7418.96290518544, 7474.140473845578, 7632.542047477058, 4501.459824820977, 4506.031203291308, 4521.321801729767, 4542.273236282179, 4566.56617621332, 3097.241175911916, 3139.6232452105437, 3154.3533575616943, 3163.2724473371254, 3169.2869104451315, 592.0172513627358, 593.5577994394117, 600.3576173494406, 606.1634943777559, 609.3114780298234, 698.1412862179548, 703.7712743358429, 715.4634024481638, 720.8810546259808, 721.7077083781077, 8749.518776467228, 8932.330075244383, 8933.419327743675, 8934.248284466625, 9083.36416450842, 646.9971544106616, 654.7642848574509, 676.0231465532258, 682.4847240333517, 702.578452928239, 4112.588741125864, 4223.408722778813, 4239.936400953989, 4263.275243208662, 4286.37847512109, 64041.67979160074, 67865.0, 68236.6588167056, 68326.0, 68443.31556684469, 56437.7178114115, 58652.0, 58930.70534647385, 59010.704946474994, 60528.39471605315, 52071.479285207424, 52256.0, 52603.0, 53533.0, 53619.463805362226, 7858.449908506578, 7885.684572617031, 7929.405294603043, 8171.305439037748, 8278.668853245803, 33888.81389151368, 34587.13532161716, 34623.13442163966, 34660.30679386449, 34798.82600586981, 47262.291065633355, 47646.28530572113, 47854.28218576655, 48642.51357486522, 49108.0, 10353.119984801377, 10633.89366106329, 10641.616589843581, 10701.625443109453, 11321.830172547583, 12119.75760484803, 12213.694657633274, 12232.75534489323, 12292.631221063382, 12427.751444970869, 11408.828867566826, 11536.480858361227, 11930.642080737593, 11983.940080299542, 12060.698482538006, 10937.56249750001, 11185.888141118485, 11286.887131128911, 11326.660200194008, 11910.166288360078, 11753.706157346134, 11828.526858925547, 11842.644720658394, 11946.76106477883, 12065.879341206475, 9731.56207970629, 9890.258230632588, 9923.801523969336, 9955.552000160154, 10192.337498062601, 10194.286399951932, 10327.741806454598, 10347.172226222036, 10396.220283478619, 10457.843132353173], "value": 6394.739199563115, "unit": "score"}], "name": "dromaeo_css", "value": 7004.43083880194, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 107.0, 111.0, 110.0, 112.0, 125.0, 112.0, 114.0, 111.0, 111.0], "value": 112.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 129.0, 162.0, 180.0, 131.0, 157.0, 156.0, 129.0, 188.0, 130.0], "value": 152.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 164.0, 164.0, 161.0, 164.0, 167.0, 164.0, 166.0, 162.0], "value": 163.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 74.0, 161.0, 73.0, 77.0, 76.0, 76.0, 167.0, 73.0], "value": 92.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 145.0, 94.0, 94.0, 92.0, 140.0, 92.0, 93.0, 146.0], "value": 108.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 118.0, 118.0, 117.0, 117.0, 117.0, 117.0, 123.0, 117.0], "value": 117.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 147.0, 147.0, 147.0, 146.0, 147.0, 151.0, 146.0, 146.0], "value": 147.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 96.0, 95.0, 96.0, 95.0, 94.0, 95.0, 94.0, 95.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 60.0, 58.0, 58.0, 58.0, 58.0, 58.0, 80.0, 57.0, 55.0], "value": 60.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 60.0, 61.0, 62.0, 61.0, 61.0, 63.0, 61.0, 61.0], "value": 61.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 76.0, 76.0, 78.0, 76.0, 78.0, 77.0, 78.0, 86.0, 79.0], "value": 78.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 127.0, 124.0, 124.0, 134.0, 131.0, 123.0, 122.0, 156.0, 125.0], "value": 129.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 165.0, 166.0, 167.0, 165.0, 170.0, 165.0, 165.0, 166.0, 164.0], "value": 165.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 67.0, 69.0, 67.0, 68.0, 66.0, 66.0, 68.0, 68.0, 67.0], "value": 67.8, "unit": "score"}], "name": "kraken", "value": 1552.6000000000001, "alertThreshold": 2.0}]} 08:54:36 INFO - Return code: 0 08:54:36 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 08:54:36 ERROR - # TBPL SUCCESS # 08:54:36 INFO - Running post-action listener: _resource_record_post_action 08:54:36 INFO - Running post-run listener: _resource_record_post_run 08:54:37 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 4096; Write bytes: 549629952; Read time: 12; Write time: 570516 08:54:37 INFO - install - Wall time: 17s; CPU: 15.0%; Read bytes: 0; Write bytes: 258564096; Read time: 0; Write time: 383328 08:54:37 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 4096; Write bytes: 289325056; Read time: 12; Write time: 187092 08:54:37 INFO - Running post-run listener: _upload_blobber_files 08:54:37 INFO - Blob upload gear active. 08:54:37 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:54:37 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 08:54:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:54:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:54:37 INFO - (blobuploader) - INFO - Open directory for files ... 08:54:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 08:54:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:54:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:54:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 08:54:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:54:38 INFO - (blobuploader) - INFO - Done attempting. 08:54:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 08:54:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:54:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:54:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 08:54:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:54:39 INFO - (blobuploader) - INFO - Done attempting. 08:54:39 INFO - (blobuploader) - INFO - Iteration through files over. 08:54:39 INFO - Return code: 0 08:54:39 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:54:39 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:54:39 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/acdbc042fb3857202b83d9d66d3e030591c42979fd084ca65cf61167efd9ae5c1015462276e5405976470a5e3c650b37798d0ef63be0c10fa1fd688dd1368839", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/49fcb281554377dedc7d7d7741d0b0a3e29600e16354b26b579586b7e4b8a24470d9eb0327bae38eb7c5efcfe54b74d66626a3c7c4a54086952210affa16f400"} 08:54:39 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:54:39 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:54:39 INFO - Contents: 08:54:39 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/acdbc042fb3857202b83d9d66d3e030591c42979fd084ca65cf61167efd9ae5c1015462276e5405976470a5e3c650b37798d0ef63be0c10fa1fd688dd1368839", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/49fcb281554377dedc7d7d7741d0b0a3e29600e16354b26b579586b7e4b8a24470d9eb0327bae38eb7c5efcfe54b74d66626a3c7c4a54086952210affa16f400"} 08:54:39 INFO - Running post-run listener: copy_logs_to_upload_dir 08:54:39 INFO - Copying logs to upload dir... 08:54:39 INFO - mkdir: /builds/slave/test/build/upload/logs 08:54:39 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1227.720798 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 27 secs) (at 2016-04-25 08:54:39.261669) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-25 08:54:39.265533) ========= 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=00204705a9daa57ed339a427000001b9-1461598365.783314-952467937 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/acdbc042fb3857202b83d9d66d3e030591c42979fd084ca65cf61167efd9ae5c1015462276e5405976470a5e3c650b37798d0ef63be0c10fa1fd688dd1368839", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/49fcb281554377dedc7d7d7741d0b0a3e29600e16354b26b579586b7e4b8a24470d9eb0327bae38eb7c5efcfe54b74d66626a3c7c4a54086952210affa16f400"} build_url:https://queue.taskcluster.net/v1/task/M74bwkb4R_e0hzWbKdkNGw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011491 build_url: 'https://queue.taskcluster.net/v1/task/M74bwkb4R_e0hzWbKdkNGw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/acdbc042fb3857202b83d9d66d3e030591c42979fd084ca65cf61167efd9ae5c1015462276e5405976470a5e3c650b37798d0ef63be0c10fa1fd688dd1368839", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/49fcb281554377dedc7d7d7741d0b0a3e29600e16354b26b579586b7e4b8a24470d9eb0327bae38eb7c5efcfe54b74d66626a3c7c4a54086952210affa16f400"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-25 08:54:39.290515) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 08:54:39.290847) ========= 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=00204705a9daa57ed339a427000001b9-1461598365.783314-952467937 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004464 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 08:54:39.377395) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-25 08:54:39.378035) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-25 08:54:39.378614) ========= ========= Total master_lag: 0.18 =========