builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-012 starttime: 1462548167.56 results: success (0) buildid: 20160506053330 builduid: 87d4a8d0b6f642d59d0cf9a6a7de94c3 revision: 9d202f109312b37f42224c55724ea845a4b86c23 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-06 08:22:47.556210) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-06 08:22:47.556698) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-06 08:22:47.557030) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-06 08:22:47.595960) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 08:22:47.596311) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1462546946.797051-141093476 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-06 08:22:47-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 225M=0s 2016-05-06 08:22:47 (225 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.196229 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 08:22:47.807171) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 08:22:47.807571) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1462546946.797051-141093476 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.120505 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 08:22:47.939308) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 08:22:47.939626) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 9d202f109312b37f42224c55724ea845a4b86c23 --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 9d202f109312b37f42224c55724ea845a4b86c23 --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=2c5dd2b0a310ecf02fd87158000001b4-1462546946.797051-141093476 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-06 08:22:47,944 truncating revision to first 12 chars 2016-05-06 08:22:47,944 Setting DEBUG logging. 2016-05-06 08:22:47,944 attempt 1/10 2016-05-06 08:22:47,944 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/9d202f109312?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-06 08:22:48,204 unpacking tar archive at: fx-team-9d202f109312/testing/mozharness/ program finished with exit code 0 elapsedTime=0.550011 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 08:22:48.506836) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-06 08:22:48.507171) ========= script_repo_revision: 9d202f109312b37f42224c55724ea845a4b86c23 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-06 08:22:48.507596) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-06 08:22:48.507903) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-06 08:22:48.575966) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-05-06 08:22:48.576470) ========= /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=2c5dd2b0a310ecf02fd87158000001b4-1462546946.797051-141093476 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:22:48 INFO - MultiFileLogger online at 20160506 08:22:48 in /builds/slave/test 08:22:48 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:22:48 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:22:48 INFO - {'append_to_log': False, 08:22:48 INFO - 'base_work_dir': '/builds/slave/test', 08:22:48 INFO - 'blob_upload_branch': 'Fx-Team', 08:22:48 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:22:48 INFO - 'branch': 'Fx-Team', 08:22:48 INFO - 'buildbot_json_path': 'buildprops.json', 08:22:48 INFO - 'config_files': ('talos/linux_config.py',), 08:22:48 INFO - 'default_actions': ('clobber', 08:22:48 INFO - 'read-buildbot-config', 08:22:48 INFO - 'download-and-extract', 08:22:48 INFO - 'populate-webroot', 08:22:48 INFO - 'create-virtualenv', 08:22:48 INFO - 'install', 08:22:48 INFO - 'run-tests'), 08:22:48 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:22:48 INFO - 'download_minidump_stackwalk': True, 08:22:48 INFO - 'download_symbols': 'ondemand', 08:22:48 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:22:48 INFO - 'tooltool.py': '/tools/tooltool.py', 08:22:48 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:22:48 INFO - '/tools/misc-python/virtualenv.py')}, 08:22:48 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:22:48 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:22:48 INFO - 'installer_path': 'installer.exe', 08:22:48 INFO - 'log_level': 'info', 08:22:48 INFO - 'log_name': 'talos', 08:22:48 INFO - 'log_to_console': True, 08:22:48 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:22:48 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:22:48 INFO - 'opt_config_files': (), 08:22:48 INFO - 'pip_index': False, 08:22:48 INFO - 'sps_profile': False, 08:22:48 INFO - 'sps_profile_interval': 0, 08:22:48 INFO - 'suite': 'dromaeojs-e10s', 08:22:48 INFO - 'system_bits': '32', 08:22:48 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:22:48 INFO - 'title': 'talos-linux64-ix-012', 08:22:48 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:22:48 INFO - 'use_talos_json': True, 08:22:48 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:22:48 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:22:48 INFO - 'work_dir': 'build'} 08:22:48 INFO - ##### 08:22:48 INFO - ##### Running clobber step. 08:22:48 INFO - ##### 08:22:48 INFO - Running pre-action listener: _resource_record_pre_action 08:22:48 INFO - Running main action method: clobber 08:22:48 INFO - rmtree: /builds/slave/test/build 08:22:48 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:22:50 INFO - Running post-action listener: _resource_record_post_action 08:22:50 INFO - ##### 08:22:50 INFO - ##### Finished clobber step (success) 08:22:50 INFO - ##### 08:22:50 INFO - ##### 08:22:50 INFO - ##### Running read-buildbot-config step. 08:22:50 INFO - ##### 08:22:50 INFO - Running pre-action listener: _resource_record_pre_action 08:22:50 INFO - Running main action method: read_buildbot_config 08:22:50 INFO - Using buildbot properties: 08:22:50 INFO - { 08:22:50 INFO - "project": "", 08:22:50 INFO - "product": "firefox", 08:22:50 INFO - "script_repo_revision": "production", 08:22:50 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 08:22:50 INFO - "repository": "", 08:22:50 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 08:22:50 INFO - "buildid": "20160506053330", 08:22:50 INFO - "pgo_build": "True", 08:22:50 INFO - "basedir": "/builds/slave/test", 08:22:50 INFO - "buildnumber": 728, 08:22:50 INFO - "slavename": "talos-linux64-ix-012", 08:22:50 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 08:22:50 INFO - "platform": "ubuntu64_hw", 08:22:50 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 08:22:50 INFO - "branch": "fx-team", 08:22:50 INFO - "repo_path": "integration/fx-team", 08:22:50 INFO - "revision": "9d202f109312b37f42224c55724ea845a4b86c23", 08:22:50 INFO - "stage_platform": "linux64-pgo", 08:22:50 INFO - "builduid": "87d4a8d0b6f642d59d0cf9a6a7de94c3", 08:22:50 INFO - "slavebuilddir": "test" 08:22:50 INFO - } 08:22:50 INFO - Found installer url https://queue.taskcluster.net/v1/task/NFQ2NwvDQIKh3tZ4u3cv8A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 08:22:50 INFO - Running post-action listener: _resource_record_post_action 08:22:50 INFO - ##### 08:22:50 INFO - ##### Finished read-buildbot-config step (success) 08:22:50 INFO - ##### 08:22:50 INFO - ##### 08:22:50 INFO - ##### Running download-and-extract step. 08:22:50 INFO - ##### 08:22:50 INFO - Running pre-action listener: _resource_record_pre_action 08:22:50 INFO - Running main action method: download_and_extract 08:22:50 INFO - mkdir: /builds/slave/test/build/tests 08:22:50 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:22:50 INFO - https://queue.taskcluster.net/v1/task/NFQ2NwvDQIKh3tZ4u3cv8A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 08:22:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NFQ2NwvDQIKh3tZ4u3cv8A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 08:22:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NFQ2NwvDQIKh3tZ4u3cv8A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 08:22:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NFQ2NwvDQIKh3tZ4u3cv8A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 08:22:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NFQ2NwvDQIKh3tZ4u3cv8A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 08:22:54 INFO - Downloaded 1361 bytes. 08:22:54 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 08:22:54 INFO - Using the following test package requirements: 08:22:54 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 08:22:54 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:22:54 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:22:54 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:22:54 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:22:54 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:22:54 INFO - u'jsshell-linux-x86_64.zip'], 08:22:54 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:22:54 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:22:54 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 08:22:54 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:22:54 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:22:54 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:22:54 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:22:54 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:22:54 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:22:54 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:22:54 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:22:54 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:22:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:22:54 INFO - https://queue.taskcluster.net/v1/task/NFQ2NwvDQIKh3tZ4u3cv8A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:22:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NFQ2NwvDQIKh3tZ4u3cv8A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 08:22:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NFQ2NwvDQIKh3tZ4u3cv8A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 08:22:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NFQ2NwvDQIKh3tZ4u3cv8A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 08:22:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NFQ2NwvDQIKh3tZ4u3cv8A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:22:58 INFO - Downloaded 23893852 bytes. 08:22:58 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:22:58 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 08:23:00 INFO - Return code: 0 08:23:00 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 08:23:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:23:00 INFO - https://queue.taskcluster.net/v1/task/NFQ2NwvDQIKh3tZ4u3cv8A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:23:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NFQ2NwvDQIKh3tZ4u3cv8A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 08:23:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NFQ2NwvDQIKh3tZ4u3cv8A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 08:23:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NFQ2NwvDQIKh3tZ4u3cv8A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 08:23:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NFQ2NwvDQIKh3tZ4u3cv8A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:23:01 INFO - Downloaded 23893852 bytes. 08:23:01 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:23:01 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 08:23:03 INFO - Return code: 0 08:23: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:23:03 INFO - https://queue.taskcluster.net/v1/task/NFQ2NwvDQIKh3tZ4u3cv8A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:23:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NFQ2NwvDQIKh3tZ4u3cv8A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 08:23:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NFQ2NwvDQIKh3tZ4u3cv8A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 08:23:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NFQ2NwvDQIKh3tZ4u3cv8A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 08:23:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NFQ2NwvDQIKh3tZ4u3cv8A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 08:23:05 INFO - Downloaded 10840152 bytes. 08:23:05 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:23:05 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 08:23:05 INFO - Return code: 0 08:23:05 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:23:05 INFO - https://queue.taskcluster.net/v1/task/NFQ2NwvDQIKh3tZ4u3cv8A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:23:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NFQ2NwvDQIKh3tZ4u3cv8A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 08:23:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NFQ2NwvDQIKh3tZ4u3cv8A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 08:23:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NFQ2NwvDQIKh3tZ4u3cv8A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 08:23:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NFQ2NwvDQIKh3tZ4u3cv8A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 08:23:06 INFO - Downloaded 58431851 bytes. 08:23:06 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NFQ2NwvDQIKh3tZ4u3cv8A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 08:23:06 INFO - mkdir: /builds/slave/test/properties 08:23:06 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:23:06 INFO - Writing to file /builds/slave/test/properties/build_url 08:23:06 INFO - Contents: 08:23:06 INFO - build_url:https://queue.taskcluster.net/v1/task/NFQ2NwvDQIKh3tZ4u3cv8A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 08:23:07 INFO - Running post-action listener: _resource_record_post_action 08:23:07 INFO - Running post-action listener: set_extra_try_arguments 08:23:07 INFO - ##### 08:23:07 INFO - ##### Finished download-and-extract step (success) 08:23:07 INFO - ##### 08:23:07 INFO - ##### 08:23:07 INFO - ##### Running populate-webroot step. 08:23:07 INFO - ##### 08:23:07 INFO - Running pre-action listener: _resource_record_pre_action 08:23:07 INFO - Running main action method: populate_webroot 08:23:07 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:23:07 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:23:07 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:23:07 INFO - '--tppagecycles', 08:23:07 INFO - '7'], 08:23:07 INFO - 'tests': ['tsvgm']}}, 08:23:07 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:23:07 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:23:07 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:23:07 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:23:07 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:23:07 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:23:07 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:23:07 INFO - 'talos_options': ['--disable-e10s'], 08:23:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:23:07 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:23:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:23:07 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:23:07 INFO - 'talos_options': ['--disable-e10s'], 08:23:07 INFO - 'tests': ['damp', 'tps']}, 08:23:07 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:23:07 INFO - 'tests': ['damp', 'tps']}, 08:23:07 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:23:07 INFO - 'tests': ['dromaeo_dom']}, 08:23:07 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:23:07 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:23:07 INFO - 'tests': ['a11yr', 08:23:07 INFO - 'ts_paint', 08:23:07 INFO - 'tpaint', 08:23:07 INFO - 'sessionrestore', 08:23:07 INFO - 'sessionrestore_no_auto_restore', 08:23:07 INFO - 'tabpaint']}, 08:23:07 INFO - 'other-e10s': {'tests': ['a11yr', 08:23:07 INFO - 'ts_paint', 08:23:07 INFO - 'tpaint', 08:23:07 INFO - 'sessionrestore', 08:23:07 INFO - 'sessionrestore_no_auto_restore', 08:23:07 INFO - 'tabpaint']}, 08:23:07 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:23:07 INFO - 'ts_paint', 08:23:07 INFO - 'tpaint', 08:23:07 INFO - 'sessionrestore', 08:23:07 INFO - 'sessionrestore_no_auto_restore', 08:23:07 INFO - 'tabpaint']}, 08:23:07 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:23:07 INFO - 'ts_paint', 08:23:07 INFO - 'tpaint', 08:23:07 INFO - 'sessionrestore', 08:23:07 INFO - 'sessionrestore_no_auto_restore', 08:23:07 INFO - 'tabpaint']}, 08:23:07 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:23:07 INFO - 'tests': ['a11yr', 08:23:07 INFO - 'ts_paint', 08:23:07 INFO - 'tpaint', 08:23:07 INFO - 'sessionrestore', 08:23:07 INFO - 'sessionrestore_no_auto_restore', 08:23:07 INFO - 'tabpaint']}, 08:23:07 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:23:07 INFO - 'tests': ['a11yr', 08:23:07 INFO - 'ts_paint', 08:23:07 INFO - 'tpaint', 08:23:07 INFO - 'sessionrestore', 08:23:07 INFO - 'sessionrestore_no_auto_restore', 08:23:07 INFO - 'tabpaint']}, 08:23:07 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:23:07 INFO - 'tests': ['tsvgx', 08:23:07 INFO - 'tsvgr_opacity', 08:23:07 INFO - 'tart', 08:23:07 INFO - 'tscrollx', 08:23:07 INFO - 'cart']}, 08:23:07 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:23:07 INFO - 'tsvgr_opacity', 08:23:07 INFO - 'tart', 08:23:07 INFO - 'tscrollx', 08:23:07 INFO - 'cart']}, 08:23:07 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:23:07 INFO - 'talos_options': ['--disable-e10s'], 08:23:07 INFO - 'tests': ['tp5o']}, 08:23:07 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:23:07 INFO - 'tests': ['tp5o']}, 08:23:07 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:23:07 INFO - 'talos_options': ['--disable-e10s', 08:23:07 INFO - '--xperf_path', 08:23:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:23:07 INFO - 'tests': ['tp5n']}, 08:23:07 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:23:07 INFO - 'talos_options': ['--xperf_path', 08:23:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:23:07 INFO - 'tests': ['tp5n']}}, 08:23:07 INFO - 'talos.zip': {'path': '', 08:23:07 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:23:07 INFO - Running post-action listener: _resource_record_post_action 08:23:07 INFO - ##### 08:23:07 INFO - ##### Finished populate-webroot step (success) 08:23:07 INFO - ##### 08:23:07 INFO - ##### 08:23:07 INFO - ##### Running create-virtualenv step. 08:23:07 INFO - ##### 08:23:07 INFO - Running pre-action listener: _resource_record_pre_action 08:23:07 INFO - Running main action method: create_virtualenv 08:23:07 INFO - Creating virtualenv /builds/slave/test/build/venv 08:23:07 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:23:07 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:23:07 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:23:07 INFO - Using real prefix '/usr' 08:23:07 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:23:08 INFO - Installing distribute.............................................................................................................................................................................................done. 08:23:10 INFO - Installing pip.................done. 08:23:10 INFO - Return code: 0 08:23:10 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:23:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:23:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:23:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:23:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:23:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9305377f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20bd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21885a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2217410>, '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 0x2218310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22187a0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1462546946.797051-141093476', '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:23:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:23:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:23:10 INFO - Using env: {'DISPLAY': ':0', 08:23:10 INFO - 'HOME': '/home/cltbld', 08:23:10 INFO - 'LANG': 'en_US.UTF-8', 08:23:10 INFO - 'LANGUAGE': 'en_US:en', 08:23:10 INFO - 'LOGNAME': 'cltbld', 08:23:10 INFO - 'MAIL': '/var/mail/cltbld', 08:23:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:23:10 INFO - 'MOZ_NO_REMOTE': '1', 08:23:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:23:10 INFO - 'NO_EM_RESTART': '1', 08:23:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:23:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:23:10 INFO - 'PWD': '/builds/slave/test', 08:23:10 INFO - 'SHELL': '/bin/bash', 08:23:10 INFO - 'SHLVL': '1', 08:23:10 INFO - 'TERM': 'linux', 08:23:10 INFO - 'TMOUT': '86400', 08:23:10 INFO - 'USER': 'cltbld', 08:23:10 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1462546946.797051-141093476', 08:23:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:23:10 INFO - '_': '/tools/buildbot/bin/python'} 08:23:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:23:10 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:23:10 INFO - Cleaning up... 08:23:10 INFO - Return code: 0 08:23:10 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 08:23:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:23:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:23:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:23:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:23:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f9305377f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20bd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21885a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2217410>, '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 0x2218310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22187a0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1462546946.797051-141093476', '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:23:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 08:23:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 08:23:10 INFO - Using env: {'DISPLAY': ':0', 08:23:10 INFO - 'HOME': '/home/cltbld', 08:23:10 INFO - 'LANG': 'en_US.UTF-8', 08:23:10 INFO - 'LANGUAGE': 'en_US:en', 08:23:10 INFO - 'LOGNAME': 'cltbld', 08:23:10 INFO - 'MAIL': '/var/mail/cltbld', 08:23:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:23:10 INFO - 'MOZ_NO_REMOTE': '1', 08:23:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:23:10 INFO - 'NO_EM_RESTART': '1', 08:23:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:23:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:23:10 INFO - 'PWD': '/builds/slave/test', 08:23:10 INFO - 'SHELL': '/bin/bash', 08:23:10 INFO - 'SHLVL': '1', 08:23:10 INFO - 'TERM': 'linux', 08:23:10 INFO - 'TMOUT': '86400', 08:23:10 INFO - 'USER': 'cltbld', 08:23:10 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1462546946.797051-141093476', 08:23:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:23:10 INFO - '_': '/tools/buildbot/bin/python'} 08:23:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:23:10 INFO - Downloading/unpacking psutil>=0.7.1 08:23:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:23:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:23:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:23:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:23:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:23:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:23:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:23:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:23:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:23:12 INFO - Installing collected packages: psutil 08:23:12 INFO - Running setup.py install for psutil 08:23:13 INFO - building 'psutil._psutil_linux' extension 08:23:13 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:23:14 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:23:14 INFO - building 'psutil._psutil_posix' extension 08:23:14 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:23:14 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:23:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:23:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:23:14 INFO - Successfully installed psutil 08:23:14 INFO - Cleaning up... 08:23:14 INFO - Return code: 0 08:23:14 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 08:23:14 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:23:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:23:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:14 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:23:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:23:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:14 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 0x7f9305377f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20bd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21885a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2217410>, '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 0x2218310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22187a0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1462546946.797051-141093476', '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:23:14 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:23:14 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:23:14 INFO - Using env: {'DISPLAY': ':0', 08:23:14 INFO - 'HOME': '/home/cltbld', 08:23:14 INFO - 'LANG': 'en_US.UTF-8', 08:23:14 INFO - 'LANGUAGE': 'en_US:en', 08:23:14 INFO - 'LOGNAME': 'cltbld', 08:23:14 INFO - 'MAIL': '/var/mail/cltbld', 08:23:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:23:14 INFO - 'MOZ_NO_REMOTE': '1', 08:23:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:23:14 INFO - 'NO_EM_RESTART': '1', 08:23:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:23:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:23:14 INFO - 'PWD': '/builds/slave/test', 08:23:14 INFO - 'SHELL': '/bin/bash', 08:23:14 INFO - 'SHLVL': '1', 08:23:14 INFO - 'TERM': 'linux', 08:23:14 INFO - 'TMOUT': '86400', 08:23:14 INFO - 'USER': 'cltbld', 08:23:14 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1462546946.797051-141093476', 08:23:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:23:14 INFO - '_': '/tools/buildbot/bin/python'} 08:23:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:23:15 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 08:23:15 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:23:15 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:23:15 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:23:15 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:23:15 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:23:15 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:23:17 INFO - Downloading mozsystemmonitor-0.0.tar.gz 08:23:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:23:17 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:23:17 INFO - Installing collected packages: mozsystemmonitor 08:23:17 INFO - Running setup.py install for mozsystemmonitor 08:23:17 INFO - Successfully installed mozsystemmonitor 08:23:17 INFO - Cleaning up... 08:23:17 INFO - Return code: 0 08:23:17 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:23:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:23:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:23:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:23:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:23:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:17 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 0x7f9305377f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20bd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21885a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2217410>, '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 0x2218310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22187a0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1462546946.797051-141093476', '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:23:17 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:23:17 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:23:17 INFO - Using env: {'DISPLAY': ':0', 08:23:17 INFO - 'HOME': '/home/cltbld', 08:23:17 INFO - 'LANG': 'en_US.UTF-8', 08:23:17 INFO - 'LANGUAGE': 'en_US:en', 08:23:17 INFO - 'LOGNAME': 'cltbld', 08:23:17 INFO - 'MAIL': '/var/mail/cltbld', 08:23:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:23:17 INFO - 'MOZ_NO_REMOTE': '1', 08:23:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:23:17 INFO - 'NO_EM_RESTART': '1', 08:23:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:23:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:23:17 INFO - 'PWD': '/builds/slave/test', 08:23:17 INFO - 'SHELL': '/bin/bash', 08:23:17 INFO - 'SHLVL': '1', 08:23:17 INFO - 'TERM': 'linux', 08:23:17 INFO - 'TMOUT': '86400', 08:23:17 INFO - 'USER': 'cltbld', 08:23:17 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1462546946.797051-141093476', 08:23:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:23:17 INFO - '_': '/tools/buildbot/bin/python'} 08:23:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:23:17 INFO - Downloading/unpacking blobuploader==1.2.4 08:23:17 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:23:17 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:23:17 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:23:17 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:23:17 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:23:17 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:23:19 INFO - Downloading blobuploader-1.2.4.tar.gz 08:23:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:23:19 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:23:19 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:23:19 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:23:19 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:23:19 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:23:19 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:23:19 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:23:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:23:19 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:23:19 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:23:19 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:23:19 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:23:19 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:23:19 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:23:19 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:23:20 INFO - Downloading docopt-0.6.1.tar.gz 08:23:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:23:20 INFO - Installing collected packages: blobuploader, requests, docopt 08:23:20 INFO - Running setup.py install for blobuploader 08:23:20 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:23:20 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:23:20 INFO - Running setup.py install for requests 08:23:20 INFO - Running setup.py install for docopt 08:23:20 INFO - Successfully installed blobuploader requests docopt 08:23:20 INFO - Cleaning up... 08:23:20 INFO - Return code: 0 08:23:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:23:20 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:23:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:23:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:20 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:23:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:23:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:20 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 0x7f9305377f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20bd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21885a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2217410>, '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 0x2218310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22187a0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1462546946.797051-141093476', '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:23:20 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:23:20 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:23:20 INFO - Using env: {'DISPLAY': ':0', 08:23:20 INFO - 'HOME': '/home/cltbld', 08:23:20 INFO - 'LANG': 'en_US.UTF-8', 08:23:20 INFO - 'LANGUAGE': 'en_US:en', 08:23:20 INFO - 'LOGNAME': 'cltbld', 08:23:20 INFO - 'MAIL': '/var/mail/cltbld', 08:23:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:23:20 INFO - 'MOZ_NO_REMOTE': '1', 08:23:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:23:20 INFO - 'NO_EM_RESTART': '1', 08:23:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:23:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:23:20 INFO - 'PWD': '/builds/slave/test', 08:23:20 INFO - 'SHELL': '/bin/bash', 08:23:20 INFO - 'SHLVL': '1', 08:23:20 INFO - 'TERM': 'linux', 08:23:20 INFO - 'TMOUT': '86400', 08:23:20 INFO - 'USER': 'cltbld', 08:23:20 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1462546946.797051-141093476', 08:23:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:23:20 INFO - '_': '/tools/buildbot/bin/python'} 08:23:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:23:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:23:20 INFO - Running setup.py (path:/tmp/pip-xu6zGr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:23:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:23:20 INFO - Running setup.py (path:/tmp/pip-RE1GA1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:23:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:23:21 INFO - Running setup.py (path:/tmp/pip-kzwJpk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:23:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:23:21 INFO - Running setup.py (path:/tmp/pip-NP8CMa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:23:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:23:21 INFO - Running setup.py (path:/tmp/pip-yoYMpQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:23:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:23:21 INFO - Running setup.py (path:/tmp/pip-1IqMha-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:23:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:23:21 INFO - Running setup.py (path:/tmp/pip-pUAxlA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:23:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:23:21 INFO - Running setup.py (path:/tmp/pip-9ye0P2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:23:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:23:21 INFO - Running setup.py (path:/tmp/pip-Iv5a37-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:23:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:23:21 INFO - Running setup.py (path:/tmp/pip-MAusvz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:23:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:23:21 INFO - Running setup.py (path:/tmp/pip-cgC3n8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:23:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:23:21 INFO - Running setup.py (path:/tmp/pip-kJqHbl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:23:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:23:21 INFO - Running setup.py (path:/tmp/pip-lJBpct-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:23:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:23:21 INFO - Running setup.py (path:/tmp/pip-tyDeeb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:23:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:23:21 INFO - Running setup.py (path:/tmp/pip-x7AU49-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:23:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:23:21 INFO - Running setup.py (path:/tmp/pip-schxAg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:23:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:23:22 INFO - Running setup.py (path:/tmp/pip-OR_lcw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:23:22 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:23:22 INFO - Running setup.py install for manifestparser 08:23:22 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:23:22 INFO - Running setup.py install for mozcrash 08:23:22 INFO - Running setup.py install for mozdebug 08:23:22 INFO - Running setup.py install for mozdevice 08:23:22 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:23:22 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:23:22 INFO - Running setup.py install for mozfile 08:23:22 INFO - Running setup.py install for mozhttpd 08:23:22 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:23:22 INFO - Running setup.py install for mozinfo 08:23:22 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:23:22 INFO - Running setup.py install for mozInstall 08:23:22 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:23:22 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:23:22 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:23:22 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:23:22 INFO - Running setup.py install for mozleak 08:23:23 INFO - Running setup.py install for mozlog 08:23:23 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:23:23 INFO - Running setup.py install for moznetwork 08:23:23 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:23:23 INFO - Running setup.py install for mozprocess 08:23:23 INFO - Running setup.py install for mozprofile 08:23:23 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:23:23 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:23:23 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:23:23 INFO - Running setup.py install for mozrunner 08:23:23 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:23:23 INFO - Running setup.py install for mozscreenshot 08:23:23 INFO - Running setup.py install for moztest 08:23:23 INFO - Running setup.py install for mozversion 08:23:23 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:23:23 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:23:23 INFO - Cleaning up... 08:23:23 INFO - Return code: 0 08:23:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:23:23 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:23:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:23:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:23 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:23:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:23:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:23 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 0x7f9305377f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20bd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21885a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2217410>, '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 0x2218310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22187a0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1462546946.797051-141093476', '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:23:23 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:23:23 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:23:23 INFO - Using env: {'DISPLAY': ':0', 08:23:23 INFO - 'HOME': '/home/cltbld', 08:23:23 INFO - 'LANG': 'en_US.UTF-8', 08:23:23 INFO - 'LANGUAGE': 'en_US:en', 08:23:23 INFO - 'LOGNAME': 'cltbld', 08:23:23 INFO - 'MAIL': '/var/mail/cltbld', 08:23:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:23:23 INFO - 'MOZ_NO_REMOTE': '1', 08:23:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:23:23 INFO - 'NO_EM_RESTART': '1', 08:23:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:23:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:23:23 INFO - 'PWD': '/builds/slave/test', 08:23:23 INFO - 'SHELL': '/bin/bash', 08:23:23 INFO - 'SHLVL': '1', 08:23:23 INFO - 'TERM': 'linux', 08:23:23 INFO - 'TMOUT': '86400', 08:23:23 INFO - 'USER': 'cltbld', 08:23:23 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1462546946.797051-141093476', 08:23:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:23:23 INFO - '_': '/tools/buildbot/bin/python'} 08:23:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:23:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:23:24 INFO - Running setup.py (path:/tmp/pip-5wsjwK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:23:24 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:23:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:23:24 INFO - Running setup.py (path:/tmp/pip-WIyqbb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:23:24 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:23:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:23:24 INFO - Running setup.py (path:/tmp/pip-R5xeOP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:23:24 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:23:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:23:24 INFO - Running setup.py (path:/tmp/pip-a6ZRXf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:23:24 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:23:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:23:24 INFO - Running setup.py (path:/tmp/pip-YKrGNN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:23:24 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:23:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:23:24 INFO - Running setup.py (path:/tmp/pip-gqN5YG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:23:24 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:23:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:23:24 INFO - Running setup.py (path:/tmp/pip-BGEtNk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:23:24 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:23:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:23:24 INFO - Running setup.py (path:/tmp/pip-1aQRYi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:23:24 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:23:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:23:24 INFO - Running setup.py (path:/tmp/pip-Jd6KHF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:23:24 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:23:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:23:24 INFO - Running setup.py (path:/tmp/pip-XsSUff-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:23:24 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:23:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:23:24 INFO - Running setup.py (path:/tmp/pip-K05wVA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:23:24 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:23:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:23:24 INFO - Running setup.py (path:/tmp/pip-74gP0R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:23:25 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:23:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:23:25 INFO - Running setup.py (path:/tmp/pip-Skqf4a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:23:25 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:23:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:23:25 INFO - Running setup.py (path:/tmp/pip-I7pbfR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:23:25 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:23:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:23:25 INFO - Running setup.py (path:/tmp/pip-pdFBJe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:23:25 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:23:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:23:25 INFO - Running setup.py (path:/tmp/pip-8nfHwp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:23:25 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:23:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:23:25 INFO - Running setup.py (path:/tmp/pip-hNUYNA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:23:25 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:23:25 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:23:25 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:23:25 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:23:25 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:23:25 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:23:25 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:23: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:23: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:23: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:23: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:23: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:23: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:23:27 INFO - Downloading blessings-1.6.tar.gz 08:23:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:23:27 INFO - Installing collected packages: blessings 08:23:27 INFO - Running setup.py install for blessings 08:23:27 INFO - Successfully installed blessings 08:23:27 INFO - Cleaning up... 08:23:27 INFO - Return code: 0 08:23:27 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:23:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:23:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:23:27 INFO - Reading from file tmpfile_stdout 08:23:27 INFO - Current package versions: 08:23:27 INFO - argparse == 1.2.1 08:23:27 INFO - blessings == 1.6 08:23:27 INFO - blobuploader == 1.2.4 08:23:27 INFO - docopt == 0.6.1 08:23:27 INFO - manifestparser == 1.1 08:23:27 INFO - mozInstall == 1.12 08:23:27 INFO - mozcrash == 0.17 08:23:27 INFO - mozdebug == 0.1 08:23:27 INFO - mozdevice == 0.48 08:23:27 INFO - mozfile == 1.2 08:23:27 INFO - mozhttpd == 0.7 08:23:27 INFO - mozinfo == 0.9 08:23:27 INFO - mozleak == 0.1 08:23:27 INFO - mozlog == 3.1 08:23:27 INFO - moznetwork == 0.27 08:23:27 INFO - mozprocess == 0.22 08:23:27 INFO - mozprofile == 0.28 08:23:27 INFO - mozrunner == 6.11 08:23:27 INFO - mozscreenshot == 0.1 08:23:27 INFO - mozsystemmonitor == 0.0 08:23:27 INFO - moztest == 0.7 08:23:27 INFO - mozversion == 1.4 08:23:27 INFO - psutil == 3.1.1 08:23:27 INFO - requests == 1.2.3 08:23:27 INFO - wsgiref == 0.1.2 08:23:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:23: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:23:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:23:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23: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:23:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:23:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:27 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 0x7f9305377f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20bd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21885a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2217410>, '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 0x2218310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22187a0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1462546946.797051-141093476', '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:23:27 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:23:27 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:23:27 INFO - Using env: {'DISPLAY': ':0', 08:23:27 INFO - 'HOME': '/home/cltbld', 08:23:27 INFO - 'LANG': 'en_US.UTF-8', 08:23:27 INFO - 'LANGUAGE': 'en_US:en', 08:23:27 INFO - 'LOGNAME': 'cltbld', 08:23:27 INFO - 'MAIL': '/var/mail/cltbld', 08:23:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:23:27 INFO - 'MOZ_NO_REMOTE': '1', 08:23:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:23:27 INFO - 'NO_EM_RESTART': '1', 08:23:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:23:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:23:27 INFO - 'PWD': '/builds/slave/test', 08:23:27 INFO - 'SHELL': '/bin/bash', 08:23:27 INFO - 'SHLVL': '1', 08:23:27 INFO - 'TERM': 'linux', 08:23:27 INFO - 'TMOUT': '86400', 08:23:27 INFO - 'USER': 'cltbld', 08:23:27 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1462546946.797051-141093476', 08:23:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:23:27 INFO - '_': '/tools/buildbot/bin/python'} 08:23:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:23:27 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:23:27 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:23:27 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:23:27 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:23:27 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:23:27 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:23:27 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:23:27 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:23:27 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:23:27 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:23:27 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:23:27 INFO - Cleaning up... 08:23:27 INFO - Return code: 0 08:23:27 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:23: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:23:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:23:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23: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:23:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:23:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9305377f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20bd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21885a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2217410>, '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 0x2218310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22187a0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1462546946.797051-141093476', '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:23: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', 'jsonschema'] in /builds/slave/test/build 08:23: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 jsonschema 08:23:27 INFO - Using env: {'DISPLAY': ':0', 08:23:27 INFO - 'HOME': '/home/cltbld', 08:23:27 INFO - 'LANG': 'en_US.UTF-8', 08:23:27 INFO - 'LANGUAGE': 'en_US:en', 08:23:27 INFO - 'LOGNAME': 'cltbld', 08:23:27 INFO - 'MAIL': '/var/mail/cltbld', 08:23:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:23:27 INFO - 'MOZ_NO_REMOTE': '1', 08:23:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:23:27 INFO - 'NO_EM_RESTART': '1', 08:23:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:23:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:23:27 INFO - 'PWD': '/builds/slave/test', 08:23:27 INFO - 'SHELL': '/bin/bash', 08:23:27 INFO - 'SHLVL': '1', 08:23:27 INFO - 'TERM': 'linux', 08:23:27 INFO - 'TMOUT': '86400', 08:23:27 INFO - 'USER': 'cltbld', 08:23:27 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1462546946.797051-141093476', 08:23:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:23:27 INFO - '_': '/tools/buildbot/bin/python'} 08:23:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:23:28 INFO - Downloading/unpacking jsonschema 08:23:28 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:23:28 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:23:28 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:23:28 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:23:28 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:23:28 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:23:30 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:23:30 INFO - Downloading/unpacking functools32 (from jsonschema) 08:23: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:23: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:23: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:23: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:23: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:23: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:23:30 INFO - Downloading functools32-3.2.3-2.tar.gz 08:23:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:23:30 INFO - warning: no files found matching '*.txt' 08:23:30 INFO - no previously-included directories found matching 'build' 08:23:30 INFO - no previously-included directories found matching 'dist' 08:23:30 INFO - no previously-included directories found matching '.git*' 08:23:30 INFO - Installing collected packages: jsonschema, functools32 08:23:30 INFO - Running setup.py install for functools32 08:23:30 INFO - warning: no files found matching '*.txt' 08:23:30 INFO - no previously-included directories found matching 'build' 08:23:30 INFO - no previously-included directories found matching 'dist' 08:23:30 INFO - no previously-included directories found matching '.git*' 08:23:30 INFO - Successfully installed jsonschema functools32 08:23:30 INFO - Cleaning up... 08:23:30 INFO - Return code: 0 08:23:30 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 08:23:30 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:23:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:23:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:30 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:23:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:23:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:30 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 0x7f9305377f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20bd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21885a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2217410>, '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 0x2218310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22187a0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1462546946.797051-141093476', '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:23:30 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:23:30 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:23:30 INFO - Using env: {'DISPLAY': ':0', 08:23:30 INFO - 'HOME': '/home/cltbld', 08:23:30 INFO - 'LANG': 'en_US.UTF-8', 08:23:30 INFO - 'LANGUAGE': 'en_US:en', 08:23:30 INFO - 'LOGNAME': 'cltbld', 08:23:30 INFO - 'MAIL': '/var/mail/cltbld', 08:23:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:23:30 INFO - 'MOZ_NO_REMOTE': '1', 08:23:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:23:30 INFO - 'NO_EM_RESTART': '1', 08:23:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:23:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:23:30 INFO - 'PWD': '/builds/slave/test', 08:23:30 INFO - 'SHELL': '/bin/bash', 08:23:30 INFO - 'SHLVL': '1', 08:23:30 INFO - 'TERM': 'linux', 08:23:30 INFO - 'TMOUT': '86400', 08:23:30 INFO - 'USER': 'cltbld', 08:23:30 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1462546946.797051-141093476', 08:23:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:23:30 INFO - '_': '/tools/buildbot/bin/python'} 08:23:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:23:30 INFO - Downloading/unpacking flake8 08:23: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:23: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:23: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:23: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:23: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:23: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:23:32 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:23:32 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:23: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:23: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:23: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:23: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:23: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:23: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:23:32 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:23:32 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:23: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:23: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:23: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:23: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:23: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:23: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:23:33 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:23:33 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:23:33 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:23:33 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:23:33 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:23:33 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:23:33 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:23:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 08:23:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:23:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:23:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:23:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:23:33 INFO - no previously-included directories found matching 'docs/_build' 08:23:33 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:23:33 INFO - Running setup.py install for pep8 08:23:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:23:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:23:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:23:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:23:33 INFO - no previously-included directories found matching 'docs/_build' 08:23:33 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 08:23:33 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:23:33 INFO - Cleaning up... 08:23:33 INFO - Return code: 0 08:23:33 INFO - Running post-action listener: _resource_record_post_action 08:23:33 INFO - Running post-action listener: _start_resource_monitoring 08:23:33 INFO - Starting resource monitoring. 08:23:33 INFO - ##### 08:23:33 INFO - ##### Finished create-virtualenv step (success) 08:23:33 INFO - ##### 08:23:33 INFO - ##### 08:23:33 INFO - ##### Running install step. 08:23:33 INFO - ##### 08:23:33 INFO - Running pre-action listener: _resource_record_pre_action 08:23:33 INFO - Running main action method: install 08:23:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:23:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:23:33 INFO - Reading from file tmpfile_stdout 08:23:33 INFO - Detecting whether we're running mozinstall >=1.0... 08:23:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:23:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:23:33 INFO - Reading from file tmpfile_stdout 08:23:33 INFO - Output received: 08:23:33 INFO - Usage: mozinstall [options] installer 08:23:33 INFO - Options: 08:23:33 INFO - -h, --help show this help message and exit 08:23:33 INFO - -d DEST, --destination=DEST 08:23:33 INFO - Directory to install application into. [default: 08:23:33 INFO - "/builds/slave/test"] 08:23:33 INFO - --app=APP Application being installed. [default: firefox] 08:23:33 INFO - mkdir: /builds/slave/test/build/application 08:23:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 08:23:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 08:23:50 INFO - Reading from file tmpfile_stdout 08:23:50 INFO - Output received: 08:23:50 INFO - /builds/slave/test/build/application/firefox/firefox 08:23:50 INFO - Running post-action listener: _resource_record_post_action 08:23:50 INFO - ##### 08:23:50 INFO - ##### Finished install step (success) 08:23:50 INFO - ##### 08:23:50 INFO - ##### 08:23:50 INFO - ##### Running run-tests step. 08:23:50 INFO - ##### 08:23:50 INFO - Running pre-action listener: _resource_record_pre_action 08:23:50 INFO - Running main action method: run_tests 08:23:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:23:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:23:50 INFO - Python 2.7.3 08:23:50 INFO - Return code: 0 08:23:50 INFO - grabbing minidump binary from tooltool 08:23:50 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:23:50 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 0x2217410>, '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 0x2218310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22187a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:23:50 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:23:50 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:23:50 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:23:50 INFO - Return code: 0 08:23:50 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:23:50 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:23:50 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:23:50 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:23:50 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:23:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 08:23:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 08:23:51 INFO - Return code: 0 08:23:51 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/NFQ2NwvDQIKh3tZ4u3cv8A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--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:23:51 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/NFQ2NwvDQIKh3tZ4u3cv8A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-012 --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:23:51 INFO - Using env: {'DISPLAY': ':0', 08:23:51 INFO - 'HOME': '/home/cltbld', 08:23:51 INFO - 'LANG': 'en_US.UTF-8', 08:23:51 INFO - 'LANGUAGE': 'en_US:en', 08:23:51 INFO - 'LOGNAME': 'cltbld', 08:23:51 INFO - 'MAIL': '/var/mail/cltbld', 08:23:51 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:23:51 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:23:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:23:51 INFO - 'MOZ_NO_REMOTE': '1', 08:23:51 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:23:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:23:51 INFO - 'NO_EM_RESTART': '1', 08:23:51 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:23:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:23:51 INFO - 'PWD': '/builds/slave/test', 08:23:51 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:23:51 INFO - 'SHELL': '/bin/bash', 08:23:51 INFO - 'SHLVL': '1', 08:23:51 INFO - 'TERM': 'linux', 08:23:51 INFO - 'TMOUT': '86400', 08:23:51 INFO - 'USER': 'cltbld', 08:23:51 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1462546946.797051-141093476', 08:23:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:23:51 INFO - '_': '/tools/buildbot/bin/python'} 08:23:51 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/NFQ2NwvDQIKh3tZ4u3cv8A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--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:23:51 INFO - mozversion application_buildid: 20160506053330 08:23:51 INFO - mozversion application_changeset: 9d202f109312b37f42224c55724ea845a4b86c23 08:23:51 INFO - mozversion application_display_name: Nightly 08:23:51 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:23:51 INFO - mozversion application_name: Firefox 08:23:51 INFO - mozversion application_remotingname: firefox 08:23:51 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 08:23:51 INFO - mozversion application_vendor: Mozilla 08:23:51 INFO - mozversion application_version: 49.0a1 08:23:51 INFO - mozversion platform_buildid: 20160506053330 08:23:51 INFO - mozversion platform_changeset: 9d202f109312b37f42224c55724ea845a4b86c23 08:23:51 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 08:23:51 INFO - mozversion platform_version: 49.0a1 08:23:51 INFO - using testdate: 1462548231 08:23:51 INFO - actual date: 1462548231 08:23:51 INFO - starting webserver on 'localhost:54976' 08:23:51 INFO - SUITE-START | Running 2 tests 08:23:51 INFO - TEST-START | dromaeo_css 08:23:51 INFO - operating with platform_type : linux_ 08:23:51 INFO - Initialising browser for dromaeo_css test... 08:23:51 INFO - TEST-INFO | started process 3290 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpo6ozEb/profile http://localhost:54976/getInfo.html) 08:23:56 INFO - PROCESS | 3290 | 08:23:56 INFO - PROCESS | 3290 | (process:3359): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 08:23:57 INFO - PROCESS | 3290 | __metrics Screen width/height:1600/1200 08:23:57 INFO - PROCESS | 3290 | colorDepth:24 08:23:57 INFO - PROCESS | 3290 | Browser inner width/height: 1024/697 08:23:57 INFO - PROCESS | 3290 | __metrics 08:23:57 ERROR - PROCESS | 3290 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 08:23:58 INFO - TEST-INFO | 3290: exit 0 08:23:58 INFO - Browser initialized. 08:23:58 INFO - Running cycle 1/1 for dromaeo_css test... 08:23:58 INFO - TEST-INFO | started process 3410 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpo6ozEb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:24:00 INFO - PROCESS | 3410 | 08:24:00 INFO - PROCESS | 3410 | (process:3471): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 08:24:10 INFO - PROCESS | 3410 | RSS: Main: 163745792 08:24:10 INFO - PROCESS | 3410 | 08:25:00 INFO - PROCESS | 3410 | 1462548300071 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:27:08 INFO - PROCESS | 3410 | Cycle 1(1): loaded http://localhost:54976/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54976/tests/dromaeo/cssquery-ext.html) 08:27:09 INFO - PROCESS | 3410 | RSS: Main: 165126144 08:27:09 INFO - PROCESS | 3410 | 08:30:10 INFO - PROCESS | 3410 | Cycle 1(1): loaded http://localhost:54976/tests/dromaeo/cssquery-ext.html (next: http://localhost:54976/tests/dromaeo/cssquery-jquery.html) 08:30:11 INFO - PROCESS | 3410 | RSS: Main: 167034880 08:30:11 INFO - PROCESS | 3410 | 08:33:13 INFO - PROCESS | 3410 | Cycle 1(1): loaded http://localhost:54976/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54976/tests/dromaeo/cssquery-mootools.html) 08:33:14 INFO - PROCESS | 3410 | RSS: Main: 168026112 08:33:14 INFO - PROCESS | 3410 | 08:36:15 INFO - PROCESS | 3410 | Cycle 1(1): loaded http://localhost:54976/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54976/tests/dromaeo/cssquery-prototype.html) 08:36:16 INFO - PROCESS | 3410 | RSS: Main: 165564416 08:36:16 INFO - PROCESS | 3410 | 08:39:18 INFO - PROCESS | 3410 | Cycle 1(1): loaded http://localhost:54976/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54976/tests/dromaeo/cssquery-yui.html) 08:39:19 INFO - PROCESS | 3410 | RSS: Main: 166572032 08:39:19 INFO - PROCESS | 3410 | 08:42:21 INFO - PROCESS | 3410 | Cycle 1(1): loaded http://localhost:54976/tests/dromaeo/cssquery-yui.html (next: http://localhost:54976/tests/dromaeo/cssquery-dojo.html) 08:42:22 INFO - PROCESS | 3410 | RSS: Main: 168775680 08:42:22 INFO - PROCESS | 3410 | 08:42:22 INFO - PROCESS | 3410 | __start_tp_report 08:42:22 INFO - PROCESS | 3410 | _x_x_mozilla_page_load 08:42:22 INFO - PROCESS | 3410 | _x_x_mozilla_page_load_details 08:42:22 INFO - PROCESS | 3410 | |i|pagename|runs| 08:42:22 INFO - PROCESS | 3410 | |0;dojo.html;3188.936221275576;3192.760542959278;3212.8393580320994;3217.951730724038;3254.446744053511;5481.643693159942;5494.835154945348;5572.164175373696;5602.495775380215;5617.354004289508;5419.701916394597;5477.67133971961;5513.2005859150395;5554.86112847179;5598.1322894951345;4947.925781113287;5010.0981823271795;5058.367704036996;5156.149235376159;5173.482651734834;5066.088104141253;5185.274061631375;5203.063448579254;5203.739813009334;5211.661242019276;4957.206846904514;4997.725125118117;5034.219695947134;5057.26669632903;5062.215356619711;5032.370953630796;5041.067402530543;5041.8487445376695;5049.722265275408;5106.08090543702;5015.1975683890405;5031.547160755513;5046.84859454217;5047.899042019139;5048.899022019576;5269.973650131763;5385.596080293954;5386;5451.100568406208;5499.532539734128;5954.07711804671;5957.374475680034;5961.91057134139;5973.492253158487;5977.521798256129;5842.182094506772;6021.277446706424;6031.728572214217;6036.728347224385;6040.154378387029;5546.029444847136;5577.52591029763;5591.496765291144;5592.552595792326;5627.5779316551425;6065;6099.84750381244;6102.69486525672;6119.418655227746;6129.601575897642;5698.544116470673;5835.4748072673665;5860.2967643883;5863.912041319383;5865.824025279248;5950.583459157904;6029.336772954972;6032.849178770566;6037.305709843336;6082.118092876508;5786.623869448556;5933.406659334032;5978.04351303798;5998.49012833914;6013.368596297413;5733.541316694655;5972.880542389128;6011.338752737195;6032.4570788629235;6065.696715164224;4330.39374487572;4379.912401751947;4400.44994375703;4411.823527058882;4421.270490369117;3933.331333673282;3939.6651284641125;3946.151577410813;3979.3633018716864;3997.340438827619;5542.8337149885565;5553.6390134641115;5572.3870374258795;5599.7480113394995;5649.4633009864;6015.308239552507;6019.428154325332;6031.60794548353;6044.123602077674;6083.270007599116;5692.686902220417;5709.229254050733;5714.371419143891;5720.542356611461;5722.828315150552;4968.925466118011;4984.352034235599;5026.421961474477;5049.419316778544;5137.537621614073;6023.186869772612;6041.2750469943885;6056.515478761688;6081.483073938764;6083.300420451705;5859.619124756877;5899.144624029577;5902.291724993029;5902.6458412495385;5910.024845900378;5947.494462970523;6109.131392048963;6135.785247516315;6173.506119510518;6233.96883015582;5942;5944.227250457413;5949.6430214187285;5957.702114894325;5992.340842507234;5888.528917686661;6072.574919755575;6072.878542429038;6076.665783381956;6084.330723620486;5697.572682048946;5738.713064346849;5750.25246717924;5786.623869448473;5789.044807606698;5691.971540142273;5770.2498675171955;5772.249607550992;5873;5879.764809407576;5717.628354156966;5730.885382292247;5780.364159942487;5784.855378615568;5797.043487824461;5611.438856114519;5741.942580574141;5796.681182535001;5855.443732845373;5857.824265272048;5711.208508474156;5742.684152371659;5748.712564371848;5758.654480731169;5770.422957704364 08:42:22 INFO - PROCESS | 3410 | |1;ext.html;602.6805792929746;623.731795328009;637.544155928511;637.9649119298437;677.9966100169498;37292.25415491692;41307;41511;41705.374419383734;41738.582614173814;40718;41198.73406962616;41361.793191034005;41373.37939930904;41390.7930460348;8778.604962776675;8809.559522023905;8829.470231786081;8845.690400835972;8893.599788009522;8671.826563468727;8793.03276639569;8831.072737362581;8836.248918841906;8843.60203790831;8863.601137948775;8880.1563851434;8913.1978121969;8914.331425143107;8923.286137109048;8752.124787521261;8779.736607901774;8831.205191532761;8864.246539044188;8882.733517994471;8704.608292626846;8808.03111657717;8809.515476648781;8809.72259022438;8824.514651694155;38698.41952370717;38849.417258741145;38872.41691374632;38893.94378730747;38982.80508597439;3850.2107068051264;3868.78721670308;3940.4483372327895;3967.5238971323624;4445.199864024475;31085.22286942822;31558.684413156032;31614.209644758834;31913.680863191534;33452;4141.088960428701;4277.841219403226;4383.868483945486;4387.736735795863;4420.491643461011;322545.93635159073;323575;325054;326060;327098;60629.39370606326;60720.39279607147;61043.69478152581;61063.694681527195;61195;36702.8164859174;37348.43977340342;37441;38803.80598096991;64043.35956640374;17097.230624621923;17187.65624687499;17387.56531086733;17406.21672024762;17418.82581174172;13293.335333233299;13358.39887205078;13471.259080750457;13488.460461581426;13492.662683432796;18520.81479185218;18660.720089198672;18720.90639546821;19035.524111897314;19141.2343506261;7265.164506081763;7294.781156565312;7316.414686825041;7333.669984850694;7460.701571937062;1057.4025675493322;1104.5526561742506;1105.9944700276446;1137.397179494869;1208.0215025829107;31608.683913160574;31858.68141318557;31962.680373196436;31963.20091997672;32554.674453255637;1144.1190283481671;1183.1836033137108;1217.8808872561679;1218.0986070307908;1268.517963173988;16954.91522542404;17121.486355409357;17199.968001919926;17354.913225434044;17356.305747769948;449823;450633;453191;457299;458609;58441.4155858436;58575;58737.41262587405;59065.70467147637;59103;1400.649837540615;1444.0252829340154;1448.8188976377742;1448.9058211216238;1460.2187829511372;29802.85098574493;30969.225769355948;31259.53110703296;31439.84280078585;32151.19622009375;49405.25892111693;49509.75245123752;49619.7519012417;49784.502154977985;50104.49895501144;385668;386038;386088;386562;391359;27557;28511.572326415535;28660.283492912844;28729.281767955134;28756.856215718788;47540;47679;47878;48540.27189592088;48575.75712121417;40801.1839763209;41145.1770964585;41380.58619413767;41590.37614435725;42242;39692.801535992134;40056.599434005286;40785.79607101945;41436.378454323814;41452.37821432621;41240.38139427851;41873.58126418697;42811.14377712366;43028.56971430371;44853.55146448624;35557.64442355543;36943;37025.44461833128;37110.25779484341;38089.4286585707;27877.721222787513;28181.71818281873;28357.858210708815;28565;28770.28074298159 08:42:22 INFO - PROCESS | 3410 | |2;jquery.html;381.2660628290541;382.77225051094604;390.9589493103224;402.5994135834845;402.7804846358734;17802.554936126602;19458.416247512563;19820.70268945967;20117.295894643674;20127.19491220351;18511.722324165148;18818.623627527442;19142;19421.32025379112;19496.317628882993;5495.6153069285065;5660.5471562274915;5698.401667824881;5721.542276617861;5733.512651424634;5610.635308704942;5635.408282130379;5649.1526271059465;5658.377578466366;5674.375818659944;5422.213779002042;5522.254495643077;5573.526250268732;5657;5658.575606829504;5616.3260408751;5616.9157462638095;5620.297462817148;5628.802991895305;5660.037793575102;4954.925676114861;4983.227599722049;5002.649814512985;5069;5069.417017043051;22717.43206419836;22817.543649126925;23137.0745170193;23333.300000999996;23371.53256934869;2246.29241788836;2329.6738456616085;2358.092134528219;2478.306074299181;3063.938721225563;7392.408607311402;7830.647620857075;9792.461414622192;10694.572217111307;13873.930630346884;1997.5505511259996;2020.2626041494748;2038.1032345767962;2040.1431398812535;2091.4039498742786;65181;73894;74109.25890741078;84259;89074.10925890788;10503.579856805642;10527.315724477885;10566.630167944086;10593.364398136137;10611.787764244826;14525.709485810225;14650.853491464948;14660.780088298685;14708.77936830927;14762.63093422673;7917.4560960612125;7945.28492435672;7962.601869906482;8175.305099066646;8191.426600137933;7903.881441778378;7981.321587665114;8045.839083218303;8166.4283500154415;8192.34461243099;4363.847265345697;4512.390827238347;4544.159330523864;4669.976650116796;4703.929441058387;1869.541962219265;1949.2203118752611;1960.6671645506597;1961.7155512450615;1964.3026725512236;981.6711401680517;986.7335819328741;995.4127065031666;1083.5828206140534;1116.7264020315074;18768.24927002932;19112.426627201206;19187.328443504688;19337;19415;1018.3584341864578;1032.7779527401494;1040.604570263295;1040.9063184313297;1065.706930594093;10546.419946902994;10970;11084.722881928017;11091.72270693239;11111.277766945122;402375;429917;431650;432345;433148;90129.1974160513;97083.77704118098;97295;97358;97741;1046.40877903984;1053.9683809485728;1069.909057730086;1091.825307950724;1093.748437859281;16471.34114635401;16771.32914683399;16950.745738814174;17161.485155445356;17306.394276200273;37406;37427.43858842065;38021.429678555396;39974;40133;50975;52820.20769688381;54824.725876370365;55410.72294638501;56092.71953640206;8419.873701894354;8454.66181352739;8466.492010479391;8591.44155629882;8713.695020674246;11738.354390508604;12855.228686278853;12919.418626161658;13035.47858085666;13117.93441032827;10932.508037138507;11364.488598012944;11461.598844040753;11474.598389056342;11506.654800356002;11254.155938304824;11404;11601.477933493183;11604.6518604442;11785.705357366134;11418.543258269909;11558.884411155781;11666.76666466649;11759.588414405454;11943.402829858645;8345.457545259538;8474.61864216124;8534.975802903691;8632.611532480927;8740.431871928304;8881.911180888108;10659.573617055541;11539.36533490666;11655.18413711032;12024.519019239482 08:42:22 INFO - PROCESS | 3410 | |3;mootools.html;1504.375684091102;1512.682336709291;1690.2985261116637;1810.0361108197606;1845.4094689699284;8021.318187954016;8689.565521723913;8708.433951793146;9288;9292.303077269198;8684.392092553524;8903.510306933116;9009.774755631113;9009.954950225256;9026.86459703105;2316.6061769499224;2335.708036495438;2365.077619728307;2367.810575153992;2370.1941339944415;2197.8351623628214;2285.919992800252;2380.7262164851004;2382.8451150675237;2389.2951579284068;2321.6401457774073;2337.1586228957563;2341.0869760793303;2341.730700969393;2363.432776133724;2326.4067662745974;2340.157543284416;2347.9530409391887;2364.030747393569;2364.6334818103223;2328.394617399488;2374.358923090756;2374.6912901322717;2375.7149142102885;2379.3932547200525;8848.203661670415;8930;8937.150970657776;8985.505797181153;9052.547372631341;5289.233061206142;5370;5388.407275199725;5456.945430545723;5461.9453805461835;3452.4993875887853;3562.358775420423;3568.589612194605;3581.6418358164237;3622.3298689742483;1042.9113525350353;1056.746380868586;1069.2568664777982;1069.3209811769505;1109.2789686703707;12446.564370247088;12546.992481202964;12568.74862502754;12568.81146782799;12610.621681349483;4583.449986001635;4672.182368085571;4690.554397332248;4798.136335459651;4810.230363141881;10581.206409519316;10653.733656658645;10660.04059634621;10686.572537098584;10703.892961070445;5360.91958620621;5368.597355198376;5368.704721240291;5376.897735964118;5380.112281473513;4342.305231162999;4813.78337974792;4887.608991280689;5009.7495125243595;5019.924701129486;4099.385092236129;4123.896453688475;4170.374443833389;4184.351425529047;4209.957900420956;1265.7658333208385;1280.219066369514;1288.774464468733;1289.6646871813396;1302.2707283921034;937.6155776131753;1004.0662184168793;1014.2697257974247;1042.0777611813598;1047.3297089862494;5995.100734889714;6079.270487541523;6229.595076320024;6358.205224346957;6496.9929660902635;442.52428639212974;450.9706869053501;1032.5869652139204;1043.666026871409;1092.006274290392;4346.850328906408;4429.82280708768;4465.508794032654;4514.548545145525;4566.269396896547;11049.834252486218;11448.255863368855;11517.48171332292;11569.826452603218;11638.301701897914;10640.680779576625;11048.171387145996;11141.721456963478;11350.318980861175;11393.145514086476;8272.917270827335;8325.417220794487;8381.16188381157;8452.704155354533;8548.016978047479;6177.227846519185;6198.163247961648;6322.46259067966;6356.872862542631;6403.743850246125;9939.403635781877;10269.281150319406;10300.484975751033;10401.179793536252;10415.479226038517;10304.948475257575;10395;10404.167666586503;10520.263581549218;10572.788544228919;7190.06529151207;7848.725294614889;7958.164392738679;8073.313768329758;8099.190080992089;9001.594928228114;9036.954815225881;9037.909620903969;9108.362414630912;9127.178553930178;7925.960370198112;7966.561839098905;8035.477693949874;8065.435419520812;8162;8055.83888322242;8063.435559510778;8072.959635202022;8113.066997295151;8233.094359620556;7087;7270.200277969525;7323.707051718085;7382.114146302478;7466.813329666802;5324.361076670824;5359.490848369399;5384.111621582395;5389.568834493152;5403.0544654686055;5397.892042159214;5574.136008918624;5584.553235741212;5705.286839145107;5793.333766616893 08:42:22 INFO - PROCESS | 3410 | |4;prototype.html;343.38019874127195;344.63812996353823;346.29010528416757;348.2912273523379;349;5558.722063896809;5587.7485513151905;5605.1974012993505;5651.745671444784;5653.717314134297;5600.6079574429805;5604.663720176793;5612.719364031792;5634.098544232924;5670.744816483258;3906.746061505993;4070.2470043041985;4217.36739489076;4251.702380833343;4308.0737641407095;4221.256183480731;4274.252005898971;4288.442502474674;4295.463067116611;4301.397804307384;4246.171996460692;4259.275923093066;4266.253405653998;4275.187714334266;4278.930267433142;4176.352665336847;4277.828886844538;4288.849890253826;4300.763458009824;4305.9784701076605;3817.8854634361014;3831.547809401985;3831.6589193782233;3834.9041273968096;3843.865464708722;5340.439253878365;5346.625736198468;5348.51863332298;5397.595180361449;5452.972735136339;4820.903581928377;4964.131277026506;4984.102861484931;5003.099442100421;5016.54851063406;5776.653400795965;5784.479396854304;5793.246877905887;5800.651960882361;5806.912896306559;4208.158368326316;4217.641500472463;4223.957760422387;4224.408582798411;4250.553691862341;5872.618279811799;6002.579819412686;6028.7588496460085;6059.878802423971;6095.573309868311;4264.424302719093;4289.056407590325;4291.596705844737;4297.333913243452;4297.419848320436;4337.284348082531;4339.869803905888;4356.259435895905;4362.389265502832;4367.170237654836;4805.8558243252055;4904.455096644546;5003.449620541737;5014.222795466709;5033.892543640393;5812;5814.186013958049;5844.925051606619;5875.504075075323;5886.529077673776;1455.8689717925438;1459.1318165691396;1468.194121230892;1474.5328398243603;1475.9926200369143;976.7655762616921;1016.6340117557673;1018.6638409324905;1021.1218352217236;1022.4325499347784;5434.831511225106;5435.673859568438;5436.456354364532;5444.5916556258435;5471.2887324647545;5826.592138550261;5827.854303642443;5870.941290587125;5898.469137777621;5907.940920590825;5361.222622719683;5497.670139791625;5512.944870551243;5519.061759500894;5534.584906132056;3071.3550154467366;3091.984540077285;3108.6477382338753;3121.4537455945574;3122.6877312269044;5854.414558544111;5973.342932277446;6003;6023.969880150659;6072.301685306158;5914.645121292736;5975.40245975399;5988.700564971734;6006.468350570664;6023.27720673522;6150;6211.2857021443115;6230.221222347207;6250.624962502265;6262.906056409249;5969;5977.3424923257535;5978.402159784161;6036.154938308552;6037.335893051673;6014.308354539284;6015.308239552332;6019.72911219005;6041.909371359521;6054.66699331541;6241.531885108726;6243.940469170165;6297.338779428277;6304.401081897213;6305.8108256752375;3999.3201155803004;4235.1317979814685;4242.554531774119;4252.8724138274665;4288;6009.0470597055255;6017.18767966319;6029.457348838626;6077.936361136695;6082.787102451393;5880.029795083934;5908.586398952032;5915.988563888299;5925.229720136354;5928.584999050025;5667.773289068391;5847.970760146172;5875.236219291465;5957.731902064331;5959.76160953557;5759.308882933907;5770.365259821332;5780.808913537651;5818.796342128006;5840.532757379485;5618.185363122243;5850.414958504116;5900.672348721503;5909.552159720896;5926.436988486087;5779.723004976203;5855.9211479924015;5858.414158584107;5861.622518708185;5862 08:42:22 INFO - PROCESS | 3410 | |5;yui.html;847.5635047950306;881.8941726992758;884.4030279561297;890.1365675294966;898.8876390451194;14711.779323310146;15452.690946181083;15613.609659758511;15633.452829150981;15681.529554113366;14396.064255823365;14509.419623215084;14513.27433628317;14533.200673962929;14577.708445831076;677.9220389655179;803;821.6713314674133;830.7134038756619;831.6714897615439;821.7082935557851;824.1017291152642;825.6738588257665;832.3008672714918;834.1950018232404;871.0375035585681;871.1506281375672;871.651339464213;872.8952525696893;873.3537182484947;860.9784755381103;866.956652167389;867.4621734524603;868.6916144768611;869.5261082709939;634.4099987012077;636.2492259134219;637.5377851057946;637.7863415755681;639.1084437210112;14532.491362802251;14672.486462973851;14707.264636768119;14754.262286885612;14769.483068092564;14407.351669174912;14470.927645361811;14506.202158881257;14582.489612863605;14823.925880370636;11377.2035957483;11387.943060284728;11470.885291147066;11534.192606517547;11684;3793.844660386521;3851.326017946876;3913.8043097844993;3929.5677475477673;3963.207358528277;56641;56645;56858.7157064212;57054;57583.71208143933;11297.774044519228;11311.660650180507;11410.714732131597;11431.371274579978;11475.77048459026;19269.22923083061;19299.710504342445;19412.417627470917;19434.70847937282;19450.902745486183;8336.333093352518;8493.27807136388;8604.78488037804;8818.779530511789;8932.776680583038;4628.190066738307;4804.8318308859025;4919.704817710949;4927.630427717935;5046.066477701637;3540.822958852047;3644.7448678592773;3685.207680348738;3690.169711814874;3691.6123807000417;647.2362612117746;658.7319410135566;659.6009414304373;662.2483481248721;665.4277321503503;721.3111478537984;768.2240936654019;770.2413123073768;782.0771489642277;804.5977011494252;9191.21874640663;9262.259019278576;9365.765855853659;9391.295652826066;9562.99588543193;644.7421279465963;712.2094475132599;717.9174394944544;732.7362149626131;734.2473964186752;4314.590113939171;4327.740335579875;4447.710898791568;4477.149341625146;4517.841875534406;59240.70379648074;60096.09855852078;63180.68409657922;63229.36770632235;63559.682201588694;54592.181117283275;54655.72672136614;54747.45252547503;56118.438815612135;58034.70982645144;50975.49024509708;51157;51469.48530514647;51718.74140629348;52235.73882130565;8240.793980150544;8441.95779021101;8447.704330348408;8565.914340856762;8608.48349099031;33638.49542256917;34064.31871362509;34218.802341917915;34246.657533424346;34569.82715086408;44050.559494404646;44611.77694111509;45431.54568454273;45761.313580296985;46202.53797461982;12530.436130374337;12599.43302551369;12951.963842892357;13100.344982751016;13314.866851331362;13382.598522044354;13383.130096543693;13698.589042328746;13699.726005480034;14548.49080282185;12553.6341825206;13190.274534900673;13328.733425331633;13417.731645366843;13470.393832277767;13059.738805224033;13073.215607063607;13122.60632181036;13576;13973.580792576238;12903.935480322538;13052.282124483245;13171.47314107425;13290.335483225606;13378;10935.453227338443;11011.229213955266;11115.388653623804;11315;11396.772064558496;10637.840432393676;10722.678319650424;10741.562944301775;10829.350238985686;10866 08:42:22 INFO - PROCESS | 3410 | __end_tp_report 08:42:22 INFO - PROCESS | 3410 | __start_cc_report 08:42:22 INFO - PROCESS | 3410 | _x_x_mozilla_cycle_collect,336 08:42:22 INFO - PROCESS | 3410 | __end_cc_report 08:42:22 INFO - PROCESS | 3410 | __startTimestamp1462549342024__endTimestamp 08:42:22 INFO - PROCESS | 3410 | 08:42:22 INFO - PROCESS | 3410 | ------- Summary: start ------- 08:42:22 INFO - PROCESS | 3410 | Number of tests: 6 08:42:22 INFO - PROCESS | 3410 | 08:42:22 INFO - PROCESS | 3410 | [#0] dojo.html Cycles:165 Average:5516.85 Median:5733.54 stddev:647.80 (11.3%) stddev-sans-first:623.51 08:42:22 INFO - PROCESS | 3410 | Values: 3188.9 3192.8 3212.8 3218.0 3254.4 5481.6 5494.8 5572.2 5602.5 5617.4 5419.7 5477.7 5513.2 5554.9 5598.1 4947.9 5010.1 5058.4 5156.1 5173.5 5066.1 5185.3 5203.1 5203.7 5211.7 4957.2 4997.7 5034.2 5057.3 5062.2 5032.4 5041.1 5041.8 5049.7 5106.1 5015.2 5031.5 5046.8 5047.9 5048.9 5270.0 5385.6 5386.0 5451.1 5499.5 5954.1 5957.4 5961.9 5973.5 5977.5 5842.2 6021.3 6031.7 6036.7 6040.2 5546.0 5577.5 5591.5 5592.6 5627.6 6065.0 6099.8 6102.7 6119.4 6129.6 5698.5 5835.5 5860.3 5863.9 5865.8 5950.6 6029.3 6032.8 6037.3 6082.1 5786.6 5933.4 5978.0 5998.5 6013.4 5733.5 5972.9 6011.3 6032.5 6065.7 4330.4 4379.9 4400.4 4411.8 4421.3 3933.3 3939.7 3946.2 3979.4 3997.3 5542.8 5553.6 5572.4 5599.7 5649.5 6015.3 6019.4 6031.6 6044.1 6083.3 5692.7 5709.2 5714.4 5720.5 5722.8 4968.9 4984.4 5026.4 5049.4 5137.5 6023.2 6041.3 6056.5 6081.5 6083.3 5859.6 5899.1 5902.3 5902.6 5910.0 5947.5 6109.1 6135.8 6173.5 6234.0 5942.0 5944.2 5949.6 5957.7 5992.3 5888.5 6072.6 6072.9 6076.7 6084.3 5697.6 5738.7 5750.3 5786.6 5789.0 5692.0 5770.2 5772.2 5873.0 5879.8 5717.6 5730.9 5780.4 5784.9 5797.0 5611.4 5741.9 5796.7 5855.4 5857.8 5711.2 5742.7 5748.7 5758.7 5770.4 08:42:22 INFO - PROCESS | 3410 | 08:42:22 INFO - PROCESS | 3410 | [#1] ext.html Cycles:180 Average:55322.61 Median:40387.30 stddev:103414.08 (256.1%) stddev-sans-first:103622.58 08:42:22 INFO - PROCESS | 3410 | Values: 602.7 623.7 637.5 638.0 678.0 37292.3 41307.0 41511.0 41705.4 41738.6 40718.0 41198.7 41361.8 41373.4 41390.8 8778.6 8809.6 8829.5 8845.7 8893.6 8671.8 8793.0 8831.1 8836.2 8843.6 8863.6 8880.2 8913.2 8914.3 8923.3 8752.1 8779.7 8831.2 8864.2 8882.7 8704.6 8808.0 8809.5 8809.7 8824.5 38698.4 38849.4 38872.4 38893.9 38982.8 3850.2 3868.8 3940.4 3967.5 4445.2 31085.2 31558.7 31614.2 31913.7 33452.0 4141.1 4277.8 4383.9 4387.7 4420.5 322545.9 323575.0 325054.0 326060.0 327098.0 60629.4 60720.4 61043.7 61063.7 61195.0 36702.8 37348.4 37441.0 38803.8 64043.4 17097.2 17187.7 17387.6 17406.2 17418.8 13293.3 13358.4 13471.3 13488.5 13492.7 18520.8 18660.7 18720.9 19035.5 19141.2 7265.2 7294.8 7316.4 7333.7 7460.7 1057.4 1104.6 1106.0 1137.4 1208.0 31608.7 31858.7 31962.7 31963.2 32554.7 1144.1 1183.2 1217.9 1218.1 1268.5 16954.9 17121.5 17200.0 17354.9 17356.3 449823.0 450633.0 453191.0 457299.0 458609.0 58441.4 58575.0 58737.4 59065.7 59103.0 1400.6 1444.0 1448.8 1448.9 1460.2 29802.9 30969.2 31259.5 31439.8 32151.2 49405.3 49509.8 49619.8 49784.5 50104.5 385668.0 386038.0 386088.0 386562.0 391359.0 27557.0 28511.6 28660.3 28729.3 28756.9 47540.0 47679.0 47878.0 48540.3 48575.8 40801.2 41145.2 41380.6 41590.4 42242.0 39692.8 40056.6 40785.8 41436.4 41452.4 41240.4 41873.6 42811.1 43028.6 44853.6 35557.6 36943.0 37025.4 37110.3 38089.4 27877.7 28181.7 28357.9 28565.0 28770.3 08:42:22 INFO - PROCESS | 3410 | 08:42:22 INFO - PROCESS | 3410 | [#2] jquery.html Cycles:180 Average:26917.63 Median:2418.20 stddev:70657.80 (2921.9%) stddev-sans-first:70827.92 08:42:22 INFO - PROCESS | 3410 | Values: 381.3 382.8 391.0 402.6 402.8 17802.6 19458.4 19820.7 20117.3 20127.2 18511.7 18818.6 19142.0 19421.3 19496.3 5495.6 5660.5 5698.4 5721.5 5733.5 5610.6 5635.4 5649.2 5658.4 5674.4 5422.2 5522.3 5573.5 5657.0 5658.6 5616.3 5616.9 5620.3 5628.8 5660.0 4954.9 4983.2 5002.6 5069.0 5069.4 22717.4 22817.5 23137.1 23333.3 23371.5 2246.3 2329.7 2358.1 2478.3 3063.9 7392.4 7830.6 9792.5 10694.6 13873.9 1997.6 2020.3 2038.1 2040.1 2091.4 65181.0 73894.0 74109.3 84259.0 89074.1 10503.6 10527.3 10566.6 10593.4 10611.8 14525.7 14650.9 14660.8 14708.8 14762.6 7917.5 7945.3 7962.6 8175.3 8191.4 7903.9 7981.3 8045.8 8166.4 8192.3 4363.8 4512.4 4544.2 4670.0 4703.9 1869.5 1949.2 1960.7 1961.7 1964.3 981.7 986.7 995.4 1083.6 1116.7 18768.2 19112.4 19187.3 19337.0 19415.0 1018.4 1032.8 1040.6 1040.9 1065.7 10546.4 10970.0 11084.7 11091.7 11111.3 402375.0 429917.0 431650.0 432345.0 433148.0 90129.2 97083.8 97295.0 97358.0 97741.0 1046.4 1054.0 1069.9 1091.8 1093.7 16471.3 16771.3 16950.7 17161.5 17306.4 37406.0 37427.4 38021.4 39974.0 40133.0 50975.0 52820.2 54824.7 55410.7 56092.7 8419.9 8454.7 8466.5 8591.4 8713.7 11738.4 12855.2 12919.4 13035.5 13117.9 10932.5 11364.5 11461.6 11474.6 11506.7 11254.2 11404.0 11601.5 11604.7 11785.7 11418.5 11558.9 11666.8 11759.6 11943.4 8345.5 8474.6 8535.0 8632.6 8740.4 8881.9 10659.6 11539.4 11655.2 12024.5 08:42:22 INFO - PROCESS | 3410 | 08:42:22 INFO - PROCESS | 3410 | [#3] mootools.html Cycles:180 Average:5984.55 Median:2458.24 stddev:3396.49 (138.2%) stddev-sans-first:3389.33 08:42:22 INFO - PROCESS | 3410 | Values: 1504.4 1512.7 1690.3 1810.0 1845.4 8021.3 8689.6 8708.4 9288.0 9292.3 8684.4 8903.5 9009.8 9010.0 9026.9 2316.6 2335.7 2365.1 2367.8 2370.2 2197.8 2285.9 2380.7 2382.8 2389.3 2321.6 2337.2 2341.1 2341.7 2363.4 2326.4 2340.2 2348.0 2364.0 2364.6 2328.4 2374.4 2374.7 2375.7 2379.4 8848.2 8930.0 8937.2 8985.5 9052.5 5289.2 5370.0 5388.4 5456.9 5461.9 3452.5 3562.4 3568.6 3581.6 3622.3 1042.9 1056.7 1069.3 1069.3 1109.3 12446.6 12547.0 12568.7 12568.8 12610.6 4583.4 4672.2 4690.6 4798.1 4810.2 10581.2 10653.7 10660.0 10686.6 10703.9 5360.9 5368.6 5368.7 5376.9 5380.1 4342.3 4813.8 4887.6 5009.7 5019.9 4099.4 4123.9 4170.4 4184.4 4210.0 1265.8 1280.2 1288.8 1289.7 1302.3 937.6 1004.1 1014.3 1042.1 1047.3 5995.1 6079.3 6229.6 6358.2 6497.0 442.5 451.0 1032.6 1043.7 1092.0 4346.9 4429.8 4465.5 4514.5 4566.3 11049.8 11448.3 11517.5 11569.8 11638.3 10640.7 11048.2 11141.7 11350.3 11393.1 8272.9 8325.4 8381.2 8452.7 8548.0 6177.2 6198.2 6322.5 6356.9 6403.7 9939.4 10269.3 10300.5 10401.2 10415.5 10304.9 10395.0 10404.2 10520.3 10572.8 7190.1 7848.7 7958.2 8073.3 8099.2 9001.6 9037.0 9037.9 9108.4 9127.2 7926.0 7966.6 8035.5 8065.4 8162.0 8055.8 8063.4 8073.0 8113.1 8233.1 7087.0 7270.2 7323.7 7382.1 7466.8 5324.4 5359.5 5384.1 5389.6 5403.1 5397.9 5574.1 5584.6 5705.3 5793.3 08:42:22 INFO - PROCESS | 3410 | 08:42:22 INFO - PROCESS | 3410 | [#4] prototype.html Cycles:180 Average:4904.21 Median:5594.18 stddev:1452.78 (26.0%) stddev-sans-first:1415.95 08:42:22 INFO - PROCESS | 3410 | Values: 343.4 344.6 346.3 348.3 349.0 5558.7 5587.7 5605.2 5651.7 5653.7 5600.6 5604.7 5612.7 5634.1 5670.7 3906.7 4070.2 4217.4 4251.7 4308.1 4221.3 4274.3 4288.4 4295.5 4301.4 4246.2 4259.3 4266.3 4275.2 4278.9 4176.4 4277.8 4288.8 4300.8 4306.0 3817.9 3831.5 3831.7 3834.9 3843.9 5340.4 5346.6 5348.5 5397.6 5453.0 4820.9 4964.1 4984.1 5003.1 5016.5 5776.7 5784.5 5793.2 5800.7 5806.9 4208.2 4217.6 4224.0 4224.4 4250.6 5872.6 6002.6 6028.8 6059.9 6095.6 4264.4 4289.1 4291.6 4297.3 4297.4 4337.3 4339.9 4356.3 4362.4 4367.2 4805.9 4904.5 5003.4 5014.2 5033.9 5812.0 5814.2 5844.9 5875.5 5886.5 1455.9 1459.1 1468.2 1474.5 1476.0 976.8 1016.6 1018.7 1021.1 1022.4 5434.8 5435.7 5436.5 5444.6 5471.3 5826.6 5827.9 5870.9 5898.5 5907.9 5361.2 5497.7 5512.9 5519.1 5534.6 3071.4 3092.0 3108.6 3121.5 3122.7 5854.4 5973.3 6003.0 6024.0 6072.3 5914.6 5975.4 5988.7 6006.5 6023.3 6150.0 6211.3 6230.2 6250.6 6262.9 5969.0 5977.3 5978.4 6036.2 6037.3 6014.3 6015.3 6019.7 6041.9 6054.7 6241.5 6243.9 6297.3 6304.4 6305.8 3999.3 4235.1 4242.6 4252.9 4288.0 6009.0 6017.2 6029.5 6077.9 6082.8 5880.0 5908.6 5916.0 5925.2 5928.6 5667.8 5848.0 5875.2 5957.7 5959.8 5759.3 5770.4 5780.8 5818.8 5840.5 5618.2 5850.4 5900.7 5909.6 5926.4 5779.7 5855.9 5858.4 5861.6 5862.0 08:42:22 INFO - PROCESS | 3410 | 08:42:22 INFO - PROCESS | 3410 | [#5] yui.html Cycles:180 Average:15147.09 Median:4497.50 stddev:17305.38 (384.8%) stddev-sans-first:17320.61 08:42:22 INFO - PROCESS | 3410 | Values: 847.6 881.9 884.4 890.1 898.9 14711.8 15452.7 15613.6 15633.5 15681.5 14396.1 14509.4 14513.3 14533.2 14577.7 677.9 803.0 821.7 830.7 831.7 821.7 824.1 825.7 832.3 834.2 871.0 871.2 871.7 872.9 873.4 861.0 867.0 867.5 868.7 869.5 634.4 636.2 637.5 637.8 639.1 14532.5 14672.5 14707.3 14754.3 14769.5 14407.4 14470.9 14506.2 14582.5 14823.9 11377.2 11387.9 11470.9 11534.2 11684.0 3793.8 3851.3 3913.8 3929.6 3963.2 56641.0 56645.0 56858.7 57054.0 57583.7 11297.8 11311.7 11410.7 11431.4 11475.8 19269.2 19299.7 19412.4 19434.7 19450.9 8336.3 8493.3 8604.8 8818.8 8932.8 4628.2 4804.8 4919.7 4927.6 5046.1 3540.8 3644.7 3685.2 3690.2 3691.6 647.2 658.7 659.6 662.2 665.4 721.3 768.2 770.2 782.1 804.6 9191.2 9262.3 9365.8 9391.3 9563.0 644.7 712.2 717.9 732.7 734.2 4314.6 4327.7 4447.7 4477.1 4517.8 59240.7 60096.1 63180.7 63229.4 63559.7 54592.2 54655.7 54747.5 56118.4 58034.7 50975.5 51157.0 51469.5 51718.7 52235.7 8240.8 8442.0 8447.7 8565.9 8608.5 33638.5 34064.3 34218.8 34246.7 34569.8 44050.6 44611.8 45431.5 45761.3 46202.5 12530.4 12599.4 12952.0 13100.3 13314.9 13382.6 13383.1 13698.6 13699.7 14548.5 12553.6 13190.3 13328.7 13417.7 13470.4 13059.7 13073.2 13122.6 13576.0 13973.6 12903.9 13052.3 13171.5 13290.3 13378.0 10935.5 11011.2 11115.4 11315.0 11396.8 10637.8 10722.7 10741.6 10829.4 10866.0 08:42:22 INFO - PROCESS | 3410 | -------- Summary: end -------- 08:42:22 INFO - PROCESS | 3410 | 08:42:22 INFO - TEST-INFO | 3410: exit 0 08:42:22 INFO - TEST-OK | dromaeo_css | took 1110988ms 08:42:22 INFO - TEST-START | kraken 08:42:22 INFO - operating with platform_type : linux_ 08:42:22 INFO - Initialising browser for kraken test... 08:42:22 INFO - TEST-INFO | started process 3637 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMUL1rh/profile http://localhost:54976/getInfo.html) 08:42:26 INFO - PROCESS | 3637 | 08:42:26 INFO - PROCESS | 3637 | (process:3710): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 08:42:26 INFO - PROCESS | 3637 | __metrics Screen width/height:1600/1200 08:42:26 INFO - PROCESS | 3637 | colorDepth:24 08:42:26 INFO - PROCESS | 3637 | Browser inner width/height: 1024/697 08:42:26 INFO - PROCESS | 3637 | __metrics 08:42:27 ERROR - PROCESS | 3637 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 08:42:28 INFO - TEST-INFO | 3637: exit 0 08:42:28 INFO - Browser initialized. 08:42:28 INFO - Running cycle 1/1 for kraken test... 08:42:28 INFO - TEST-INFO | started process 3761 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMUL1rh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:42:30 INFO - PROCESS | 3761 | 08:42:30 INFO - PROCESS | 3761 | (process:3824): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 08:42:40 INFO - PROCESS | 3761 | RSS: Main: 163819520 08:42:40 INFO - PROCESS | 3761 | 08:42:42 INFO - PROCESS | 3761 | Cycle 1(1): loaded http://localhost:54976/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54976/tests/kraken/driver.html?testName=audio-beat-detection) 08:42:43 INFO - PROCESS | 3761 | RSS: Main: 167710720 08:42:43 INFO - PROCESS | 3761 | 08:42:46 INFO - PROCESS | 3761 | Cycle 1(1): loaded http://localhost:54976/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54976/tests/kraken/driver.html?testName=audio-dft) 08:42:46 INFO - PROCESS | 3761 | RSS: Main: 168026112 08:42:46 INFO - PROCESS | 3761 | 08:42:49 INFO - PROCESS | 3761 | Cycle 1(1): loaded http://localhost:54976/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54976/tests/kraken/driver.html?testName=audio-fft) 08:42:50 INFO - PROCESS | 3761 | RSS: Main: 162910208 08:42:50 INFO - PROCESS | 3761 | 08:42:52 INFO - PROCESS | 3761 | Cycle 1(1): loaded http://localhost:54976/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54976/tests/kraken/driver.html?testName=audio-oscillator) 08:42:53 INFO - PROCESS | 3761 | RSS: Main: 163123200 08:42:53 INFO - PROCESS | 3761 | 08:42:55 INFO - PROCESS | 3761 | Cycle 1(1): loaded http://localhost:54976/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54976/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:42:55 INFO - PROCESS | 3761 | RSS: Main: 163332096 08:42:55 INFO - PROCESS | 3761 | 08:42:58 INFO - PROCESS | 3761 | Cycle 1(1): loaded http://localhost:54976/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54976/tests/kraken/driver.html?testName=imaging-darkroom) 08:42:59 INFO - PROCESS | 3761 | RSS: Main: 163581952 08:42:59 INFO - PROCESS | 3761 | 08:43:02 INFO - PROCESS | 3761 | Cycle 1(1): loaded http://localhost:54976/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54976/tests/kraken/driver.html?testName=imaging-desaturate) 08:43:03 INFO - PROCESS | 3761 | RSS: Main: 163856384 08:43:03 INFO - PROCESS | 3761 | 08:43:06 INFO - PROCESS | 3761 | Cycle 1(1): loaded http://localhost:54976/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54976/tests/kraken/driver.html?testName=json-parse-financial) 08:43:07 INFO - PROCESS | 3761 | RSS: Main: 164429824 08:43:07 INFO - PROCESS | 3761 | 08:43:08 INFO - PROCESS | 3761 | Cycle 1(1): loaded http://localhost:54976/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54976/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:43:09 INFO - PROCESS | 3761 | RSS: Main: 164233216 08:43:09 INFO - PROCESS | 3761 | 08:43:10 INFO - PROCESS | 3761 | Cycle 1(1): loaded http://localhost:54976/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54976/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:43:11 INFO - PROCESS | 3761 | RSS: Main: 164536320 08:43:11 INFO - PROCESS | 3761 | 08:43:13 INFO - PROCESS | 3761 | Cycle 1(1): loaded http://localhost:54976/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54976/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:43:14 INFO - PROCESS | 3761 | RSS: Main: 164384768 08:43:14 INFO - PROCESS | 3761 | 08:43:16 INFO - PROCESS | 3761 | Cycle 1(1): loaded http://localhost:54976/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54976/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:43:17 INFO - PROCESS | 3761 | RSS: Main: 164462592 08:43:17 INFO - PROCESS | 3761 | 08:43:20 INFO - PROCESS | 3761 | Cycle 1(1): loaded http://localhost:54976/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54976/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:43:20 INFO - PROCESS | 3761 | RSS: Main: 164421632 08:43:20 INFO - PROCESS | 3761 | 08:43:22 INFO - PROCESS | 3761 | Cycle 1(1): loaded http://localhost:54976/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54976/tests/kraken/driver.html?testName=ai-astar) 08:43:22 INFO - PROCESS | 3761 | RSS: Main: 165609472 08:43:22 INFO - PROCESS | 3761 | 08:43:22 INFO - PROCESS | 3761 | __start_tp_report 08:43:22 INFO - PROCESS | 3761 | _x_x_mozilla_page_load 08:43:22 INFO - PROCESS | 3761 | _x_x_mozilla_page_load_details 08:43:22 INFO - PROCESS | 3761 | |i|pagename|runs| 08:43:22 INFO - PROCESS | 3761 | |0;ai-astar;109;112;103;113;117;113;106;111;112;112 08:43:22 INFO - PROCESS | 3761 | |1;audio-beat-detection;157;125;162;181;125;162;157;126;192;133 08:43:22 INFO - PROCESS | 3761 | |2;audio-dft;162;163;162;161;162;162;172;163;161;160 08:43:22 INFO - PROCESS | 3761 | |3;audio-fft;76;73;74;161;77;76;74;77;169;75 08:43:22 INFO - PROCESS | 3761 | |4;audio-oscillator;91;91;163;92;91;92;151;91;91;154 08:43:22 INFO - PROCESS | 3761 | |5;imaging-gaussian-blur;117;117;117;117;117;118;117;117;117;117 08:43:22 INFO - PROCESS | 3761 | |6;imaging-darkroom;148;146;146;146;148;146;147;147;148;148 08:43:22 INFO - PROCESS | 3761 | |7;imaging-desaturate;95;96;95;96;96;96;96;96;96;96 08:43:22 INFO - PROCESS | 3761 | |8;json-parse-financial;57;58;64;57;57;58;57;73;57;55 08:43:22 INFO - PROCESS | 3761 | |9;json-stringify-tinderbox;60;60;60;59;61;60;60;60;68;60 08:43:22 INFO - PROCESS | 3761 | |10;stanford-crypto-aes;77;79;85;84;89;80;79;78;79;80 08:43:22 INFO - PROCESS | 3761 | |11;stanford-crypto-ccm;124;128;123;125;123;123;125;128;157;129 08:43:22 INFO - PROCESS | 3761 | |12;stanford-crypto-pbkdf2;170;172;171;165;166;171;166;164;165;168 08:43:22 INFO - PROCESS | 3761 | |13;stanford-crypto-sha256-iterative;65;74;65;65;64;64;65;63;69;64 08:43:22 INFO - PROCESS | 3761 | __end_tp_report 08:43:22 INFO - PROCESS | 3761 | __start_cc_report 08:43:22 INFO - PROCESS | 3761 | _x_x_mozilla_cycle_collect,822 08:43:22 INFO - PROCESS | 3761 | __end_cc_report 08:43:22 INFO - PROCESS | 3761 | __startTimestamp1462549402806__endTimestamp 08:43:22 INFO - PROCESS | 3761 | 08:43:22 INFO - PROCESS | 3761 | ------- Summary: start ------- 08:43:22 INFO - PROCESS | 3761 | Number of tests: 14 08:43:22 INFO - PROCESS | 3761 | 08:43:22 INFO - PROCESS | 3761 | [#0] ai-astar Cycles:10 Average:110.80 Median:112.00 stddev:3.94 (3.5%) stddev-sans-first:4.12 08:43:22 INFO - PROCESS | 3761 | Values: 109.0 112.0 103.0 113.0 117.0 113.0 106.0 111.0 112.0 112.0 08:43:22 INFO - PROCESS | 3761 | 08:43:22 INFO - PROCESS | 3761 | [#1] audio-beat-detection Cycles:10 Average:152.00 Median:159.50 stddev:24.00 (15.0%) stddev-sans-first:25.39 08:43:22 INFO - PROCESS | 3761 | Values: 157.0 125.0 162.0 181.0 125.0 162.0 157.0 126.0 192.0 133.0 08:43:22 INFO - PROCESS | 3761 | 08:43:22 INFO - PROCESS | 3761 | [#2] audio-dft Cycles:10 Average:162.80 Median:162.00 stddev:3.36 (2.1%) stddev-sans-first:3.55 08:43:22 INFO - PROCESS | 3761 | Values: 162.0 163.0 162.0 161.0 162.0 162.0 172.0 163.0 161.0 160.0 08:43:22 INFO - PROCESS | 3761 | 08:43:22 INFO - PROCESS | 3761 | [#3] audio-fft Cycles:10 Average:93.20 Median:75.50 stddev:37.91 (50.2%) stddev-sans-first:39.70 08:43:22 INFO - PROCESS | 3761 | Values: 76.0 73.0 74.0 161.0 77.0 76.0 74.0 77.0 169.0 75.0 08:43:22 INFO - PROCESS | 3761 | 08:43:22 INFO - PROCESS | 3761 | [#4] audio-oscillator Cycles:10 Average:110.70 Median:91.00 stddev:31.40 (34.5%) stddev-sans-first:32.49 08:43:22 INFO - PROCESS | 3761 | Values: 91.0 91.0 163.0 92.0 91.0 92.0 151.0 91.0 91.0 154.0 08:43:22 INFO - PROCESS | 3761 | 08:43:22 INFO - PROCESS | 3761 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 08:43:22 INFO - PROCESS | 3761 | Values: 117.0 117.0 117.0 117.0 117.0 118.0 117.0 117.0 117.0 117.0 08:43:22 INFO - PROCESS | 3761 | 08:43:22 INFO - PROCESS | 3761 | [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.50 stddev:0.94 (0.6%) stddev-sans-first:0.93 08:43:22 INFO - PROCESS | 3761 | Values: 148.0 146.0 146.0 146.0 148.0 146.0 147.0 147.0 148.0 148.0 08:43:22 INFO - PROCESS | 3761 | 08:43:22 INFO - PROCESS | 3761 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 08:43:22 INFO - PROCESS | 3761 | Values: 95.0 96.0 95.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 08:43:22 INFO - PROCESS | 3761 | 08:43:22 INFO - PROCESS | 3761 | [#8] json-parse-financial Cycles:10 Average:59.30 Median:57.50 stddev:5.36 (9.3%) stddev-sans-first:5.61 08:43:22 INFO - PROCESS | 3761 | Values: 57.0 58.0 64.0 57.0 57.0 58.0 57.0 73.0 57.0 55.0 08:43:22 INFO - PROCESS | 3761 | 08:43:22 INFO - PROCESS | 3761 | [#9] json-stringify-tinderbox Cycles:10 Average:60.80 Median:60.00 stddev:2.57 (4.3%) stddev-sans-first:2.71 08:43:22 INFO - PROCESS | 3761 | Values: 60.0 60.0 60.0 59.0 61.0 60.0 60.0 60.0 68.0 60.0 08:43:22 INFO - PROCESS | 3761 | 08:43:22 INFO - PROCESS | 3761 | [#10] stanford-crypto-aes Cycles:10 Average:81.00 Median:80.00 stddev:3.77 (4.7%) stddev-sans-first:3.71 08:43:22 INFO - PROCESS | 3761 | Values: 77.0 79.0 85.0 84.0 89.0 80.0 79.0 78.0 79.0 80.0 08:43:22 INFO - PROCESS | 3761 | 08:43:22 INFO - PROCESS | 3761 | [#11] stanford-crypto-ccm Cycles:10 Average:128.50 Median:126.50 stddev:10.27 (8.1%) stddev-sans-first:10.76 08:43:22 INFO - PROCESS | 3761 | Values: 124.0 128.0 123.0 125.0 123.0 123.0 125.0 128.0 157.0 129.0 08:43:22 INFO - PROCESS | 3761 | 08:43:22 INFO - PROCESS | 3761 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.80 Median:169.00 stddev:2.97 (1.8%) stddev-sans-first:3.05 08:43:22 INFO - PROCESS | 3761 | Values: 170.0 172.0 171.0 165.0 166.0 171.0 166.0 164.0 165.0 168.0 08:43:22 INFO - PROCESS | 3761 | 08:43:22 INFO - PROCESS | 3761 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.80 Median:65.00 stddev:3.29 (5.1%) stddev-sans-first:3.48 08:43:22 INFO - PROCESS | 3761 | Values: 65.0 74.0 65.0 65.0 64.0 64.0 65.0 63.0 69.0 64.0 08:43:22 INFO - PROCESS | 3761 | -------- Summary: end -------- 08:43:22 INFO - PROCESS | 3761 | 08:43:23 INFO - TEST-INFO | 3761: exit 0 08:43:23 INFO - TEST-OK | kraken | took 60965ms 08:43:23 INFO - SUITE-END | took 1171s 08:43:23 INFO - Completed test suite (00:19:32) 08:43:23 INFO - javascript benchmark 08:43:24 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3188.936221275576, 3192.760542959278, 3212.8393580320994, 3217.951730724038, 3254.446744053511, 5481.643693159942, 5494.835154945348, 5572.164175373696, 5602.495775380215, 5617.354004289508, 5419.701916394597, 5477.67133971961, 5513.2005859150395, 5554.86112847179, 5598.1322894951345, 4947.925781113287, 5010.0981823271795, 5058.367704036996, 5156.149235376159, 5173.482651734834, 5066.088104141253, 5185.274061631375, 5203.063448579254, 5203.739813009334, 5211.661242019276, 4957.206846904514, 4997.725125118117, 5034.219695947134, 5057.26669632903, 5062.215356619711, 5032.370953630796, 5041.067402530543, 5041.8487445376695, 5049.722265275408, 5106.08090543702, 5015.1975683890405, 5031.547160755513, 5046.84859454217, 5047.899042019139, 5048.899022019576, 5269.973650131763, 5385.596080293954, 5386.0, 5451.100568406208, 5499.532539734128, 5954.07711804671, 5957.374475680034, 5961.91057134139, 5973.492253158487, 5977.521798256129, 5842.182094506772, 6021.277446706424, 6031.728572214217, 6036.728347224385, 6040.154378387029, 5546.029444847136, 5577.52591029763, 5591.496765291144, 5592.552595792326, 5627.5779316551425, 6065.0, 6099.84750381244, 6102.69486525672, 6119.418655227746, 6129.601575897642, 5698.544116470673, 5835.4748072673665, 5860.2967643883, 5863.912041319383, 5865.824025279248, 5950.583459157904, 6029.336772954972, 6032.849178770566, 6037.305709843336, 6082.118092876508, 5786.623869448556, 5933.406659334032, 5978.04351303798, 5998.49012833914, 6013.368596297413, 5733.541316694655, 5972.880542389128, 6011.338752737195, 6032.4570788629235, 6065.696715164224, 4330.39374487572, 4379.912401751947, 4400.44994375703, 4411.823527058882, 4421.270490369117, 3933.331333673282, 3939.6651284641125, 3946.151577410813, 3979.3633018716864, 3997.340438827619, 5542.8337149885565, 5553.6390134641115, 5572.3870374258795, 5599.7480113394995, 5649.4633009864, 6015.308239552507, 6019.428154325332, 6031.60794548353, 6044.123602077674, 6083.270007599116, 5692.686902220417, 5709.229254050733, 5714.371419143891, 5720.542356611461, 5722.828315150552, 4968.925466118011, 4984.352034235599, 5026.421961474477, 5049.419316778544, 5137.537621614073, 6023.186869772612, 6041.2750469943885, 6056.515478761688, 6081.483073938764, 6083.300420451705, 5859.619124756877, 5899.144624029577, 5902.291724993029, 5902.6458412495385, 5910.024845900378, 5947.494462970523, 6109.131392048963, 6135.785247516315, 6173.506119510518, 6233.96883015582, 5942.0, 5944.227250457413, 5949.6430214187285, 5957.702114894325, 5992.340842507234, 5888.528917686661, 6072.574919755575, 6072.878542429038, 6076.665783381956, 6084.330723620486, 5697.572682048946, 5738.713064346849, 5750.25246717924, 5786.623869448473, 5789.044807606698, 5691.971540142273, 5770.2498675171955, 5772.249607550992, 5873.0, 5879.764809407576, 5717.628354156966, 5730.885382292247, 5780.364159942487, 5784.855378615568, 5797.043487824461, 5611.438856114519, 5741.942580574141, 5796.681182535001, 5855.443732845373, 5857.824265272048, 5711.208508474156, 5742.684152371659, 5748.712564371848, 5758.654480731169, 5770.422957704364], "value": 5471.673897536287, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [602.6805792929746, 623.731795328009, 637.544155928511, 637.9649119298437, 677.9966100169498, 37292.25415491692, 41307.0, 41511.0, 41705.374419383734, 41738.582614173814, 40718.0, 41198.73406962616, 41361.793191034005, 41373.37939930904, 41390.7930460348, 8778.604962776675, 8809.559522023905, 8829.470231786081, 8845.690400835972, 8893.599788009522, 8671.826563468727, 8793.03276639569, 8831.072737362581, 8836.248918841906, 8843.60203790831, 8863.601137948775, 8880.1563851434, 8913.1978121969, 8914.331425143107, 8923.286137109048, 8752.124787521261, 8779.736607901774, 8831.205191532761, 8864.246539044188, 8882.733517994471, 8704.608292626846, 8808.03111657717, 8809.515476648781, 8809.72259022438, 8824.514651694155, 38698.41952370717, 38849.417258741145, 38872.41691374632, 38893.94378730747, 38982.80508597439, 3850.2107068051264, 3868.78721670308, 3940.4483372327895, 3967.5238971323624, 4445.199864024475, 31085.22286942822, 31558.684413156032, 31614.209644758834, 31913.680863191534, 33452.0, 4141.088960428701, 4277.841219403226, 4383.868483945486, 4387.736735795863, 4420.491643461011, 322545.93635159073, 323575.0, 325054.0, 326060.0, 327098.0, 60629.39370606326, 60720.39279607147, 61043.69478152581, 61063.694681527195, 61195.0, 36702.8164859174, 37348.43977340342, 37441.0, 38803.80598096991, 64043.35956640374, 17097.230624621923, 17187.65624687499, 17387.56531086733, 17406.21672024762, 17418.82581174172, 13293.335333233299, 13358.39887205078, 13471.259080750457, 13488.460461581426, 13492.662683432796, 18520.81479185218, 18660.720089198672, 18720.90639546821, 19035.524111897314, 19141.2343506261, 7265.164506081763, 7294.781156565312, 7316.414686825041, 7333.669984850694, 7460.701571937062, 1057.4025675493322, 1104.5526561742506, 1105.9944700276446, 1137.397179494869, 1208.0215025829107, 31608.683913160574, 31858.68141318557, 31962.680373196436, 31963.20091997672, 32554.674453255637, 1144.1190283481671, 1183.1836033137108, 1217.8808872561679, 1218.0986070307908, 1268.517963173988, 16954.91522542404, 17121.486355409357, 17199.968001919926, 17354.913225434044, 17356.305747769948, 449823.0, 450633.0, 453191.0, 457299.0, 458609.0, 58441.4155858436, 58575.0, 58737.41262587405, 59065.70467147637, 59103.0, 1400.649837540615, 1444.0252829340154, 1448.8188976377742, 1448.9058211216238, 1460.2187829511372, 29802.85098574493, 30969.225769355948, 31259.53110703296, 31439.84280078585, 32151.19622009375, 49405.25892111693, 49509.75245123752, 49619.7519012417, 49784.502154977985, 50104.49895501144, 385668.0, 386038.0, 386088.0, 386562.0, 391359.0, 27557.0, 28511.572326415535, 28660.283492912844, 28729.281767955134, 28756.856215718788, 47540.0, 47679.0, 47878.0, 48540.27189592088, 48575.75712121417, 40801.1839763209, 41145.1770964585, 41380.58619413767, 41590.37614435725, 42242.0, 39692.801535992134, 40056.599434005286, 40785.79607101945, 41436.378454323814, 41452.37821432621, 41240.38139427851, 41873.58126418697, 42811.14377712366, 43028.56971430371, 44853.55146448624, 35557.64442355543, 36943.0, 37025.44461833128, 37110.25779484341, 38089.4286585707, 27877.721222787513, 28181.71818281873, 28357.858210708815, 28565.0, 28770.28074298159], "value": 19919.643771336287, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [381.2660628290541, 382.77225051094604, 390.9589493103224, 402.5994135834845, 402.7804846358734, 17802.554936126602, 19458.416247512563, 19820.70268945967, 20117.295894643674, 20127.19491220351, 18511.722324165148, 18818.623627527442, 19142.0, 19421.32025379112, 19496.317628882993, 5495.6153069285065, 5660.5471562274915, 5698.401667824881, 5721.542276617861, 5733.512651424634, 5610.635308704942, 5635.408282130379, 5649.1526271059465, 5658.377578466366, 5674.375818659944, 5422.213779002042, 5522.254495643077, 5573.526250268732, 5657.0, 5658.575606829504, 5616.3260408751, 5616.9157462638095, 5620.297462817148, 5628.802991895305, 5660.037793575102, 4954.925676114861, 4983.227599722049, 5002.649814512985, 5069.0, 5069.417017043051, 22717.43206419836, 22817.543649126925, 23137.0745170193, 23333.300000999996, 23371.53256934869, 2246.29241788836, 2329.6738456616085, 2358.092134528219, 2478.306074299181, 3063.938721225563, 7392.408607311402, 7830.647620857075, 9792.461414622192, 10694.572217111307, 13873.930630346884, 1997.5505511259996, 2020.2626041494748, 2038.1032345767962, 2040.1431398812535, 2091.4039498742786, 65181.0, 73894.0, 74109.25890741078, 84259.0, 89074.10925890788, 10503.579856805642, 10527.315724477885, 10566.630167944086, 10593.364398136137, 10611.787764244826, 14525.709485810225, 14650.853491464948, 14660.780088298685, 14708.77936830927, 14762.63093422673, 7917.4560960612125, 7945.28492435672, 7962.601869906482, 8175.305099066646, 8191.426600137933, 7903.881441778378, 7981.321587665114, 8045.839083218303, 8166.4283500154415, 8192.34461243099, 4363.847265345697, 4512.390827238347, 4544.159330523864, 4669.976650116796, 4703.929441058387, 1869.541962219265, 1949.2203118752611, 1960.6671645506597, 1961.7155512450615, 1964.3026725512236, 981.6711401680517, 986.7335819328741, 995.4127065031666, 1083.5828206140534, 1116.7264020315074, 18768.24927002932, 19112.426627201206, 19187.328443504688, 19337.0, 19415.0, 1018.3584341864578, 1032.7779527401494, 1040.604570263295, 1040.9063184313297, 1065.706930594093, 10546.419946902994, 10970.0, 11084.722881928017, 11091.72270693239, 11111.277766945122, 402375.0, 429917.0, 431650.0, 432345.0, 433148.0, 90129.1974160513, 97083.77704118098, 97295.0, 97358.0, 97741.0, 1046.40877903984, 1053.9683809485728, 1069.909057730086, 1091.825307950724, 1093.748437859281, 16471.34114635401, 16771.32914683399, 16950.745738814174, 17161.485155445356, 17306.394276200273, 37406.0, 37427.43858842065, 38021.429678555396, 39974.0, 40133.0, 50975.0, 52820.20769688381, 54824.725876370365, 55410.72294638501, 56092.71953640206, 8419.873701894354, 8454.66181352739, 8466.492010479391, 8591.44155629882, 8713.695020674246, 11738.354390508604, 12855.228686278853, 12919.418626161658, 13035.47858085666, 13117.93441032827, 10932.508037138507, 11364.488598012944, 11461.598844040753, 11474.598389056342, 11506.654800356002, 11254.155938304824, 11404.0, 11601.477933493183, 11604.6518604442, 11785.705357366134, 11418.543258269909, 11558.884411155781, 11666.76666466649, 11759.588414405454, 11943.402829858645, 8345.457545259538, 8474.61864216124, 8534.975802903691, 8632.611532480927, 8740.431871928304, 8881.911180888108, 10659.573617055541, 11539.36533490666, 11655.18413711032, 12024.519019239482], "value": 9086.170910866505, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1504.375684091102, 1512.682336709291, 1690.2985261116637, 1810.0361108197606, 1845.4094689699284, 8021.318187954016, 8689.565521723913, 8708.433951793146, 9288.0, 9292.303077269198, 8684.392092553524, 8903.510306933116, 9009.774755631113, 9009.954950225256, 9026.86459703105, 2316.6061769499224, 2335.708036495438, 2365.077619728307, 2367.810575153992, 2370.1941339944415, 2197.8351623628214, 2285.919992800252, 2380.7262164851004, 2382.8451150675237, 2389.2951579284068, 2321.6401457774073, 2337.1586228957563, 2341.0869760793303, 2341.730700969393, 2363.432776133724, 2326.4067662745974, 2340.157543284416, 2347.9530409391887, 2364.030747393569, 2364.6334818103223, 2328.394617399488, 2374.358923090756, 2374.6912901322717, 2375.7149142102885, 2379.3932547200525, 8848.203661670415, 8930.0, 8937.150970657776, 8985.505797181153, 9052.547372631341, 5289.233061206142, 5370.0, 5388.407275199725, 5456.945430545723, 5461.9453805461835, 3452.4993875887853, 3562.358775420423, 3568.589612194605, 3581.6418358164237, 3622.3298689742483, 1042.9113525350353, 1056.746380868586, 1069.2568664777982, 1069.3209811769505, 1109.2789686703707, 12446.564370247088, 12546.992481202964, 12568.74862502754, 12568.81146782799, 12610.621681349483, 4583.449986001635, 4672.182368085571, 4690.554397332248, 4798.136335459651, 4810.230363141881, 10581.206409519316, 10653.733656658645, 10660.04059634621, 10686.572537098584, 10703.892961070445, 5360.91958620621, 5368.597355198376, 5368.704721240291, 5376.897735964118, 5380.112281473513, 4342.305231162999, 4813.78337974792, 4887.608991280689, 5009.7495125243595, 5019.924701129486, 4099.385092236129, 4123.896453688475, 4170.374443833389, 4184.351425529047, 4209.957900420956, 1265.7658333208385, 1280.219066369514, 1288.774464468733, 1289.6646871813396, 1302.2707283921034, 937.6155776131753, 1004.0662184168793, 1014.2697257974247, 1042.0777611813598, 1047.3297089862494, 5995.100734889714, 6079.270487541523, 6229.595076320024, 6358.205224346957, 6496.9929660902635, 442.52428639212974, 450.9706869053501, 1032.5869652139204, 1043.666026871409, 1092.006274290392, 4346.850328906408, 4429.82280708768, 4465.508794032654, 4514.548545145525, 4566.269396896547, 11049.834252486218, 11448.255863368855, 11517.48171332292, 11569.826452603218, 11638.301701897914, 10640.680779576625, 11048.171387145996, 11141.721456963478, 11350.318980861175, 11393.145514086476, 8272.917270827335, 8325.417220794487, 8381.16188381157, 8452.704155354533, 8548.016978047479, 6177.227846519185, 6198.163247961648, 6322.46259067966, 6356.872862542631, 6403.743850246125, 9939.403635781877, 10269.281150319406, 10300.484975751033, 10401.179793536252, 10415.479226038517, 10304.948475257575, 10395.0, 10404.167666586503, 10520.263581549218, 10572.788544228919, 7190.06529151207, 7848.725294614889, 7958.164392738679, 8073.313768329758, 8099.190080992089, 9001.594928228114, 9036.954815225881, 9037.909620903969, 9108.362414630912, 9127.178553930178, 7925.960370198112, 7966.561839098905, 8035.477693949874, 8065.435419520812, 8162.0, 8055.83888322242, 8063.435559510778, 8072.959635202022, 8113.066997295151, 8233.094359620556, 7087.0, 7270.200277969525, 7323.707051718085, 7382.114146302478, 7466.813329666802, 5324.361076670824, 5359.490848369399, 5384.111621582395, 5389.568834493152, 5403.0544654686055, 5397.892042159214, 5574.136008918624, 5584.553235741212, 5705.286839145107, 5793.333766616893], "value": 4761.677462588889, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [343.38019874127195, 344.63812996353823, 346.29010528416757, 348.2912273523379, 349.0, 5558.722063896809, 5587.7485513151905, 5605.1974012993505, 5651.745671444784, 5653.717314134297, 5600.6079574429805, 5604.663720176793, 5612.719364031792, 5634.098544232924, 5670.744816483258, 3906.746061505993, 4070.2470043041985, 4217.36739489076, 4251.702380833343, 4308.0737641407095, 4221.256183480731, 4274.252005898971, 4288.442502474674, 4295.463067116611, 4301.397804307384, 4246.171996460692, 4259.275923093066, 4266.253405653998, 4275.187714334266, 4278.930267433142, 4176.352665336847, 4277.828886844538, 4288.849890253826, 4300.763458009824, 4305.9784701076605, 3817.8854634361014, 3831.547809401985, 3831.6589193782233, 3834.9041273968096, 3843.865464708722, 5340.439253878365, 5346.625736198468, 5348.51863332298, 5397.595180361449, 5452.972735136339, 4820.903581928377, 4964.131277026506, 4984.102861484931, 5003.099442100421, 5016.54851063406, 5776.653400795965, 5784.479396854304, 5793.246877905887, 5800.651960882361, 5806.912896306559, 4208.158368326316, 4217.641500472463, 4223.957760422387, 4224.408582798411, 4250.553691862341, 5872.618279811799, 6002.579819412686, 6028.7588496460085, 6059.878802423971, 6095.573309868311, 4264.424302719093, 4289.056407590325, 4291.596705844737, 4297.333913243452, 4297.419848320436, 4337.284348082531, 4339.869803905888, 4356.259435895905, 4362.389265502832, 4367.170237654836, 4805.8558243252055, 4904.455096644546, 5003.449620541737, 5014.222795466709, 5033.892543640393, 5812.0, 5814.186013958049, 5844.925051606619, 5875.504075075323, 5886.529077673776, 1455.8689717925438, 1459.1318165691396, 1468.194121230892, 1474.5328398243603, 1475.9926200369143, 976.7655762616921, 1016.6340117557673, 1018.6638409324905, 1021.1218352217236, 1022.4325499347784, 5434.831511225106, 5435.673859568438, 5436.456354364532, 5444.5916556258435, 5471.2887324647545, 5826.592138550261, 5827.854303642443, 5870.941290587125, 5898.469137777621, 5907.940920590825, 5361.222622719683, 5497.670139791625, 5512.944870551243, 5519.061759500894, 5534.584906132056, 3071.3550154467366, 3091.984540077285, 3108.6477382338753, 3121.4537455945574, 3122.6877312269044, 5854.414558544111, 5973.342932277446, 6003.0, 6023.969880150659, 6072.301685306158, 5914.645121292736, 5975.40245975399, 5988.700564971734, 6006.468350570664, 6023.27720673522, 6150.0, 6211.2857021443115, 6230.221222347207, 6250.624962502265, 6262.906056409249, 5969.0, 5977.3424923257535, 5978.402159784161, 6036.154938308552, 6037.335893051673, 6014.308354539284, 6015.308239552332, 6019.72911219005, 6041.909371359521, 6054.66699331541, 6241.531885108726, 6243.940469170165, 6297.338779428277, 6304.401081897213, 6305.8108256752375, 3999.3201155803004, 4235.1317979814685, 4242.554531774119, 4252.8724138274665, 4288.0, 6009.0470597055255, 6017.18767966319, 6029.457348838626, 6077.936361136695, 6082.787102451393, 5880.029795083934, 5908.586398952032, 5915.988563888299, 5925.229720136354, 5928.584999050025, 5667.773289068391, 5847.970760146172, 5875.236219291465, 5957.731902064331, 5959.76160953557, 5759.308882933907, 5770.365259821332, 5780.808913537651, 5818.796342128006, 5840.532757379485, 5618.185363122243, 5850.414958504116, 5900.672348721503, 5909.552159720896, 5926.436988486087, 5779.723004976203, 5855.9211479924015, 5858.414158584107, 5861.622518708185, 5862.0], "value": 4441.312893566071, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [847.5635047950306, 881.8941726992758, 884.4030279561297, 890.1365675294966, 898.8876390451194, 14711.779323310146, 15452.690946181083, 15613.609659758511, 15633.452829150981, 15681.529554113366, 14396.064255823365, 14509.419623215084, 14513.27433628317, 14533.200673962929, 14577.708445831076, 677.9220389655179, 803.0, 821.6713314674133, 830.7134038756619, 831.6714897615439, 821.7082935557851, 824.1017291152642, 825.6738588257665, 832.3008672714918, 834.1950018232404, 871.0375035585681, 871.1506281375672, 871.651339464213, 872.8952525696893, 873.3537182484947, 860.9784755381103, 866.956652167389, 867.4621734524603, 868.6916144768611, 869.5261082709939, 634.4099987012077, 636.2492259134219, 637.5377851057946, 637.7863415755681, 639.1084437210112, 14532.491362802251, 14672.486462973851, 14707.264636768119, 14754.262286885612, 14769.483068092564, 14407.351669174912, 14470.927645361811, 14506.202158881257, 14582.489612863605, 14823.925880370636, 11377.2035957483, 11387.943060284728, 11470.885291147066, 11534.192606517547, 11684.0, 3793.844660386521, 3851.326017946876, 3913.8043097844993, 3929.5677475477673, 3963.207358528277, 56641.0, 56645.0, 56858.7157064212, 57054.0, 57583.71208143933, 11297.774044519228, 11311.660650180507, 11410.714732131597, 11431.371274579978, 11475.77048459026, 19269.22923083061, 19299.710504342445, 19412.417627470917, 19434.70847937282, 19450.902745486183, 8336.333093352518, 8493.27807136388, 8604.78488037804, 8818.779530511789, 8932.776680583038, 4628.190066738307, 4804.8318308859025, 4919.704817710949, 4927.630427717935, 5046.066477701637, 3540.822958852047, 3644.7448678592773, 3685.207680348738, 3690.169711814874, 3691.6123807000417, 647.2362612117746, 658.7319410135566, 659.6009414304373, 662.2483481248721, 665.4277321503503, 721.3111478537984, 768.2240936654019, 770.2413123073768, 782.0771489642277, 804.5977011494252, 9191.21874640663, 9262.259019278576, 9365.765855853659, 9391.295652826066, 9562.99588543193, 644.7421279465963, 712.2094475132599, 717.9174394944544, 732.7362149626131, 734.2473964186752, 4314.590113939171, 4327.740335579875, 4447.710898791568, 4477.149341625146, 4517.841875534406, 59240.70379648074, 60096.09855852078, 63180.68409657922, 63229.36770632235, 63559.682201588694, 54592.181117283275, 54655.72672136614, 54747.45252547503, 56118.438815612135, 58034.70982645144, 50975.49024509708, 51157.0, 51469.48530514647, 51718.74140629348, 52235.73882130565, 8240.793980150544, 8441.95779021101, 8447.704330348408, 8565.914340856762, 8608.48349099031, 33638.49542256917, 34064.31871362509, 34218.802341917915, 34246.657533424346, 34569.82715086408, 44050.559494404646, 44611.77694111509, 45431.54568454273, 45761.313580296985, 46202.53797461982, 12530.436130374337, 12599.43302551369, 12951.963842892357, 13100.344982751016, 13314.866851331362, 13382.598522044354, 13383.130096543693, 13698.589042328746, 13699.726005480034, 14548.49080282185, 12553.6341825206, 13190.274534900673, 13328.733425331633, 13417.731645366843, 13470.393832277767, 13059.738805224033, 13073.215607063607, 13122.60632181036, 13576.0, 13973.580792576238, 12903.935480322538, 13052.282124483245, 13171.47314107425, 13290.335483225606, 13378.0, 10935.453227338443, 11011.229213955266, 11115.388653623804, 11315.0, 11396.772064558496, 10637.840432393676, 10722.678319650424, 10741.562944301775, 10829.350238985686, 10866.0], "value": 6941.502819972624, "unit": "score"}], "name": "dromaeo_css", "value": 7251.4487662929505, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 112.0, 103.0, 113.0, 117.0, 113.0, 106.0, 111.0, 112.0, 112.0], "value": 110.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 125.0, 162.0, 181.0, 125.0, 162.0, 157.0, 126.0, 192.0, 133.0], "value": 152.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 162.0, 161.0, 162.0, 162.0, 172.0, 163.0, 161.0, 160.0], "value": 162.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 73.0, 74.0, 161.0, 77.0, 76.0, 74.0, 77.0, 169.0, 75.0], "value": 93.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 91.0, 163.0, 92.0, 91.0, 92.0, 151.0, 91.0, 91.0, 154.0], "value": 110.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 117.0, 117.0, 117.0, 117.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 146.0, 146.0, 146.0, 148.0, 146.0, 147.0, 147.0, 148.0, 148.0], "value": 147.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 58.0, 64.0, 57.0, 57.0, 58.0, 57.0, 73.0, 57.0, 55.0], "value": 59.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 60.0, 59.0, 61.0, 60.0, 60.0, 60.0, 68.0, 60.0], "value": 60.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 79.0, 85.0, 84.0, 89.0, 80.0, 79.0, 78.0, 79.0, 80.0], "value": 81.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 128.0, 123.0, 125.0, 123.0, 123.0, 125.0, 128.0, 157.0, 129.0], "value": 128.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 172.0, 171.0, 165.0, 166.0, 171.0, 166.0, 164.0, 165.0, 168.0], "value": 167.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 74.0, 65.0, 65.0, 64.0, 64.0, 65.0, 63.0, 69.0, 64.0], "value": 65.8, "unit": "score"}], "name": "kraken", "value": 1552.6, "alertThreshold": 2.0}]} 08:43:24 INFO - Return code: 0 08:43:24 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 08:43:24 ERROR - # TBPL SUCCESS # 08:43:24 INFO - Running post-action listener: _resource_record_post_action 08:43:24 INFO - ##### 08:43:24 INFO - ##### Finished run-tests step (success) 08:43:24 INFO - ##### 08:43:24 INFO - Running post-run listener: _resource_record_post_run 08:43:25 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 8065024; Write bytes: 425771008; Read time: 1308; Write time: 360012 08:43:25 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 89645056; Read time: 0; Write time: 71852 08:43:25 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 6328320; Write bytes: 336125952; Read time: 1268; Write time: 288160 08:43:25 INFO - Running post-run listener: _upload_blobber_files 08:43:25 INFO - Blob upload gear active. 08:43:25 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:43:25 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:43:25 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:43:25 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:43:25 INFO - (blobuploader) - INFO - Open directory for files ... 08:43:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 08:43:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:43:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:43:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 08:43:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:43:26 INFO - (blobuploader) - INFO - Done attempting. 08:43:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 08:43:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:43:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:43:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 08:43:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:43:27 INFO - (blobuploader) - INFO - Done attempting. 08:43:27 INFO - (blobuploader) - INFO - Iteration through files over. 08:43:27 INFO - Return code: 0 08:43:27 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:43:27 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:43:27 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a4e0cde7eabb512044916e48c524b530015da85b210e80bb85746547905e362cbf2c97cc52113dd851a844d3c8b565c91cac387e7ce272a90b3066f33f7fab9c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/43cf561e72f7d8afc95bc0bfe2ad2b23732efe4ecc16e24bb2147ab3660d689f1c20f07e52d358ea338e46239a539d077a65f3e2a5c03d3c84e20c8cfaa88d90"} 08:43:27 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:43:27 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:43:27 INFO - Contents: 08:43:27 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a4e0cde7eabb512044916e48c524b530015da85b210e80bb85746547905e362cbf2c97cc52113dd851a844d3c8b565c91cac387e7ce272a90b3066f33f7fab9c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/43cf561e72f7d8afc95bc0bfe2ad2b23732efe4ecc16e24bb2147ab3660d689f1c20f07e52d358ea338e46239a539d077a65f3e2a5c03d3c84e20c8cfaa88d90"} 08:43:27 INFO - Running post-run listener: copy_logs_to_upload_dir 08:43:27 INFO - Copying logs to upload dir... 08:43:27 INFO - mkdir: /builds/slave/test/build/upload/logs 08:43:27 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.900900 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-05-06 08:43:27.500544) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-06 08:43:27.504187) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1462546946.797051-141093476 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/a4e0cde7eabb512044916e48c524b530015da85b210e80bb85746547905e362cbf2c97cc52113dd851a844d3c8b565c91cac387e7ce272a90b3066f33f7fab9c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/43cf561e72f7d8afc95bc0bfe2ad2b23732efe4ecc16e24bb2147ab3660d689f1c20f07e52d358ea338e46239a539d077a65f3e2a5c03d3c84e20c8cfaa88d90"} build_url:https://queue.taskcluster.net/v1/task/NFQ2NwvDQIKh3tZ4u3cv8A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011217 build_url: 'https://queue.taskcluster.net/v1/task/NFQ2NwvDQIKh3tZ4u3cv8A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a4e0cde7eabb512044916e48c524b530015da85b210e80bb85746547905e362cbf2c97cc52113dd851a844d3c8b565c91cac387e7ce272a90b3066f33f7fab9c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/43cf561e72f7d8afc95bc0bfe2ad2b23732efe4ecc16e24bb2147ab3660d689f1c20f07e52d358ea338e46239a539d077a65f3e2a5c03d3c84e20c8cfaa88d90"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-06 08:43:27.528638) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 08:43:27.528997) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1462546946.797051-141093476 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004426 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 08:43:27.612905) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-06 08:43:27.613214) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-06 08:43:27.613515) ========= ========= Total master_lag: 0.16 =========