builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-054 starttime: 1462803275.77 results: success (0) buildid: 20160509040557 builduid: 5e1b192add0c487182cf725d3895dd3e revision: 043082cb7bd8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-09 07:14:35.768838) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-09 07:14:35.769277) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-09 07:14:35.769574) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-09 07:14:35.786225) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 07:14:35.786518) ========= 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=cbe409c6de289db6ac707de3000001d4-1462802875.667723-1287373266 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-09 07:14:36-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.4M=0s 2016-05-09 07:14:36 (46.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.125188 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 07:14:35.926314) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 07:14:35.926635) ========= 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=cbe409c6de289db6ac707de3000001d4-1462802875.667723-1287373266 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019108 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 07:14:35.980416) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 07:14:35.980836) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 043082cb7bd8 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 043082cb7bd8 --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=cbe409c6de289db6ac707de3000001d4-1462802875.667723-1287373266 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-09 07:14:36,685 Setting DEBUG logging. 2016-05-09 07:14:36,685 attempt 1/10 2016-05-09 07:14:36,685 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/043082cb7bd8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-09 07:14:36,911 unpacking tar archive at: mozilla-central-043082cb7bd8/testing/mozharness/ program finished with exit code 0 elapsedTime=0.500872 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 07:14:36.497762) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-09 07:14:36.498099) ========= script_repo_revision: 043082cb7bd8 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-09 07:14:36.498868) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-09 07:14:36.499150) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-09 07:14:36.508640) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-05-09 07:14:36.508918) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=cbe409c6de289db6ac707de3000001d4-1462802875.667723-1287373266 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:14:37 INFO - MultiFileLogger online at 20160509 07:14:37 in /builds/slave/test 07:14:37 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 07:14:37 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:14:37 INFO - {'append_to_log': False, 07:14:37 INFO - 'base_work_dir': '/builds/slave/test', 07:14:37 INFO - 'blob_upload_branch': 'Firefox', 07:14:37 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:14:37 INFO - 'branch': 'Firefox', 07:14:37 INFO - 'buildbot_json_path': 'buildprops.json', 07:14:37 INFO - 'config_files': ('talos/linux_config.py',), 07:14:37 INFO - 'default_actions': ('clobber', 07:14:37 INFO - 'read-buildbot-config', 07:14:37 INFO - 'download-and-extract', 07:14:37 INFO - 'populate-webroot', 07:14:37 INFO - 'create-virtualenv', 07:14:37 INFO - 'install', 07:14:37 INFO - 'run-tests'), 07:14:37 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:14:37 INFO - 'download_minidump_stackwalk': True, 07:14:37 INFO - 'download_symbols': 'ondemand', 07:14:37 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:14:37 INFO - 'tooltool.py': '/tools/tooltool.py', 07:14:37 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:14:37 INFO - '/tools/misc-python/virtualenv.py')}, 07:14:37 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:14:37 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:14:37 INFO - 'installer_path': 'installer.exe', 07:14:37 INFO - 'log_level': 'info', 07:14:37 INFO - 'log_name': 'talos', 07:14:37 INFO - 'log_to_console': True, 07:14:37 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:14:37 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:14:37 INFO - 'opt_config_files': (), 07:14:37 INFO - 'pip_index': False, 07:14:37 INFO - 'sps_profile': False, 07:14:37 INFO - 'sps_profile_interval': 0, 07:14:37 INFO - 'suite': 'dromaeojs-e10s', 07:14:37 INFO - 'system_bits': '32', 07:14:37 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:14:37 INFO - 'title': 'talos-linux64-ix-054', 07:14:37 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:14:37 INFO - 'use_talos_json': True, 07:14:37 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:14:37 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:14:37 INFO - 'work_dir': 'build'} 07:14:37 INFO - ##### 07:14:37 INFO - ##### Running clobber step. 07:14:37 INFO - ##### 07:14:37 INFO - Running pre-action listener: _resource_record_pre_action 07:14:37 INFO - Running main action method: clobber 07:14:37 INFO - rmtree: /builds/slave/test/build 07:14:37 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:14:37 INFO - Running post-action listener: _resource_record_post_action 07:14:37 INFO - ##### 07:14:37 INFO - ##### Finished clobber step (success) 07:14:37 INFO - ##### 07:14:37 INFO - ##### 07:14:37 INFO - ##### Running read-buildbot-config step. 07:14:37 INFO - ##### 07:14:37 INFO - Running pre-action listener: _resource_record_pre_action 07:14:37 INFO - Running main action method: read_buildbot_config 07:14:37 INFO - Using buildbot properties: 07:14:37 INFO - { 07:14:37 INFO - "project": "", 07:14:37 INFO - "product": "firefox", 07:14:37 INFO - "script_repo_revision": "production", 07:14:37 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 07:14:37 INFO - "repository": "", 07:14:37 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 07:14:37 INFO - "buildid": "20160509040557", 07:14:37 INFO - "stage_platform": "linux64-pgo", 07:14:37 INFO - "basedir": "/builds/slave/test", 07:14:37 INFO - "nightly_build": "True", 07:14:37 INFO - "buildnumber": 27, 07:14:37 INFO - "slavename": "talos-linux64-ix-054", 07:14:37 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 07:14:37 INFO - "platform": "ubuntu64_hw", 07:14:37 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 07:14:37 INFO - "branch": "mozilla-central", 07:14:37 INFO - "repo_path": "mozilla-central", 07:14:37 INFO - "revision": "043082cb7bd8", 07:14:37 INFO - "pgo_build": "True", 07:14:37 INFO - "builduid": "5e1b192add0c487182cf725d3895dd3e", 07:14:37 INFO - "slavebuilddir": "test" 07:14:37 INFO - } 07:14:37 INFO - Found installer url https://queue.taskcluster.net/v1/task/Gx7NyQHERGCqQDddiVh7kg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 07:14:37 INFO - Running post-action listener: _resource_record_post_action 07:14:37 INFO - ##### 07:14:37 INFO - ##### Finished read-buildbot-config step (success) 07:14:37 INFO - ##### 07:14:37 INFO - ##### 07:14:37 INFO - ##### Running download-and-extract step. 07:14:37 INFO - ##### 07:14:37 INFO - Running pre-action listener: _resource_record_pre_action 07:14:37 INFO - Running main action method: download_and_extract 07:14:37 INFO - mkdir: /builds/slave/test/build/tests 07:14:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 07:14:37 INFO - https://queue.taskcluster.net/v1/task/Gx7NyQHERGCqQDddiVh7kg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 07:14:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gx7NyQHERGCqQDddiVh7kg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 07:14:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gx7NyQHERGCqQDddiVh7kg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 07:14:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gx7NyQHERGCqQDddiVh7kg/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 07:14:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gx7NyQHERGCqQDddiVh7kg/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 07:14:44 INFO - Downloaded 1361 bytes. 07:14:44 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 07:14:44 INFO - Using the following test package requirements: 07:14:44 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 07:14:44 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:14:44 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:14:44 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:14:44 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:14:44 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:14:44 INFO - u'jsshell-linux-x86_64.zip'], 07:14:44 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:14:44 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:14:44 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 07:14:44 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:14:44 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:14:44 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:14:44 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:14:44 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:14:44 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:14:44 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:14:44 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:14:44 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:14:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 07:14:44 INFO - https://queue.taskcluster.net/v1/task/Gx7NyQHERGCqQDddiVh7kg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:14:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gx7NyQHERGCqQDddiVh7kg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 07:14:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gx7NyQHERGCqQDddiVh7kg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 07:14:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gx7NyQHERGCqQDddiVh7kg/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 07:14:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gx7NyQHERGCqQDddiVh7kg/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 07:14:46 INFO - Downloaded 23895261 bytes. 07:14:46 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'] 07:14:46 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 07:14:47 INFO - Return code: 0 07:14:47 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 07:14:47 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')]} 07:14:47 INFO - https://queue.taskcluster.net/v1/task/Gx7NyQHERGCqQDddiVh7kg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:14:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gx7NyQHERGCqQDddiVh7kg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 07:14:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gx7NyQHERGCqQDddiVh7kg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 07:14:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gx7NyQHERGCqQDddiVh7kg/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 07:14:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gx7NyQHERGCqQDddiVh7kg/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 07:14:50 INFO - Downloaded 23895261 bytes. 07:14:50 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'] 07:14:50 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 07:14:51 INFO - Return code: 0 07:14:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:14:51 INFO - https://queue.taskcluster.net/v1/task/Gx7NyQHERGCqQDddiVh7kg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:14:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gx7NyQHERGCqQDddiVh7kg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 07:14:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gx7NyQHERGCqQDddiVh7kg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 07:14:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gx7NyQHERGCqQDddiVh7kg/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 07:14:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gx7NyQHERGCqQDddiVh7kg/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 07:14:52 INFO - Downloaded 10840152 bytes. 07:14:52 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'] 07:14:52 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 07:14:53 INFO - Return code: 0 07:14:53 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')]} 07:14:53 INFO - https://queue.taskcluster.net/v1/task/Gx7NyQHERGCqQDddiVh7kg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:14:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gx7NyQHERGCqQDddiVh7kg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 07:14:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gx7NyQHERGCqQDddiVh7kg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 07:14:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gx7NyQHERGCqQDddiVh7kg/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 07:14:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gx7NyQHERGCqQDddiVh7kg/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 07:14:55 INFO - Downloaded 58442478 bytes. 07:14:55 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Gx7NyQHERGCqQDddiVh7kg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 07:14:55 INFO - mkdir: /builds/slave/test/properties 07:14:55 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:14:55 INFO - Writing to file /builds/slave/test/properties/build_url 07:14:55 INFO - Contents: 07:14:55 INFO - build_url:https://queue.taskcluster.net/v1/task/Gx7NyQHERGCqQDddiVh7kg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 07:14:56 INFO - Running post-action listener: _resource_record_post_action 07:14:56 INFO - Running post-action listener: set_extra_try_arguments 07:14:56 INFO - ##### 07:14:56 INFO - ##### Finished download-and-extract step (success) 07:14:56 INFO - ##### 07:14:56 INFO - ##### 07:14:56 INFO - ##### Running populate-webroot step. 07:14:56 INFO - ##### 07:14:56 INFO - Running pre-action listener: _resource_record_pre_action 07:14:56 INFO - Running main action method: populate_webroot 07:14:56 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:14:56 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:14:56 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:14:56 INFO - '--tppagecycles', 07:14:56 INFO - '7'], 07:14:56 INFO - 'tests': ['tsvgm']}}, 07:14:56 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:14:56 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:14:56 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:14:56 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:14:56 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:14:56 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:14:56 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:14:56 INFO - 'talos_options': ['--disable-e10s'], 07:14:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:14:56 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:14:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:14:56 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:14:56 INFO - 'talos_options': ['--disable-e10s'], 07:14:56 INFO - 'tests': ['damp', 'tps']}, 07:14:56 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:14:56 INFO - 'tests': ['damp', 'tps']}, 07:14:56 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:14:56 INFO - 'tests': ['dromaeo_dom']}, 07:14:56 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:14:56 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:14:56 INFO - 'tests': ['a11yr', 07:14:56 INFO - 'ts_paint', 07:14:56 INFO - 'tpaint', 07:14:56 INFO - 'sessionrestore', 07:14:56 INFO - 'sessionrestore_no_auto_restore', 07:14:56 INFO - 'tabpaint']}, 07:14:56 INFO - 'other-e10s': {'tests': ['a11yr', 07:14:56 INFO - 'ts_paint', 07:14:56 INFO - 'tpaint', 07:14:56 INFO - 'sessionrestore', 07:14:56 INFO - 'sessionrestore_no_auto_restore', 07:14:56 INFO - 'tabpaint']}, 07:14:56 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:14:56 INFO - 'ts_paint', 07:14:56 INFO - 'tpaint', 07:14:56 INFO - 'sessionrestore', 07:14:56 INFO - 'sessionrestore_no_auto_restore', 07:14:56 INFO - 'tabpaint']}, 07:14:56 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:14:56 INFO - 'ts_paint', 07:14:56 INFO - 'tpaint', 07:14:56 INFO - 'sessionrestore', 07:14:56 INFO - 'sessionrestore_no_auto_restore', 07:14:56 INFO - 'tabpaint']}, 07:14:56 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:14:56 INFO - 'tests': ['a11yr', 07:14:56 INFO - 'ts_paint', 07:14:56 INFO - 'tpaint', 07:14:56 INFO - 'sessionrestore', 07:14:56 INFO - 'sessionrestore_no_auto_restore', 07:14:56 INFO - 'tabpaint']}, 07:14:56 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:14:56 INFO - 'tests': ['a11yr', 07:14:56 INFO - 'ts_paint', 07:14:56 INFO - 'tpaint', 07:14:56 INFO - 'sessionrestore', 07:14:56 INFO - 'sessionrestore_no_auto_restore', 07:14:56 INFO - 'tabpaint']}, 07:14:56 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:14:56 INFO - 'tests': ['tsvgx', 07:14:56 INFO - 'tsvgr_opacity', 07:14:56 INFO - 'tart', 07:14:56 INFO - 'tscrollx', 07:14:56 INFO - 'cart']}, 07:14:56 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:14:56 INFO - 'tsvgr_opacity', 07:14:56 INFO - 'tart', 07:14:56 INFO - 'tscrollx', 07:14:56 INFO - 'cart']}, 07:14:56 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:14:56 INFO - 'talos_options': ['--disable-e10s'], 07:14:56 INFO - 'tests': ['tp5o']}, 07:14:56 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:14:56 INFO - 'tests': ['tp5o']}, 07:14:56 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:14:56 INFO - 'talos_options': ['--disable-e10s', 07:14:56 INFO - '--xperf_path', 07:14:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:14:56 INFO - 'tests': ['tp5n']}, 07:14:56 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:14:56 INFO - 'talos_options': ['--xperf_path', 07:14:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:14:56 INFO - 'tests': ['tp5n']}}, 07:14:56 INFO - 'talos.zip': {'path': '', 07:14:56 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:14:56 INFO - Running post-action listener: _resource_record_post_action 07:14:56 INFO - ##### 07:14:56 INFO - ##### Finished populate-webroot step (success) 07:14:56 INFO - ##### 07:14:56 INFO - ##### 07:14:56 INFO - ##### Running create-virtualenv step. 07:14:56 INFO - ##### 07:14:56 INFO - Running pre-action listener: _resource_record_pre_action 07:14:56 INFO - Running main action method: create_virtualenv 07:14:56 INFO - Creating virtualenv /builds/slave/test/build/venv 07:14:56 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 07:14:56 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:14:56 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:14:56 INFO - Using real prefix '/usr' 07:14:56 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:14:57 INFO - Installing distribute.............................................................................................................................................................................................done. 07:14:59 INFO - Installing pip.................done. 07:14:59 INFO - Return code: 0 07:14:59 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:14:59 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')]} 07:14:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:14:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:14:59 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')]} 07:14:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:14:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:14:59 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 0x7ff3eee66f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c92770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d219c0>, '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 0x2d228c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d22d50>, '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': 'cbe409c6de289db6ac707de3000001d4-1462802875.667723-1287373266', '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 07:14:59 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 07:14:59 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 07:14:59 INFO - Using env: {'DISPLAY': ':0', 07:14:59 INFO - 'HOME': '/home/cltbld', 07:14:59 INFO - 'LANG': 'en_US.UTF-8', 07:14:59 INFO - 'LANGUAGE': 'en_US:en', 07:14:59 INFO - 'LOGNAME': 'cltbld', 07:14:59 INFO - 'MAIL': '/var/mail/cltbld', 07:14:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:14:59 INFO - 'MOZ_NO_REMOTE': '1', 07:14:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:14:59 INFO - 'NO_EM_RESTART': '1', 07:14:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:14:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:14:59 INFO - 'PWD': '/builds/slave/test', 07:14:59 INFO - 'SHELL': '/bin/bash', 07:14:59 INFO - 'SHLVL': '1', 07:14:59 INFO - 'TERM': 'linux', 07:14:59 INFO - 'TMOUT': '86400', 07:14:59 INFO - 'USER': 'cltbld', 07:14:59 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1462802875.667723-1287373266', 07:14:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:14:59 INFO - '_': '/tools/buildbot/bin/python'} 07:14:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:14:59 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 07:14:59 INFO - Cleaning up... 07:14:59 INFO - Return code: 0 07:14:59 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 07:14:59 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')]} 07:14:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:14:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:14:59 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')]} 07:14:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:14:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:14:59 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 0x7ff3eee66f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c92770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d219c0>, '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 0x2d228c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d22d50>, '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': 'cbe409c6de289db6ac707de3000001d4-1462802875.667723-1287373266', '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 07:14:59 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 07:14:59 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 07:14:59 INFO - Using env: {'DISPLAY': ':0', 07:14:59 INFO - 'HOME': '/home/cltbld', 07:14:59 INFO - 'LANG': 'en_US.UTF-8', 07:14:59 INFO - 'LANGUAGE': 'en_US:en', 07:14:59 INFO - 'LOGNAME': 'cltbld', 07:14:59 INFO - 'MAIL': '/var/mail/cltbld', 07:14:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:14:59 INFO - 'MOZ_NO_REMOTE': '1', 07:14:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:14:59 INFO - 'NO_EM_RESTART': '1', 07:14:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:14:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:14:59 INFO - 'PWD': '/builds/slave/test', 07:14:59 INFO - 'SHELL': '/bin/bash', 07:14:59 INFO - 'SHLVL': '1', 07:14:59 INFO - 'TERM': 'linux', 07:14:59 INFO - 'TMOUT': '86400', 07:14:59 INFO - 'USER': 'cltbld', 07:14:59 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1462802875.667723-1287373266', 07:14:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:14:59 INFO - '_': '/tools/buildbot/bin/python'} 07:14:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:14:59 INFO - Downloading/unpacking psutil>=0.7.1 07:14:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:14:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:14:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:14:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:14:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:14:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:15:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:15:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:15:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:15:01 INFO - Installing collected packages: psutil 07:15:01 INFO - Running setup.py install for psutil 07:15:01 INFO - building 'psutil._psutil_linux' extension 07:15:01 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 07:15:01 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 07:15:01 INFO - building 'psutil._psutil_posix' extension 07:15:01 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 07:15:02 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 07:15:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:15:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:15:02 INFO - Successfully installed psutil 07:15:02 INFO - Cleaning up... 07:15:02 INFO - Return code: 0 07:15:02 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 07:15:02 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')]} 07:15:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:15:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:02 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')]} 07:15:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:15:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:02 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 0x7ff3eee66f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c92770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d219c0>, '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 0x2d228c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d22d50>, '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': 'cbe409c6de289db6ac707de3000001d4-1462802875.667723-1287373266', '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 07:15:02 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 07:15:02 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 07:15:02 INFO - Using env: {'DISPLAY': ':0', 07:15:02 INFO - 'HOME': '/home/cltbld', 07:15:02 INFO - 'LANG': 'en_US.UTF-8', 07:15:02 INFO - 'LANGUAGE': 'en_US:en', 07:15:02 INFO - 'LOGNAME': 'cltbld', 07:15:02 INFO - 'MAIL': '/var/mail/cltbld', 07:15:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:15:02 INFO - 'MOZ_NO_REMOTE': '1', 07:15:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:15:02 INFO - 'NO_EM_RESTART': '1', 07:15:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:15:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:15:02 INFO - 'PWD': '/builds/slave/test', 07:15:02 INFO - 'SHELL': '/bin/bash', 07:15:02 INFO - 'SHLVL': '1', 07:15:02 INFO - 'TERM': 'linux', 07:15:02 INFO - 'TMOUT': '86400', 07:15:02 INFO - 'USER': 'cltbld', 07:15:02 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1462802875.667723-1287373266', 07:15:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:15:02 INFO - '_': '/tools/buildbot/bin/python'} 07:15:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:15:02 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 07:15:02 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 07:15:02 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 07:15:02 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 07:15:02 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 07:15:02 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 07:15:02 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 07:15:04 INFO - Downloading mozsystemmonitor-0.0.tar.gz 07:15:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:15:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 07:15:04 INFO - Installing collected packages: mozsystemmonitor 07:15:04 INFO - Running setup.py install for mozsystemmonitor 07:15:04 INFO - Successfully installed mozsystemmonitor 07:15:04 INFO - Cleaning up... 07:15:04 INFO - Return code: 0 07:15:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:15:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 07:15:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:15:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 07:15:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:15:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:04 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 0x7ff3eee66f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c92770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d219c0>, '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 0x2d228c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d22d50>, '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': 'cbe409c6de289db6ac707de3000001d4-1462802875.667723-1287373266', '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 07:15:04 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 07:15:04 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 07:15:04 INFO - Using env: {'DISPLAY': ':0', 07:15:04 INFO - 'HOME': '/home/cltbld', 07:15:04 INFO - 'LANG': 'en_US.UTF-8', 07:15:04 INFO - 'LANGUAGE': 'en_US:en', 07:15:04 INFO - 'LOGNAME': 'cltbld', 07:15:04 INFO - 'MAIL': '/var/mail/cltbld', 07:15:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:15:04 INFO - 'MOZ_NO_REMOTE': '1', 07:15:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:15:04 INFO - 'NO_EM_RESTART': '1', 07:15:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:15:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:15:04 INFO - 'PWD': '/builds/slave/test', 07:15:04 INFO - 'SHELL': '/bin/bash', 07:15:04 INFO - 'SHLVL': '1', 07:15:04 INFO - 'TERM': 'linux', 07:15:04 INFO - 'TMOUT': '86400', 07:15:04 INFO - 'USER': 'cltbld', 07:15:04 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1462802875.667723-1287373266', 07:15:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:15:04 INFO - '_': '/tools/buildbot/bin/python'} 07:15:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:15:04 INFO - Downloading/unpacking blobuploader==1.2.4 07:15:04 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 07:15:04 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 07:15:04 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 07:15:04 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 07:15:04 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 07:15:04 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 07:15:06 INFO - Downloading blobuploader-1.2.4.tar.gz 07:15:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:15:06 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:15:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:15:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:15:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:15:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:15:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:15:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:15:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:15:07 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:15:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:15:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:15:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:15:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:15:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:15:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:15:07 INFO - Downloading docopt-0.6.1.tar.gz 07:15:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:15:07 INFO - Installing collected packages: blobuploader, requests, docopt 07:15:07 INFO - Running setup.py install for blobuploader 07:15:07 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:15:07 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:15:07 INFO - Running setup.py install for requests 07:15:07 INFO - Running setup.py install for docopt 07:15:08 INFO - Successfully installed blobuploader requests docopt 07:15:08 INFO - Cleaning up... 07:15:08 INFO - Return code: 0 07:15:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:15:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 07:15:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:15:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 07:15:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:15:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:08 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 0x7ff3eee66f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c92770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d219c0>, '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 0x2d228c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d22d50>, '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': 'cbe409c6de289db6ac707de3000001d4-1462802875.667723-1287373266', '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 07:15:08 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 07:15:08 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 07:15:08 INFO - Using env: {'DISPLAY': ':0', 07:15:08 INFO - 'HOME': '/home/cltbld', 07:15:08 INFO - 'LANG': 'en_US.UTF-8', 07:15:08 INFO - 'LANGUAGE': 'en_US:en', 07:15:08 INFO - 'LOGNAME': 'cltbld', 07:15:08 INFO - 'MAIL': '/var/mail/cltbld', 07:15:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:15:08 INFO - 'MOZ_NO_REMOTE': '1', 07:15:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:15:08 INFO - 'NO_EM_RESTART': '1', 07:15:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:15:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:15:08 INFO - 'PWD': '/builds/slave/test', 07:15:08 INFO - 'SHELL': '/bin/bash', 07:15:08 INFO - 'SHLVL': '1', 07:15:08 INFO - 'TERM': 'linux', 07:15:08 INFO - 'TMOUT': '86400', 07:15:08 INFO - 'USER': 'cltbld', 07:15:08 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1462802875.667723-1287373266', 07:15:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:15:08 INFO - '_': '/tools/buildbot/bin/python'} 07:15:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:15:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:15:08 INFO - Running setup.py (path:/tmp/pip-B0zA5q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:15:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:15:08 INFO - Running setup.py (path:/tmp/pip-es5f5l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:15:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:15:08 INFO - Running setup.py (path:/tmp/pip-tSUVwS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:15:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:15:08 INFO - Running setup.py (path:/tmp/pip-AMwtL5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:15:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:15:08 INFO - Running setup.py (path:/tmp/pip-BPEyVU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:15:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:15:08 INFO - Running setup.py (path:/tmp/pip-UMl4zu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:15:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:15:08 INFO - Running setup.py (path:/tmp/pip-GO8KMR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:15:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:15:08 INFO - Running setup.py (path:/tmp/pip-VjhY4g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:15:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:15:08 INFO - Running setup.py (path:/tmp/pip-owtKbV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:15:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:15:08 INFO - Running setup.py (path:/tmp/pip-3cCRYU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:15:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:15:09 INFO - Running setup.py (path:/tmp/pip-zMStHk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:15:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:15:09 INFO - Running setup.py (path:/tmp/pip-Zj8Hrm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:15:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:15:09 INFO - Running setup.py (path:/tmp/pip-AP5qps-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:15:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:15:09 INFO - Running setup.py (path:/tmp/pip-YusVsa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:15:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:15:09 INFO - Running setup.py (path:/tmp/pip-xgZ6Bf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:15:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:15:09 INFO - Running setup.py (path:/tmp/pip-Ob92Yy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:15:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:15:09 INFO - Running setup.py (path:/tmp/pip-taJj5C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:15:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:15:09 INFO - Running setup.py install for manifestparser 07:15:09 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:15:09 INFO - Running setup.py install for mozcrash 07:15:09 INFO - Running setup.py install for mozdebug 07:15:09 INFO - Running setup.py install for mozdevice 07:15:09 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:15:09 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:15:09 INFO - Running setup.py install for mozfile 07:15:10 INFO - Running setup.py install for mozhttpd 07:15:10 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:15:10 INFO - Running setup.py install for mozinfo 07:15:10 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:15:10 INFO - Running setup.py install for mozInstall 07:15:10 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:15:10 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:15:10 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:15:10 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:15:10 INFO - Running setup.py install for mozleak 07:15:10 INFO - Running setup.py install for mozlog 07:15:10 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:15:10 INFO - Running setup.py install for moznetwork 07:15:10 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:15:10 INFO - Running setup.py install for mozprocess 07:15:10 INFO - Running setup.py install for mozprofile 07:15:10 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:15:10 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:15:10 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:15:10 INFO - Running setup.py install for mozrunner 07:15:11 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:15:11 INFO - Running setup.py install for mozscreenshot 07:15:11 INFO - Running setup.py install for moztest 07:15:11 INFO - Running setup.py install for mozversion 07:15:11 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:15:11 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:15:11 INFO - Cleaning up... 07:15:11 INFO - Return code: 0 07:15:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:15:11 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')]} 07:15:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:15:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:11 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')]} 07:15:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:15:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:11 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 0x7ff3eee66f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c92770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d219c0>, '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 0x2d228c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d22d50>, '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': 'cbe409c6de289db6ac707de3000001d4-1462802875.667723-1287373266', '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 07:15:11 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 07:15:11 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 07:15:11 INFO - Using env: {'DISPLAY': ':0', 07:15:11 INFO - 'HOME': '/home/cltbld', 07:15:11 INFO - 'LANG': 'en_US.UTF-8', 07:15:11 INFO - 'LANGUAGE': 'en_US:en', 07:15:11 INFO - 'LOGNAME': 'cltbld', 07:15:11 INFO - 'MAIL': '/var/mail/cltbld', 07:15:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:15:11 INFO - 'MOZ_NO_REMOTE': '1', 07:15:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:15:11 INFO - 'NO_EM_RESTART': '1', 07:15:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:15:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:15:11 INFO - 'PWD': '/builds/slave/test', 07:15:11 INFO - 'SHELL': '/bin/bash', 07:15:11 INFO - 'SHLVL': '1', 07:15:11 INFO - 'TERM': 'linux', 07:15:11 INFO - 'TMOUT': '86400', 07:15:11 INFO - 'USER': 'cltbld', 07:15:11 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1462802875.667723-1287373266', 07:15:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:15:11 INFO - '_': '/tools/buildbot/bin/python'} 07:15:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:15:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:15:11 INFO - Running setup.py (path:/tmp/pip-HUkr66-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:15:11 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)) 07:15:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:15:11 INFO - Running setup.py (path:/tmp/pip-ErVfzy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:15:11 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)) 07:15:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:15:11 INFO - Running setup.py (path:/tmp/pip-5eDuT7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:15:11 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)) 07:15:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:15:11 INFO - Running setup.py (path:/tmp/pip-IntOK6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:15:11 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)) 07:15:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:15:11 INFO - Running setup.py (path:/tmp/pip-ICsJuR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:15:11 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)) 07:15:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:15:11 INFO - Running setup.py (path:/tmp/pip-MPtgiU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:15:12 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)) 07:15:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:15:12 INFO - Running setup.py (path:/tmp/pip-5VPcux-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:15:12 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)) 07:15:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:15:12 INFO - Running setup.py (path:/tmp/pip-SgxmPX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:15:12 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)) 07:15:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:15:12 INFO - Running setup.py (path:/tmp/pip-Dhonv6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:15:12 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)) 07:15:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:15:12 INFO - Running setup.py (path:/tmp/pip-eVK0fC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:15:12 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)) 07:15:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:15:12 INFO - Running setup.py (path:/tmp/pip-jd_wIF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:15:12 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)) 07:15:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:15:12 INFO - Running setup.py (path:/tmp/pip-s4jZNX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:15:12 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)) 07:15:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:15:12 INFO - Running setup.py (path:/tmp/pip-xbeXsE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:15:12 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)) 07:15:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:15:12 INFO - Running setup.py (path:/tmp/pip-jQEauJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:15:12 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)) 07:15:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:15:12 INFO - Running setup.py (path:/tmp/pip-YdCecn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:15:12 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)) 07:15:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:15:12 INFO - Running setup.py (path:/tmp/pip-grVkAn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:15:12 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)) 07:15:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:15:12 INFO - Running setup.py (path:/tmp/pip-jWxXbh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:15:12 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)) 07:15:12 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)) 07:15:12 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)) 07:15:12 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)) 07:15:12 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)) 07:15:12 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)) 07:15:12 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:15:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:15:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:15:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:15:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:15:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:15:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:15:14 INFO - Downloading blessings-1.6.tar.gz 07:15:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:15:14 INFO - Installing collected packages: blessings 07:15:14 INFO - Running setup.py install for blessings 07:15:14 INFO - Successfully installed blessings 07:15:14 INFO - Cleaning up... 07:15:14 INFO - Return code: 0 07:15:14 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:15:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:15:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:15:15 INFO - Reading from file tmpfile_stdout 07:15:15 INFO - Current package versions: 07:15:15 INFO - argparse == 1.2.1 07:15:15 INFO - blessings == 1.6 07:15:15 INFO - blobuploader == 1.2.4 07:15:15 INFO - docopt == 0.6.1 07:15:15 INFO - manifestparser == 1.1 07:15:15 INFO - mozInstall == 1.12 07:15:15 INFO - mozcrash == 0.17 07:15:15 INFO - mozdebug == 0.1 07:15:15 INFO - mozdevice == 0.48 07:15:15 INFO - mozfile == 1.2 07:15:15 INFO - mozhttpd == 0.7 07:15:15 INFO - mozinfo == 0.9 07:15:15 INFO - mozleak == 0.1 07:15:15 INFO - mozlog == 3.1 07:15:15 INFO - moznetwork == 0.27 07:15:15 INFO - mozprocess == 0.22 07:15:15 INFO - mozprofile == 0.28 07:15:15 INFO - mozrunner == 6.11 07:15:15 INFO - mozscreenshot == 0.1 07:15:15 INFO - mozsystemmonitor == 0.0 07:15:15 INFO - moztest == 0.7 07:15:15 INFO - mozversion == 1.4 07:15:15 INFO - psutil == 3.1.1 07:15:15 INFO - requests == 1.2.3 07:15:15 INFO - wsgiref == 0.1.2 07:15:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:15:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:15:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:15:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:15:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:15:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:15 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 0x7ff3eee66f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c92770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d219c0>, '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 0x2d228c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d22d50>, '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': 'cbe409c6de289db6ac707de3000001d4-1462802875.667723-1287373266', '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 07:15:15 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 07:15:15 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 07:15:15 INFO - Using env: {'DISPLAY': ':0', 07:15:15 INFO - 'HOME': '/home/cltbld', 07:15:15 INFO - 'LANG': 'en_US.UTF-8', 07:15:15 INFO - 'LANGUAGE': 'en_US:en', 07:15:15 INFO - 'LOGNAME': 'cltbld', 07:15:15 INFO - 'MAIL': '/var/mail/cltbld', 07:15:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:15:15 INFO - 'MOZ_NO_REMOTE': '1', 07:15:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:15:15 INFO - 'NO_EM_RESTART': '1', 07:15:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:15:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:15:15 INFO - 'PWD': '/builds/slave/test', 07:15:15 INFO - 'SHELL': '/bin/bash', 07:15:15 INFO - 'SHLVL': '1', 07:15:15 INFO - 'TERM': 'linux', 07:15:15 INFO - 'TMOUT': '86400', 07:15:15 INFO - 'USER': 'cltbld', 07:15:15 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1462802875.667723-1287373266', 07:15:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:15:15 INFO - '_': '/tools/buildbot/bin/python'} 07:15:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:15:15 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)) 07:15:15 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)) 07:15:15 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)) 07:15:15 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)) 07:15:15 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)) 07:15:15 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)) 07:15:15 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)) 07:15:15 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)) 07:15:15 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)) 07:15:15 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)) 07:15:15 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)) 07:15:15 INFO - Cleaning up... 07:15:15 INFO - Return code: 0 07:15:15 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:15:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:15:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:15:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:15:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:15:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:15 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 0x7ff3eee66f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c92770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d219c0>, '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 0x2d228c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d22d50>, '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': 'cbe409c6de289db6ac707de3000001d4-1462802875.667723-1287373266', '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 07:15:15 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 07:15:15 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 07:15:15 INFO - Using env: {'DISPLAY': ':0', 07:15:15 INFO - 'HOME': '/home/cltbld', 07:15:15 INFO - 'LANG': 'en_US.UTF-8', 07:15:15 INFO - 'LANGUAGE': 'en_US:en', 07:15:15 INFO - 'LOGNAME': 'cltbld', 07:15:15 INFO - 'MAIL': '/var/mail/cltbld', 07:15:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:15:15 INFO - 'MOZ_NO_REMOTE': '1', 07:15:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:15:15 INFO - 'NO_EM_RESTART': '1', 07:15:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:15:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:15:15 INFO - 'PWD': '/builds/slave/test', 07:15:15 INFO - 'SHELL': '/bin/bash', 07:15:15 INFO - 'SHLVL': '1', 07:15:15 INFO - 'TERM': 'linux', 07:15:15 INFO - 'TMOUT': '86400', 07:15:15 INFO - 'USER': 'cltbld', 07:15:15 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1462802875.667723-1287373266', 07:15:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:15:15 INFO - '_': '/tools/buildbot/bin/python'} 07:15:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:15:15 INFO - Downloading/unpacking jsonschema 07:15: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 07:15: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 07:15: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 07:15: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 07:15: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 07:15: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 07:15:17 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:15:17 INFO - Downloading/unpacking functools32 (from jsonschema) 07:15: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 07:15: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 07:15: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 07:15: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 07:15: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 07:15: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 07:15:17 INFO - Downloading functools32-3.2.3-2.tar.gz 07:15:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:15:17 INFO - warning: no files found matching '*.txt' 07:15:17 INFO - no previously-included directories found matching 'build' 07:15:17 INFO - no previously-included directories found matching 'dist' 07:15:17 INFO - no previously-included directories found matching '.git*' 07:15:17 INFO - Installing collected packages: jsonschema, functools32 07:15:17 INFO - Running setup.py install for functools32 07:15:17 INFO - warning: no files found matching '*.txt' 07:15:17 INFO - no previously-included directories found matching 'build' 07:15:17 INFO - no previously-included directories found matching 'dist' 07:15:17 INFO - no previously-included directories found matching '.git*' 07:15:17 INFO - Successfully installed jsonschema functools32 07:15:17 INFO - Cleaning up... 07:15:17 INFO - Return code: 0 07:15:17 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 07:15: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')]} 07:15:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:15:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15: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')]} 07:15:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:15:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff3eee66f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c92770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d219c0>, '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 0x2d228c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d22d50>, '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': 'cbe409c6de289db6ac707de3000001d4-1462802875.667723-1287373266', '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 07:15: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', 'flake8'] in /builds/slave/test/build 07:15: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 flake8 07:15:17 INFO - Using env: {'DISPLAY': ':0', 07:15:17 INFO - 'HOME': '/home/cltbld', 07:15:17 INFO - 'LANG': 'en_US.UTF-8', 07:15:17 INFO - 'LANGUAGE': 'en_US:en', 07:15:17 INFO - 'LOGNAME': 'cltbld', 07:15:17 INFO - 'MAIL': '/var/mail/cltbld', 07:15:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:15:17 INFO - 'MOZ_NO_REMOTE': '1', 07:15:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:15:17 INFO - 'NO_EM_RESTART': '1', 07:15:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:15:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:15:17 INFO - 'PWD': '/builds/slave/test', 07:15:17 INFO - 'SHELL': '/bin/bash', 07:15:17 INFO - 'SHLVL': '1', 07:15:17 INFO - 'TERM': 'linux', 07:15:17 INFO - 'TMOUT': '86400', 07:15:17 INFO - 'USER': 'cltbld', 07:15:17 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1462802875.667723-1287373266', 07:15:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:15:17 INFO - '_': '/tools/buildbot/bin/python'} 07:15:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:15:18 INFO - Downloading/unpacking flake8 07:15:18 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 07:15:18 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 07:15:18 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 07:15:18 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 07:15:18 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 07:15:18 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 07:15:19 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:15:20 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:15:20 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 07:15:20 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 07:15:20 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 07:15:20 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 07:15:20 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 07:15:20 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 07:15:20 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:15:20 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:15:20 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 07:15:20 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 07:15:20 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 07:15:20 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 07:15:20 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 07:15:20 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 07:15:20 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:15:20 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 07:15:20 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 07:15:20 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 07:15:20 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 07:15:20 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 07:15:20 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 07:15:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 07:15:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:15:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:15:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:15:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:15:20 INFO - no previously-included directories found matching 'docs/_build' 07:15:20 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:15:20 INFO - Running setup.py install for pep8 07:15:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:15:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:15:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:15:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:15:20 INFO - no previously-included directories found matching 'docs/_build' 07:15:20 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 07:15:20 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:15:20 INFO - Cleaning up... 07:15:20 INFO - Return code: 0 07:15:20 INFO - Running post-action listener: _resource_record_post_action 07:15:20 INFO - Running post-action listener: _start_resource_monitoring 07:15:20 INFO - Starting resource monitoring. 07:15:20 INFO - ##### 07:15:20 INFO - ##### Finished create-virtualenv step (success) 07:15:20 INFO - ##### 07:15:20 INFO - ##### 07:15:20 INFO - ##### Running install step. 07:15:20 INFO - ##### 07:15:20 INFO - Running pre-action listener: _resource_record_pre_action 07:15:21 INFO - Running main action method: install 07:15:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:15:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:15:21 INFO - Reading from file tmpfile_stdout 07:15:21 INFO - Detecting whether we're running mozinstall >=1.0... 07:15:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:15:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:15:21 INFO - Reading from file tmpfile_stdout 07:15:21 INFO - Output received: 07:15:21 INFO - Usage: mozinstall [options] installer 07:15:21 INFO - Options: 07:15:21 INFO - -h, --help show this help message and exit 07:15:21 INFO - -d DEST, --destination=DEST 07:15:21 INFO - Directory to install application into. [default: 07:15:21 INFO - "/builds/slave/test"] 07:15:21 INFO - --app=APP Application being installed. [default: firefox] 07:15:21 INFO - mkdir: /builds/slave/test/build/application 07:15:21 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'] 07:15:21 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 07:15:37 INFO - Reading from file tmpfile_stdout 07:15:37 INFO - Output received: 07:15:37 INFO - /builds/slave/test/build/application/firefox/firefox 07:15:37 INFO - Running post-action listener: _resource_record_post_action 07:15:37 INFO - ##### 07:15:37 INFO - ##### Finished install step (success) 07:15:37 INFO - ##### 07:15:37 INFO - ##### 07:15:37 INFO - ##### Running run-tests step. 07:15:37 INFO - ##### 07:15:37 INFO - Running pre-action listener: _resource_record_pre_action 07:15:37 INFO - Running main action method: run_tests 07:15:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:15:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:15:37 INFO - Python 2.7.3 07:15:37 INFO - Return code: 0 07:15:37 INFO - grabbing minidump binary from tooltool 07:15:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 07:15:37 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 0x2d219c0>, '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 0x2d228c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d22d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:15:37 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 07:15:37 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 07:15:37 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:15:37 INFO - Return code: 0 07:15:37 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:15:37 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:15:37 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:15:37 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:15:37 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:15:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 07:15:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 07:15:38 INFO - Return code: 0 07:15:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Gx7NyQHERGCqQDddiVh7kg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-054', '--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 07:15:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Gx7NyQHERGCqQDddiVh7kg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-054 --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 07:15:38 INFO - Using env: {'DISPLAY': ':0', 07:15:38 INFO - 'HOME': '/home/cltbld', 07:15:38 INFO - 'LANG': 'en_US.UTF-8', 07:15:38 INFO - 'LANGUAGE': 'en_US:en', 07:15:38 INFO - 'LOGNAME': 'cltbld', 07:15:38 INFO - 'MAIL': '/var/mail/cltbld', 07:15:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:15:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:15:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:15:38 INFO - 'MOZ_NO_REMOTE': '1', 07:15:38 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:15:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:15:38 INFO - 'NO_EM_RESTART': '1', 07:15:38 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:15:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:15:38 INFO - 'PWD': '/builds/slave/test', 07:15:38 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:15:38 INFO - 'SHELL': '/bin/bash', 07:15:38 INFO - 'SHLVL': '1', 07:15:38 INFO - 'TERM': 'linux', 07:15:38 INFO - 'TMOUT': '86400', 07:15:38 INFO - 'USER': 'cltbld', 07:15:38 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1462802875.667723-1287373266', 07:15:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:15:38 INFO - '_': '/tools/buildbot/bin/python'} 07:15:38 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Gx7NyQHERGCqQDddiVh7kg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-054', '--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 07:15:39 INFO - mozversion application_buildid: 20160509040557 07:15:39 INFO - mozversion application_changeset: 043082cb7bd8490c60815f67fbd1f33323ad7663 07:15:39 INFO - mozversion application_display_name: Nightly 07:15:39 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:15:39 INFO - mozversion application_name: Firefox 07:15:39 INFO - mozversion application_remotingname: firefox 07:15:39 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 07:15:39 INFO - mozversion application_vendor: Mozilla 07:15:39 INFO - mozversion application_version: 49.0a1 07:15:39 INFO - mozversion platform_buildid: 20160509040557 07:15:39 INFO - mozversion platform_changeset: 043082cb7bd8490c60815f67fbd1f33323ad7663 07:15:39 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 07:15:39 INFO - mozversion platform_version: 49.0a1 07:15:39 INFO - using testdate: 1462803339 07:15:39 INFO - actual date: 1462803339 07:15:39 INFO - starting webserver on 'localhost:57298' 07:15:39 INFO - SUITE-START | Running 2 tests 07:15:39 INFO - TEST-START | dromaeo_css 07:15:39 INFO - operating with platform_type : linux_ 07:15:39 INFO - Initialising browser for dromaeo_css test... 07:15:39 INFO - TEST-INFO | started process 5644 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpscqgU4/profile http://localhost:57298/getInfo.html) 07:15:42 INFO - PROCESS | 5644 | 07:15:42 INFO - PROCESS | 5644 | (process:5712): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 07:15:43 INFO - PROCESS | 5644 | __metrics Screen width/height:1600/1200 07:15:43 INFO - PROCESS | 5644 | colorDepth:24 07:15:43 INFO - PROCESS | 5644 | Browser inner width/height: 1024/697 07:15:43 INFO - PROCESS | 5644 | __metrics 07:15:44 ERROR - PROCESS | 5644 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2937: TypeError: this.tabs is undefined 07:15:45 INFO - TEST-INFO | 5644: exit 0 07:15:45 INFO - Browser initialized. 07:15:45 INFO - Running cycle 1/1 for dromaeo_css test... 07:15:45 INFO - TEST-INFO | started process 5763 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpscqgU4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:15:47 INFO - PROCESS | 5763 | 07:15:47 INFO - PROCESS | 5763 | (process:5822): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 07:15:57 INFO - PROCESS | 5763 | RSS: Main: 163020800 07:15:57 INFO - PROCESS | 5763 | 07:16:46 INFO - PROCESS | 5763 | 1462803406654 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] 07:18:54 INFO - PROCESS | 5763 | Cycle 1(1): loaded http://localhost:57298/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57298/tests/dromaeo/cssquery-ext.html) 07:18:55 INFO - PROCESS | 5763 | RSS: Main: 166789120 07:18:55 INFO - PROCESS | 5763 | 07:21:57 INFO - PROCESS | 5763 | Cycle 1(1): loaded http://localhost:57298/tests/dromaeo/cssquery-ext.html (next: http://localhost:57298/tests/dromaeo/cssquery-jquery.html) 07:21:58 INFO - PROCESS | 5763 | RSS: Main: 166481920 07:21:58 INFO - PROCESS | 5763 | 07:25:00 INFO - PROCESS | 5763 | Cycle 1(1): loaded http://localhost:57298/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57298/tests/dromaeo/cssquery-mootools.html) 07:25:00 INFO - PROCESS | 5763 | RSS: Main: 167407616 07:25:00 INFO - PROCESS | 5763 | 07:28:02 INFO - PROCESS | 5763 | Cycle 1(1): loaded http://localhost:57298/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57298/tests/dromaeo/cssquery-prototype.html) 07:28:03 INFO - PROCESS | 5763 | RSS: Main: 165019648 07:28:03 INFO - PROCESS | 5763 | 07:31:05 INFO - PROCESS | 5763 | Cycle 1(1): loaded http://localhost:57298/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57298/tests/dromaeo/cssquery-yui.html) 07:31:06 INFO - PROCESS | 5763 | RSS: Main: 166354944 07:31:06 INFO - PROCESS | 5763 | 07:34:08 INFO - PROCESS | 5763 | Cycle 1(1): loaded http://localhost:57298/tests/dromaeo/cssquery-yui.html (next: http://localhost:57298/tests/dromaeo/cssquery-dojo.html) 07:34:09 INFO - PROCESS | 5763 | RSS: Main: 168181760 07:34:09 INFO - PROCESS | 5763 | 07:34:09 INFO - PROCESS | 5763 | __start_tp_report 07:34:09 INFO - PROCESS | 5763 | _x_x_mozilla_page_load 07:34:09 INFO - PROCESS | 5763 | _x_x_mozilla_page_load_details 07:34:09 INFO - PROCESS | 5763 | |i|pagename|runs| 07:34:09 INFO - PROCESS | 5763 | |0;dojo.html;3155.4162479941197;3159.0680749178996;3203.247236899328;3221.8872339468107;3223.3069889973635;5394.083005889003;5396.811111611094;5448.073827449333;5489.58828087894;5492.093804522259;5320.574354051676;5476.507114359707;5484.341878974518;5526.364468086172;5559.833205003856;4920.114379411704;4966.652334336598;5044.899102017957;5068.898622027557;5120.180771076629;4918.827841025565;5129.871753206163;5156.200788877712;5172.534471897528;5177.767000484969;4924.28597853311;4968.354113965198;4982.451930287665;4993.525615066563;4993.825216117437;5044.848654540333;5051.343325367716;5056.570191533724;5064.873378165538;5112.514311140436;5035.496450354972;5035.924461133086;5040.269160971675;5042.571381432583;5061.190209566452;5312.574994000509;5331.680099194061;5362.195670649395;5362.597805164628;5378.677279363212;5828.737706803162;5867.031939729939;5887.705614719247;5894.115882617642;5910.881782364371;5810.070388737824;5823.039198532237;5935.37678543751;5944.019236825919;5950.613210141327;5446.2375267462585;5491.588130890199;5519.641223320471;5534.252875861747;5602;5983.371745966698;6015.4586087252355;6031.065184896348;6032.939670603238;6036.9737144685505;5631.549476041907;5678.4037676044245;5723.484886360247;5765.4811067004175;5779.653220806765;5789.334226563999;5829.912551311733;5863.648181109147;5867.14926335679;5914.940850591439;5764.193012978102;5784.566157538202;5812.099124635688;5814.796482123105;5820.505257053198;5873.970630146822;5919.3192782829665;5940.821775346746;5944.851378715567;5977.013792724239;4486.730796152241;4497.482789479252;4506.842260520932;4516.728996260169;4551.863444096616;3887.494625698641;4016.8393264269685;4052.9392059119136;4054.3715724062818;4067.349224124126;5536.252605898233;5540;5550.389457159709;5565.6104072714525;5599.076152434803;5889.764409423575;5890.587658863838;5907.822765317047;5916.437938395846;5926.822195334147;5402.810901618424;5570.275864137636;5576.191452239403;5579.7489112990015;5588;5053.620978426633;5094.133997220481;5107.846764597068;5117.488251174853;5158.071547121479;6009.609375390585;6029.577929544977;6063.666498342545;6067.514598832083;6078.969605151946;5720.313562372542;5898.793542226002;5919.378465261258;5982.042873140451;5985.102234664835;6078.149059131813;6081.726322315418;6082.330943596113;6083.178770865877;6111.205543279345;5871.383504732113;5899.616524925866;5903.586748927705;5907.143464197753;5909.940900591111;5697.259356283656;5818;5849.064149736192;5901.557383196192;5927.851803704942;5731.914021289601;5744.569157313134;5746.310442746897;5757.193992840922;5759.452851979056;5704.914426283526;5737.655740655574;5756.366799651951;5760.020796464695;5760.8271751847515;5461.371942226695;5523.6685798852195;5530.281063461724;5545.417731138173;5570.777168913198;5744.885102297847;5748.396418376177;5766.711664416678;5816.156657284585;5836.620619659709;5687.573431992534;5691.3170419549915;5706.9714651426475;5710.37185909558;5712.171735098471 07:34:09 INFO - PROCESS | 5763 | |1;ext.html;609.2962628164472;641.6791604197902;655.2595567009284;659.498780926496;662.8110988368313;32749.508757368658;44988.550114498845;45902;46057;46111.53888461119;47352.816179595524;47718.284225736556;47798.283025754645;47893.760531197295;47893.76053119738;8992.730218093451;9131;9138;9138.908610913906;9148.17666410023;8942.46345219289;8984.416012959136;8987.101289871025;8992.910070899272;9010.54947252638;9000.954995225047;9029;9039.502827344493;9066.365354425192;9069.047749986255;8974.775630609221;9027.368084234105;9035;9039.548022598843;9046.547672616376;8892.59983300753;8956.910430895672;8970.192682658591;8971.282297416255;8978.326625503048;42783.35824962628;42825.78587107076;42932.57067429317;42981.78509107466;43142.13715725668;3576.8211589420425;3654;3749.381352076904;3758.5113935188524;4168.228877657612;32350.83824580862;32947.835260823784;33163.17092072718;33517.32965340679;34455.13862153441;4424.292113261895;4439.223135951228;4460.7323560586465;4472.463304403493;4494.07871386365;295065;297743.51128244435;298353;301298;302803;35669.821650892096;58696.706516467995;59075.40924590785;59522.40477595255;59607;36323.63676363203;37990;38514;38555.80722096372;38580.421293680614;14026.947978901419;14079.296035198198;14142.929285353714;14171.433142674177;14405.279736013366;11439.771204575862;11455.255408398427;11470.311781292981;11537.596184133683;11537.653870383901;7069.858602827914;7083.433325334064;7097.858042839114;7176.031235783207;7195.460340474486;3249.5775549178456;3298.0765385691566;3300.3069355435628;3307.074019274607;3363.058343663778;1068.2468859454066;1111.5498223219608;1121.607437396921;1163.4531770068224;1193.9522419103312;32500.512492312635;32949.341013179604;33042.504362434585;33521.32957340888;33903;1106.773111512138;1156.9479373428217;1198.316959333189;1199.696582561484;1231.9322437265857;17460.126993650265;17496.650066998587;17561.67783569124;17568;18033.54916127081;518014;520841;522428;523532;524255;59630;60199.09701354483;60279.69860150671;60329.39670603238;60413.395866041654;1396.6578188343717;1410.182094385254;1414.6746248362933;1416.1715396492962;1435.798988141661;31512.842435787676;31868.203294917814;31885.20286992844;32145.35709285848;32221.194470138435;52854.20718689146;53020;53030;53269.733651331495;53282;407195;412704;413576;413774;414404;29379.265518362212;29487.26281842971;29619.555706663985;29676.10971670853;29759.404811904074;49671.751641241564;50265.49734502754;50482.74758626183;50708.492915070376;51472.22791658203;41843.581564183965;42814.35778463263;43523.69428917138;43632.56367436412;44108;41793.37309940414;41995;42218.36672449854;43311.35032974571;43707.781461093764;36854.26291474209;42808.357874631285;43288.567114329715;43588.56411435845;43751.78124109359;36064.8196759025;37818.534826474184;37840.81079594584;38103.618963810004;38346.80826595849;28382.23359604868;28685.713142868302;29567.26081847971;29603.407931841673;29679.25801854971 07:34:09 INFO - PROCESS | 5763 | |2;jquery.html;409.6620288262184;409.73162578511085;411.2474172264756;413.9855105071323;426.69704509798044;18006.909965450188;19545.12046957887;19762.505937351554;19784.406467805988;19799.109040093193;18197.727034094467;18608.34870779523;19079.14143863526;19681.70477442836;19682.90158549205;5787.21872547206;5842.298924129111;5890.617109887844;5925.407459254062;5967.910481342783;5708.457696518844;5841.065429531276;5853.5902486825935;5870.911936320958;5883.264591926009;5647.491725744682;5772.682502462363;5779;5817.41825817417;5839.620424672383;5486.698231597261;5750.511206547449;5793.304803423574;5807.128930660392;5810.273715785527;5631.63394379364;5686.402927692616;5719.799807006776;5733.627314224562;5745.913811292834;22502.77497225023;22568.322950311518;22676.65985010226;23199.3040208794;23268.301950941328;2290.541891621682;2712.8101032927702;2868.1969048666406;2909.6799352071257;3018.2303512604367;10189.337693049929;10244.846327305022;13454.932725336408;13667.726645467135;14021.369038393297;1769.7079981802988;1862.5622978600018;1873.334966087033;1886.5674015466318;1940.1560321260297;64926.675366623334;75103;75188.62405687936;80250;82870.58564707199;10764.13886889047;10885.965833245988;10957.12343012557;11017.338959662446;11264.972304985018;14490.971264023045;14577.489787857374;14643.414263429344;14662.633434164018;14737.631559210891;7914.841703165905;7982.720604778805;8018.839623207503;8086.070101938235;8145.877811832827;7488.138864030598;7601.923980760233;7627.847443051219;7647.311741943252;7864.6854125834325;4505.617022553054;4592.265237561974;4625.907481850344;4682.672212945129;4765.213739732905;1838.531174550481;1951.7170010348705;1970.2808474906842;1979.1786408640542;1992.1334219614514;991.667791289926;1039.812833689943;1071.8713754349528;1166.6966588686832;1187.1986409173774;18921.148548315083;19305.80694193068;19378;19482.902585487267;19511.512212194808;1034.4689859008558;1036.1555332404216;1062.3731998121145;1092.4100985467758;1098.5770478365728;9578.281628877861;10889.564417423373;10977.28647637901;11000.119990400748;11136.498857551429;533010;555653;570175.9642079633;576831;579161;54501.45498545043;64506;94895.52552237333;94944.05055949352;95183.52408237914;1026.1944373666636;1033.194108595297;1037.766502536923;1061.883192848786;1063.8936106389453;16741.74887376715;17152.399666011628;17171.141442927554;17225;17489.737653934946;27467.450650987266;29696.40607187801;32456.51315230226;38984.41523377208;39991.80004099961;53418.465815342905;54982.72508637431;55025.1746223799;55213.44786552083;56134.157987631035;8683.956580217311;8685.39202255836;8698;8732.78168045804;9028.458292502472;9717.271204659537;13256.80114798298;13426.395812188279;13489.055766096279;13611.727765444833;11448.3703396314;11475.885241147482;11520.88479115198;11637.06903447739;11748.941255293668;11035.962220301964;11291.491882865126;11530.82703759461;11563.884361156617;11784.70538236551;11556.306621602731;11738.237014594366;11767.293962362286;12078.698032549257;12171.81742273849;8673.609687563949;8727.825443491221;8796.252318552739;8852.070532593985;8864.113588641085;10332.276740628084;11222.438878056228;11230.270032448192;11466.140039497239;11505.482253298454 07:34:09 INFO - PROCESS | 5763 | |3;mootools.html;1559.5711179425657;1567.5454118305688;1748.1958299182375;1796.812749003985;1806.1962426720115;7614.428917831171;8479.745607631774;8492.49045057297;9099.135582119696;9104.499252541107;8711.91288087119;8713;8734.126587341263;8745.606447709852;8747.431416957894;2345.8827058647125;2366.645003249509;2366.7041619797524;2387.9522409551887;2393.964090538643;2291.86248825071;2341.988290058556;2348.7416384197722;2354.564405584972;2361.728401233854;2311;2328.75548067453;2343.5195784864145;2366.4912043910554;2366.8698221597806;2257.3115199864037;2273.2952784636814;2275.055851821492;2299.2297580310533;2322.500662357584;2266.5580211858696;2299.9425014374606;2303.896324665394;2314.340412982292;2314.5833749925005;8819.162179592928;8859.955700221522;8874.911250887537;8886.066962968924;8909.910900890973;5237.397699264595;5353.197020446964;5359.919601205985;5364.785408583652;5365.517103460707;3337.8331083445732;3338.21551935295;3462.5844898612077;3491.9476207856646;3535.186907011376;1129.1587767113554;1134.183387960667;1170.584442522909;1192.8986036186848;1204.2052245518003;10809.67570972872;11034.613788517443;11036.392998385085;11437.256578322382;11451.48468318936;4486.842960496367;4501.257292546758;4551.544845515488;4576.244919588231;4577.3362862384765;9736.36713613627;9755.414675119515;9762.414255144715;9762.560684769202;9813.509324533745;5302.072137375943;5316.734163291897;5366.436524164985;5370.489803468664;5373.65071270374;4404.009097952935;4733.9763301183275;4876.487968763229;4888.7311197884455;4946.159152944008;3765.7740535567955;3785.848566057382;3815.465834783133;3854.845806167778;3887.7861717605238;1126.3129491010477;1144.8683401408944;1157.2073129906041;1182.899453546441;1187.5309252845077;837.5937670230055;948.2414068744977;962.259060523393;962.3985009369144;988.7528117970508;5289.100852855024;5471.06991811393;5526.972365138148;5571;5691.9146212806845;963.0898800633335;965.8116667249959;965.82615129276;1007.2395341517108;1017.2929813779352;3571.089372210122;3600.351936651428;3611.9277614447565;3645.799481028516;3654.0499470137956;10666.839997400046;11099.390588364642;11159.72100697489;11206.439678016066;11219.102471802236;10717.035466808025;10821.513031913582;10905.672829815117;10989.725256868482;11083.168762342857;8379.706710265233;8423.663053477914;8435.578221088921;8448.873266901;8599.785005374915;5711.942880571307;5792.710364481674;5899.085641725539;6003.459688628044;6056.788012419544;9549.28380371461;9741.512924353612;9950.651727189803;10255.58977640886;10264.178865690876;10154.898451015692;10329.638462653771;10353.482325883526;10532.104771094237;10681.51933162994;7677.232276772278;8383.37124715661;8429.789255268668;8469.830603388022;8645.610947507503;8742.825143496968;8746.344024198082;8757.124287571447;8763;8812.2950163988;7462.992496012968;7616.428767842323;7673;7844.254795794391;7945.801354966172;7535.472516923982;7869.134395216407;7901.051873775184;8004.599770011592;8022.358211343195;7025.437964962688;7185.568865868065;7212.098487689039;7231.566106033655;7245.529040612343;4946.08497427977;5032.823851165192;5084.847454576368;5100.056489549445;5126.871828204325;5067.467915868928;5079.72061536619;5101.260317254051;5120.436751957356;5244.737763111905 07:34:09 INFO - PROCESS | 5763 | |4;prototype.html;328.5646518363169;328.84872958439115;336.23506522660944;336.5574269835168;337.0512008695522;5497.587680923927;5507.284053073105;5525.530329921957;5573.386927437979;5631.746571404292;5474.698891560963;5490.56075513959;5496.670199788015;5499.257600223978;5505.284313039299;4092.77489738065;4188.204241194163;4230.619244268015;4241.597048280409;4303.074838909633;4232.894177645553;4251.298535741599;4254.765987870666;4326.502452217988;4347.93473100278;4297.226499230137;4299.226139294926;4302.333138363559;4303.289957157065;4308.931712777869;4025.6175663311938;4237.343211802176;4254.617084462413;4277.588395829369;4293.969447332649;3745.250949810049;3753.343164946151;3770.2082562661876;3777.527809023872;3789.6399842014966;5310.070737620939;5320.17537281722;5334.4132145464355;5336.30628018359;5431.565474762009;4629.606483448911;4862.659613827033;4870.464248932614;4878;4902.264660300948;5710.71508910496;5712.771489140429;5740.4546568076385;5807.444724321285;5820.417958204146;4110.520212723447;4120.423140760296;4123.8556650517085;4129.834806607732;4134.793260336971;5963.1494130149595;6030.66831324277;6043.398499397663;6057.666828324441;6154.569180157391;4149.170165966819;4155.774046656244;4167.8958026049595;4175.144095460423;4185.434966279574;4239.491261048694;4242.406063151161;4249.766262855573;4251.681123915719;4256.893577660521;4632.814687412533;4822.903541929142;4861.6353773467135;4922.556969872729;4922.990786888679;5721.656700597978;5798.59409841307;5805.187273781674;5809.88380232393;5863.120531920246;1401.9369128389044;1409.873111419977;1417.1284659934067;1428.4857451317516;1428.8785453236592;896.8609865470946;944.1832814615445;945.1399226703667;945.7257395355407;958.990410095904;5338.626296159232;5338.866528336823;5369.24830523727;5390.380106287748;5395.271638328775;5660.377358490563;5700.572457065737;5714.914276285859;5750.6262092963825;5773.740181691834;5167.379914410295;5256.894862102737;5352.4915133062295;5391.892162156735;5416.643759964428;2967.4065186962694;3038.769298434138;3058.2720762768963;3065.754739620825;3086.27472543952;5591.888162236733;5766.596338256366;5864.384239654775;5929.436703513159;5930.406959304121;5864.589478736448;5895.764169433174;5896.498797602166;5909.261342332208;5915.556333274935;5787.594868359174;5801.82594522165;5824.563157763185;5834.737436815353;5893.911591326134;5541.171413433477;5634.392941047325;5707.8858422832145;5735.36910939788;5816.534677225896;5694.943050569607;5725.255716756795;5760.683162426107;5779.884402312015;5787.479126878601;5533.363663178786;5824;5850.0932355484965;5855.560832937632;5900.92205028821;3968.583298753589;4015.630777841088;4028.43601895729;4029.17401932609;4037.8384864605086;5773.509251713652;5852.356240813422;5859.648421094748;5860.589758717019;5874.534024925315;5564.248826408383;5664.801731939362;5676.347220069745;5682.460166284196;5696.886062278814;5437.1241921537;5531.474509921551;5575.7490912909825;5657.773689052392;5675.858103547444;5384.223206341976;5416.864578385572;5446.591505637014;5458.344998600034;5489.819688766935;5654.321481422256;5781.710914454345;5813.593048486566;5840.707964601838;5922.585419020627;5668.914966275592;5700.800471983461;5754.53963682896;5758.913616295675;5774.700692344357 07:34:09 INFO - PROCESS | 5763 | |5;yui.html;754.992450075499;798.7411361644491;836.126248070766;886.162576365335;899.9685011024616;13945.302734863255;14892.627684307898;15020.849791502082;15072.547823565297;15076.396944122249;14129.152250864956;14134.50529231477;14161.504347347845;14181.858181418183;14200.218987955684;691.5297597633607;806.770070529899;824.1840577827967;824.3240542754943;834.2450082675189;817.81190326225;818.2186012358213;826.68999125328;826.89663792026;829.1169904052196;855.4054931822386;857.8284343131368;858.2061593026457;860.9009963854143;866.1771317248607;849.8512760266959;857.0529564830865;861.6596444404425;862.9784255393571;863.011851430109;637.1812221295659;637.8692368064536;640.5644161969859;642.0401499757845;642.2549842183092;14013.719725605533;14041.64895877601;14068.71862562743;14156.646083847883;14177.220252886087;14308.069975451666;14349.13905165683;14373.209473478955;14410.855891441057;14496.71006579873;11383.178691409417;11487.597934072352;11601.303921764636;11782.351970641612;11827.408629568487;3610.7833529988284;3617.7467577269604;3662.450632405134;3690.2619476104887;3702.2965636529243;53920;54108.72945635286;56492.71753641246;56608.35787168721;56752.43247567554;10945.23383363157;10992.450377481095;11000.22998390105;11155.553777848796;11288;20471;20481.2831550895;20641.89679051595;20690.793092069187;21036.894815525826;8060.637271322805;8223.259906608433;8233.423660343838;8397.496150231005;8543.273821725223;4183.811728472226;4208.915821683549;4305.182015417061;4392;4415.5363686812425;3422.3497535468678;3495.9475607865393;3496.091016335771;3503.386907291214;3509.438489841613;630.3633330336302;639.5491178718992;646.1406329581645;648.4488185042676;654.3914159831307;759.673340463606;779.8557266905641;784.2432053068702;786.9842603147905;788.6687591211705;9661.758456038655;9809.166220871162;9912.504374781232;10003.79992400148;10031.69904902854;790.2295262119387;801.5831767480877;807.3460496997451;822.6709316273539;828.6879605899593;4601.4248218972625;4758.310045043519;4766.523347665275;4772.665913386099;4774.140654682121;61168.38831611716;62769.37230627727;63401.68299158475;64780.35219647743;64810.675946619966;49008;51138.48861511412;55921.720391398594;56306;56710.71644641833;52607.47392526102;52695.20957185645;52944.47055529473;53387.733061335224;53897;9631.43932013366;9701.291577320158;9781.236644104374;9930.553125109533;9944.15474684631;33370;33645.15887102842;34302;34366.14084647804;34642.82678586591;42241.15517689568;44570.554294457936;44781.10437791291;45211.54788452073;45288.54711452843;12419.31693756816;12449;12535.623931282076;12558.748825023631;12727.109102362745;12360.75278494443;13338.399772010476;13947.651308717363;13973.301334933416;14173.503927362493;11648.650540483799;11659.125565582446;12176.269423834598;12281.815772763595;12774;11622.535098595961;12037.097217708882;12393.132480726263;12607;12726.23642581411;11950.521979120738;12073.456694448596;12080.335581543099;12113.15207935436;12137.393130343624;9953.153981911619;10040;10071;10168;10274.589016439259;10170.796584068425;10372.118369938338;10446.738831528968;10450.163986881184;10468.214883883587 07:34:09 INFO - PROCESS | 5763 | __end_tp_report 07:34:09 INFO - PROCESS | 5763 | __start_cc_report 07:34:09 INFO - PROCESS | 5763 | _x_x_mozilla_cycle_collect,348 07:34:09 INFO - PROCESS | 5763 | __end_cc_report 07:34:09 INFO - PROCESS | 5763 | __startTimestamp1462804449139__endTimestamp 07:34:09 INFO - PROCESS | 5763 | 07:34:09 INFO - PROCESS | 5763 | ------- Summary: start ------- 07:34:09 INFO - PROCESS | 5763 | Number of tests: 6 07:34:09 INFO - PROCESS | 5763 | 07:34:09 INFO - PROCESS | 5763 | [#0] dojo.html Cycles:165 Average:5460.74 Median:5687.57 stddev:611.56 (10.8%) stddev-sans-first:586.09 07:34:09 INFO - PROCESS | 5763 | Values: 3155.4 3159.1 3203.2 3221.9 3223.3 5394.1 5396.8 5448.1 5489.6 5492.1 5320.6 5476.5 5484.3 5526.4 5559.8 4920.1 4966.7 5044.9 5068.9 5120.2 4918.8 5129.9 5156.2 5172.5 5177.8 4924.3 4968.4 4982.5 4993.5 4993.8 5044.8 5051.3 5056.6 5064.9 5112.5 5035.5 5035.9 5040.3 5042.6 5061.2 5312.6 5331.7 5362.2 5362.6 5378.7 5828.7 5867.0 5887.7 5894.1 5910.9 5810.1 5823.0 5935.4 5944.0 5950.6 5446.2 5491.6 5519.6 5534.3 5602.0 5983.4 6015.5 6031.1 6032.9 6037.0 5631.5 5678.4 5723.5 5765.5 5779.7 5789.3 5829.9 5863.6 5867.1 5914.9 5764.2 5784.6 5812.1 5814.8 5820.5 5874.0 5919.3 5940.8 5944.9 5977.0 4486.7 4497.5 4506.8 4516.7 4551.9 3887.5 4016.8 4052.9 4054.4 4067.3 5536.3 5540.0 5550.4 5565.6 5599.1 5889.8 5890.6 5907.8 5916.4 5926.8 5402.8 5570.3 5576.2 5579.7 5588.0 5053.6 5094.1 5107.8 5117.5 5158.1 6009.6 6029.6 6063.7 6067.5 6079.0 5720.3 5898.8 5919.4 5982.0 5985.1 6078.1 6081.7 6082.3 6083.2 6111.2 5871.4 5899.6 5903.6 5907.1 5909.9 5697.3 5818.0 5849.1 5901.6 5927.9 5731.9 5744.6 5746.3 5757.2 5759.5 5704.9 5737.7 5756.4 5760.0 5760.8 5461.4 5523.7 5530.3 5545.4 5570.8 5744.9 5748.4 5766.7 5816.2 5836.6 5687.6 5691.3 5707.0 5710.4 5712.2 07:34:09 INFO - PROCESS | 5763 | 07:34:09 INFO - PROCESS | 5763 | [#1] ext.html Cycles:180 Average:57149.67 Median:42106.68 stddev:111699.60 (265.3%) stddev-sans-first:111932.28 07:34:09 INFO - PROCESS | 5763 | Values: 609.3 641.7 655.3 659.5 662.8 32749.5 44988.6 45902.0 46057.0 46111.5 47352.8 47718.3 47798.3 47893.8 47893.8 8992.7 9131.0 9138.0 9138.9 9148.2 8942.5 8984.4 8987.1 8992.9 9010.5 9001.0 9029.0 9039.5 9066.4 9069.0 8974.8 9027.4 9035.0 9039.5 9046.5 8892.6 8956.9 8970.2 8971.3 8978.3 42783.4 42825.8 42932.6 42981.8 43142.1 3576.8 3654.0 3749.4 3758.5 4168.2 32350.8 32947.8 33163.2 33517.3 34455.1 4424.3 4439.2 4460.7 4472.5 4494.1 295065.0 297743.5 298353.0 301298.0 302803.0 35669.8 58696.7 59075.4 59522.4 59607.0 36323.6 37990.0 38514.0 38555.8 38580.4 14026.9 14079.3 14142.9 14171.4 14405.3 11439.8 11455.3 11470.3 11537.6 11537.7 7069.9 7083.4 7097.9 7176.0 7195.5 3249.6 3298.1 3300.3 3307.1 3363.1 1068.2 1111.5 1121.6 1163.5 1194.0 32500.5 32949.3 33042.5 33521.3 33903.0 1106.8 1156.9 1198.3 1199.7 1231.9 17460.1 17496.7 17561.7 17568.0 18033.5 518014.0 520841.0 522428.0 523532.0 524255.0 59630.0 60199.1 60279.7 60329.4 60413.4 1396.7 1410.2 1414.7 1416.2 1435.8 31512.8 31868.2 31885.2 32145.4 32221.2 52854.2 53020.0 53030.0 53269.7 53282.0 407195.0 412704.0 413576.0 413774.0 414404.0 29379.3 29487.3 29619.6 29676.1 29759.4 49671.8 50265.5 50482.7 50708.5 51472.2 41843.6 42814.4 43523.7 43632.6 44108.0 41793.4 41995.0 42218.4 43311.4 43707.8 36854.3 42808.4 43288.6 43588.6 43751.8 36064.8 37818.5 37840.8 38103.6 38346.8 28382.2 28685.7 29567.3 29603.4 29679.3 07:34:09 INFO - PROCESS | 5763 | 07:34:09 INFO - PROCESS | 5763 | [#2] jquery.html Cycles:180 Average:30282.82 Median:12744.92 stddev:92257.19 (723.9%) stddev-sans-first:92488.73 07:34:09 INFO - PROCESS | 5763 | Values: 409.7 409.7 411.2 414.0 426.7 18006.9 19545.1 19762.5 19784.4 19799.1 18197.7 18608.3 19079.1 19681.7 19682.9 5787.2 5842.3 5890.6 5925.4 5967.9 5708.5 5841.1 5853.6 5870.9 5883.3 5647.5 5772.7 5779.0 5817.4 5839.6 5486.7 5750.5 5793.3 5807.1 5810.3 5631.6 5686.4 5719.8 5733.6 5745.9 22502.8 22568.3 22676.7 23199.3 23268.3 2290.5 2712.8 2868.2 2909.7 3018.2 10189.3 10244.8 13454.9 13667.7 14021.4 1769.7 1862.6 1873.3 1886.6 1940.2 64926.7 75103.0 75188.6 80250.0 82870.6 10764.1 10886.0 10957.1 11017.3 11265.0 14491.0 14577.5 14643.4 14662.6 14737.6 7914.8 7982.7 8018.8 8086.1 8145.9 7488.1 7601.9 7627.8 7647.3 7864.7 4505.6 4592.3 4625.9 4682.7 4765.2 1838.5 1951.7 1970.3 1979.2 1992.1 991.7 1039.8 1071.9 1166.7 1187.2 18921.1 19305.8 19378.0 19482.9 19511.5 1034.5 1036.2 1062.4 1092.4 1098.6 9578.3 10889.6 10977.3 11000.1 11136.5 533010.0 555653.0 570176.0 576831.0 579161.0 54501.5 64506.0 94895.5 94944.1 95183.5 1026.2 1033.2 1037.8 1061.9 1063.9 16741.7 17152.4 17171.1 17225.0 17489.7 27467.5 29696.4 32456.5 38984.4 39991.8 53418.5 54982.7 55025.2 55213.4 56134.2 8684.0 8685.4 8698.0 8732.8 9028.5 9717.3 13256.8 13426.4 13489.1 13611.7 11448.4 11475.9 11520.9 11637.1 11748.9 11036.0 11291.5 11530.8 11563.9 11784.7 11556.3 11738.2 11767.3 12078.7 12171.8 8673.6 8727.8 8796.3 8852.1 8864.1 10332.3 11222.4 11230.3 11466.1 11505.5 07:34:09 INFO - PROCESS | 5763 | 07:34:09 INFO - PROCESS | 5763 | [#3] mootools.html Cycles:180 Average:5770.69 Median:5050.15 stddev:3260.35 (64.6%) stddev-sans-first:3254.14 07:34:09 INFO - PROCESS | 5763 | Values: 1559.6 1567.5 1748.2 1796.8 1806.2 7614.4 8479.7 8492.5 9099.1 9104.5 8711.9 8713.0 8734.1 8745.6 8747.4 2345.9 2366.6 2366.7 2388.0 2394.0 2291.9 2342.0 2348.7 2354.6 2361.7 2311.0 2328.8 2343.5 2366.5 2366.9 2257.3 2273.3 2275.1 2299.2 2322.5 2266.6 2299.9 2303.9 2314.3 2314.6 8819.2 8860.0 8874.9 8886.1 8909.9 5237.4 5353.2 5359.9 5364.8 5365.5 3337.8 3338.2 3462.6 3491.9 3535.2 1129.2 1134.2 1170.6 1192.9 1204.2 10809.7 11034.6 11036.4 11437.3 11451.5 4486.8 4501.3 4551.5 4576.2 4577.3 9736.4 9755.4 9762.4 9762.6 9813.5 5302.1 5316.7 5366.4 5370.5 5373.7 4404.0 4734.0 4876.5 4888.7 4946.2 3765.8 3785.8 3815.5 3854.8 3887.8 1126.3 1144.9 1157.2 1182.9 1187.5 837.6 948.2 962.3 962.4 988.8 5289.1 5471.1 5527.0 5571.0 5691.9 963.1 965.8 965.8 1007.2 1017.3 3571.1 3600.4 3611.9 3645.8 3654.0 10666.8 11099.4 11159.7 11206.4 11219.1 10717.0 10821.5 10905.7 10989.7 11083.2 8379.7 8423.7 8435.6 8448.9 8599.8 5711.9 5792.7 5899.1 6003.5 6056.8 9549.3 9741.5 9950.7 10255.6 10264.2 10154.9 10329.6 10353.5 10532.1 10681.5 7677.2 8383.4 8429.8 8469.8 8645.6 8742.8 8746.3 8757.1 8763.0 8812.3 7463.0 7616.4 7673.0 7844.3 7945.8 7535.5 7869.1 7901.1 8004.6 8022.4 7025.4 7185.6 7212.1 7231.6 7245.5 4946.1 5032.8 5084.8 5100.1 5126.9 5067.5 5079.7 5101.3 5120.4 5244.7 07:34:09 INFO - PROCESS | 5763 | 07:34:09 INFO - PROCESS | 5763 | [#4] prototype.html Cycles:180 Average:4776.34 Median:5482.26 stddev:1403.10 (25.6%) stddev-sans-first:1366.74 07:34:09 INFO - PROCESS | 5763 | Values: 328.6 328.8 336.2 336.6 337.1 5497.6 5507.3 5525.5 5573.4 5631.7 5474.7 5490.6 5496.7 5499.3 5505.3 4092.8 4188.2 4230.6 4241.6 4303.1 4232.9 4251.3 4254.8 4326.5 4347.9 4297.2 4299.2 4302.3 4303.3 4308.9 4025.6 4237.3 4254.6 4277.6 4294.0 3745.3 3753.3 3770.2 3777.5 3789.6 5310.1 5320.2 5334.4 5336.3 5431.6 4629.6 4862.7 4870.5 4878.0 4902.3 5710.7 5712.8 5740.5 5807.4 5820.4 4110.5 4120.4 4123.9 4129.8 4134.8 5963.1 6030.7 6043.4 6057.7 6154.6 4149.2 4155.8 4167.9 4175.1 4185.4 4239.5 4242.4 4249.8 4251.7 4256.9 4632.8 4822.9 4861.6 4922.6 4923.0 5721.7 5798.6 5805.2 5809.9 5863.1 1401.9 1409.9 1417.1 1428.5 1428.9 896.9 944.2 945.1 945.7 959.0 5338.6 5338.9 5369.2 5390.4 5395.3 5660.4 5700.6 5714.9 5750.6 5773.7 5167.4 5256.9 5352.5 5391.9 5416.6 2967.4 3038.8 3058.3 3065.8 3086.3 5591.9 5766.6 5864.4 5929.4 5930.4 5864.6 5895.8 5896.5 5909.3 5915.6 5787.6 5801.8 5824.6 5834.7 5893.9 5541.2 5634.4 5707.9 5735.4 5816.5 5694.9 5725.3 5760.7 5779.9 5787.5 5533.4 5824.0 5850.1 5855.6 5900.9 3968.6 4015.6 4028.4 4029.2 4037.8 5773.5 5852.4 5859.6 5860.6 5874.5 5564.2 5664.8 5676.3 5682.5 5696.9 5437.1 5531.5 5575.7 5657.8 5675.9 5384.2 5416.9 5446.6 5458.3 5489.8 5654.3 5781.7 5813.6 5840.7 5922.6 5668.9 5700.8 5754.5 5758.9 5774.7 07:34:09 INFO - PROCESS | 5763 | 07:34:09 INFO - PROCESS | 5763 | [#5] yui.html Cycles:180 Average:14983.42 Median:4403.77 stddev:17311.54 (393.1%) stddev-sans-first:17327.12 07:34:09 INFO - PROCESS | 5763 | Values: 755.0 798.7 836.1 886.2 900.0 13945.3 14892.6 15020.8 15072.5 15076.4 14129.2 14134.5 14161.5 14181.9 14200.2 691.5 806.8 824.2 824.3 834.2 817.8 818.2 826.7 826.9 829.1 855.4 857.8 858.2 860.9 866.2 849.9 857.1 861.7 863.0 863.0 637.2 637.9 640.6 642.0 642.3 14013.7 14041.6 14068.7 14156.6 14177.2 14308.1 14349.1 14373.2 14410.9 14496.7 11383.2 11487.6 11601.3 11782.4 11827.4 3610.8 3617.7 3662.5 3690.3 3702.3 53920.0 54108.7 56492.7 56608.4 56752.4 10945.2 10992.5 11000.2 11155.6 11288.0 20471.0 20481.3 20641.9 20690.8 21036.9 8060.6 8223.3 8233.4 8397.5 8543.3 4183.8 4208.9 4305.2 4392.0 4415.5 3422.3 3495.9 3496.1 3503.4 3509.4 630.4 639.5 646.1 648.4 654.4 759.7 779.9 784.2 787.0 788.7 9661.8 9809.2 9912.5 10003.8 10031.7 790.2 801.6 807.3 822.7 828.7 4601.4 4758.3 4766.5 4772.7 4774.1 61168.4 62769.4 63401.7 64780.4 64810.7 49008.0 51138.5 55921.7 56306.0 56710.7 52607.5 52695.2 52944.5 53387.7 53897.0 9631.4 9701.3 9781.2 9930.6 9944.2 33370.0 33645.2 34302.0 34366.1 34642.8 42241.2 44570.6 44781.1 45211.5 45288.5 12419.3 12449.0 12535.6 12558.7 12727.1 12360.8 13338.4 13947.7 13973.3 14173.5 11648.7 11659.1 12176.3 12281.8 12774.0 11622.5 12037.1 12393.1 12607.0 12726.2 11950.5 12073.5 12080.3 12113.2 12137.4 9953.2 10040.0 10071.0 10168.0 10274.6 10170.8 10372.1 10446.7 10450.2 10468.2 07:34:09 INFO - PROCESS | 5763 | -------- Summary: end -------- 07:34:09 INFO - PROCESS | 5763 | 07:34:09 INFO - TEST-INFO | 5763: exit 0 07:34:09 INFO - TEST-OK | dromaeo_css | took 1110791ms 07:34:09 INFO - TEST-START | kraken 07:34:09 INFO - operating with platform_type : linux_ 07:34:09 INFO - Initialising browser for kraken test... 07:34:09 INFO - TEST-INFO | started process 6003 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMcLwOa/profile http://localhost:57298/getInfo.html) 07:34:13 INFO - PROCESS | 6003 | 07:34:13 INFO - PROCESS | 6003 | (process:6070): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 07:34:14 INFO - PROCESS | 6003 | __metrics Screen width/height:1600/1200 07:34:14 INFO - PROCESS | 6003 | colorDepth:24 07:34:14 INFO - PROCESS | 6003 | Browser inner width/height: 1024/697 07:34:14 INFO - PROCESS | 6003 | __metrics 07:34:15 ERROR - PROCESS | 6003 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2937: TypeError: this.tabs is undefined 07:34:16 INFO - TEST-INFO | 6003: exit 0 07:34:16 INFO - Browser initialized. 07:34:16 INFO - Running cycle 1/1 for kraken test... 07:34:16 INFO - TEST-INFO | started process 6121 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMcLwOa/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:34:17 INFO - PROCESS | 6121 | 07:34:17 INFO - PROCESS | 6121 | (process:6182): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 07:34:27 INFO - PROCESS | 6121 | RSS: Main: 163045376 07:34:27 INFO - PROCESS | 6121 | 07:34:30 INFO - PROCESS | 6121 | Cycle 1(1): loaded http://localhost:57298/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57298/tests/kraken/driver.html?testName=audio-beat-detection) 07:34:31 INFO - PROCESS | 6121 | RSS: Main: 167849984 07:34:31 INFO - PROCESS | 6121 | 07:34:34 INFO - PROCESS | 6121 | Cycle 1(1): loaded http://localhost:57298/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57298/tests/kraken/driver.html?testName=audio-dft) 07:34:34 INFO - PROCESS | 6121 | RSS: Main: 168263680 07:34:34 INFO - PROCESS | 6121 | 07:34:37 INFO - PROCESS | 6121 | Cycle 1(1): loaded http://localhost:57298/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57298/tests/kraken/driver.html?testName=audio-fft) 07:34:38 INFO - PROCESS | 6121 | RSS: Main: 162430976 07:34:38 INFO - PROCESS | 6121 | 07:34:40 INFO - PROCESS | 6121 | Cycle 1(1): loaded http://localhost:57298/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57298/tests/kraken/driver.html?testName=audio-oscillator) 07:34:40 INFO - PROCESS | 6121 | RSS: Main: 162729984 07:34:40 INFO - PROCESS | 6121 | 07:34:43 INFO - PROCESS | 6121 | Cycle 1(1): loaded http://localhost:57298/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57298/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:34:43 INFO - PROCESS | 6121 | RSS: Main: 163282944 07:34:43 INFO - PROCESS | 6121 | 07:34:47 INFO - PROCESS | 6121 | Cycle 1(1): loaded http://localhost:57298/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57298/tests/kraken/driver.html?testName=imaging-darkroom) 07:34:47 INFO - PROCESS | 6121 | RSS: Main: 163483648 07:34:47 INFO - PROCESS | 6121 | 07:34:51 INFO - PROCESS | 6121 | Cycle 1(1): loaded http://localhost:57298/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57298/tests/kraken/driver.html?testName=imaging-desaturate) 07:34:51 INFO - PROCESS | 6121 | RSS: Main: 161947648 07:34:51 INFO - PROCESS | 6121 | 07:34:54 INFO - PROCESS | 6121 | Cycle 1(1): loaded http://localhost:57298/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57298/tests/kraken/driver.html?testName=json-parse-financial) 07:34:55 INFO - PROCESS | 6121 | RSS: Main: 162938880 07:34:55 INFO - PROCESS | 6121 | 07:34:56 INFO - PROCESS | 6121 | Cycle 1(1): loaded http://localhost:57298/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57298/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:34:57 INFO - PROCESS | 6121 | RSS: Main: 163151872 07:34:57 INFO - PROCESS | 6121 | 07:34:59 INFO - PROCESS | 6121 | Cycle 1(1): loaded http://localhost:57298/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57298/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:35:00 INFO - PROCESS | 6121 | RSS: Main: 163565568 07:35:00 INFO - PROCESS | 6121 | 07:35:02 INFO - PROCESS | 6121 | Cycle 1(1): loaded http://localhost:57298/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57298/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:35:02 INFO - PROCESS | 6121 | RSS: Main: 163332096 07:35:02 INFO - PROCESS | 6121 | 07:35:05 INFO - PROCESS | 6121 | Cycle 1(1): loaded http://localhost:57298/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57298/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:35:06 INFO - PROCESS | 6121 | RSS: Main: 163545088 07:35:06 INFO - PROCESS | 6121 | 07:35:08 INFO - PROCESS | 6121 | Cycle 1(1): loaded http://localhost:57298/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57298/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:35:09 INFO - PROCESS | 6121 | RSS: Main: 163495936 07:35:09 INFO - PROCESS | 6121 | 07:35:11 INFO - PROCESS | 6121 | Cycle 1(1): loaded http://localhost:57298/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57298/tests/kraken/driver.html?testName=ai-astar) 07:35:11 INFO - PROCESS | 6121 | RSS: Main: 164507648 07:35:11 INFO - PROCESS | 6121 | 07:35:11 INFO - PROCESS | 6121 | __start_tp_report 07:35:11 INFO - PROCESS | 6121 | _x_x_mozilla_page_load 07:35:11 INFO - PROCESS | 6121 | _x_x_mozilla_page_load_details 07:35:11 INFO - PROCESS | 6121 | |i|pagename|runs| 07:35:11 INFO - PROCESS | 6121 | |0;ai-astar;110;111;105;111;112;112;107;114;111;112 07:35:11 INFO - PROCESS | 6121 | |1;audio-beat-detection;165;125;151;215;128;159;152;128;185;128 07:35:11 INFO - PROCESS | 6121 | |2;audio-dft;161;163;162;162;166;170;165;164;161;163 07:35:11 INFO - PROCESS | 6121 | |3;audio-fft;74;75;75;162;77;74;75;77;164;77 07:35:11 INFO - PROCESS | 6121 | |4;audio-oscillator;92;91;174;92;91;92;154;91;91;152 07:35:11 INFO - PROCESS | 6121 | |5;imaging-gaussian-blur;117;117;118;117;118;118;117;118;116;119 07:35:11 INFO - PROCESS | 6121 | |6;imaging-darkroom;148;147;147;146;147;147;146;146;147;147 07:35:11 INFO - PROCESS | 6121 | |7;imaging-desaturate;95;95;95;96;95;96;97;97;97;95 07:35:11 INFO - PROCESS | 6121 | |8;json-parse-financial;58;56;57;57;57;57;57;106;54;57 07:35:11 INFO - PROCESS | 6121 | |9;json-stringify-tinderbox;61;59;60;59;60;59;58;59;60;59 07:35:11 INFO - PROCESS | 6121 | |10;stanford-crypto-aes;78;80;79;80;81;82;82;82;81;85 07:35:11 INFO - PROCESS | 6121 | |11;stanford-crypto-ccm;125;127;140;135;128;143;131;131;187;132 07:35:11 INFO - PROCESS | 6121 | |12;stanford-crypto-pbkdf2;179;171;168;173;169;166;167;167;166;163 07:35:11 INFO - PROCESS | 6121 | |13;stanford-crypto-sha256-iterative;67;63;65;66;63;65;67;64;63;62 07:35:11 INFO - PROCESS | 6121 | __end_tp_report 07:35:11 INFO - PROCESS | 6121 | __start_cc_report 07:35:11 INFO - PROCESS | 6121 | _x_x_mozilla_cycle_collect,869 07:35:11 INFO - PROCESS | 6121 | __end_cc_report 07:35:11 INFO - PROCESS | 6121 | __startTimestamp1462804511594__endTimestamp 07:35:11 INFO - PROCESS | 6121 | 07:35:11 INFO - PROCESS | 6121 | ------- Summary: start ------- 07:35:11 INFO - PROCESS | 6121 | Number of tests: 14 07:35:11 INFO - PROCESS | 6121 | 07:35:11 INFO - PROCESS | 6121 | [#0] ai-astar Cycles:10 Average:110.50 Median:111.50 stddev:2.64 (2.4%) stddev-sans-first:2.79 07:35:11 INFO - PROCESS | 6121 | Values: 110.0 111.0 105.0 111.0 112.0 112.0 107.0 114.0 111.0 112.0 07:35:11 INFO - PROCESS | 6121 | 07:35:11 INFO - PROCESS | 6121 | [#1] audio-beat-detection Cycles:10 Average:153.60 Median:155.50 stddev:29.27 (18.8%) stddev-sans-first:30.75 07:35:11 INFO - PROCESS | 6121 | Values: 165.0 125.0 151.0 215.0 128.0 159.0 152.0 128.0 185.0 128.0 07:35:11 INFO - PROCESS | 6121 | 07:35:11 INFO - PROCESS | 6121 | [#2] audio-dft Cycles:10 Average:163.70 Median:163.50 stddev:2.75 (1.7%) stddev-sans-first:2.74 07:35:11 INFO - PROCESS | 6121 | Values: 161.0 163.0 162.0 162.0 166.0 170.0 165.0 164.0 161.0 163.0 07:35:11 INFO - PROCESS | 6121 | 07:35:11 INFO - PROCESS | 6121 | [#3] audio-fft Cycles:10 Average:93.00 Median:75.00 stddev:36.91 (49.2%) stddev-sans-first:38.51 07:35:11 INFO - PROCESS | 6121 | Values: 74.0 75.0 75.0 162.0 77.0 74.0 75.0 77.0 164.0 77.0 07:35:11 INFO - PROCESS | 6121 | 07:35:11 INFO - PROCESS | 6121 | [#4] audio-oscillator Cycles:10 Average:112.00 Median:91.00 stddev:33.62 (36.9%) stddev-sans-first:34.87 07:35:11 INFO - PROCESS | 6121 | Values: 92.0 91.0 174.0 92.0 91.0 92.0 154.0 91.0 91.0 152.0 07:35:11 INFO - PROCESS | 6121 | 07:35:11 INFO - PROCESS | 6121 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:118.00 stddev:0.85 (0.7%) stddev-sans-first:0.88 07:35:11 INFO - PROCESS | 6121 | Values: 117.0 117.0 118.0 117.0 118.0 118.0 117.0 118.0 116.0 119.0 07:35:11 INFO - PROCESS | 6121 | 07:35:11 INFO - PROCESS | 6121 | [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:0.63 (0.4%) stddev-sans-first:0.50 07:35:11 INFO - PROCESS | 6121 | Values: 148.0 147.0 147.0 146.0 147.0 147.0 146.0 146.0 147.0 147.0 07:35:11 INFO - PROCESS | 6121 | 07:35:11 INFO - PROCESS | 6121 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.92 (1.0%) stddev-sans-first:0.93 07:35:11 INFO - PROCESS | 6121 | Values: 95.0 95.0 95.0 96.0 95.0 96.0 97.0 97.0 97.0 95.0 07:35:11 INFO - PROCESS | 6121 | 07:35:11 INFO - PROCESS | 6121 | [#8] json-parse-financial Cycles:10 Average:61.60 Median:57.00 stddev:15.64 (27.4%) stddev-sans-first:16.53 07:35:11 INFO - PROCESS | 6121 | Values: 58.0 56.0 57.0 57.0 57.0 57.0 57.0 106.0 54.0 57.0 07:35:11 INFO - PROCESS | 6121 | 07:35:11 INFO - PROCESS | 6121 | [#9] json-stringify-tinderbox Cycles:10 Average:59.40 Median:59.50 stddev:0.84 (1.4%) stddev-sans-first:0.67 07:35:11 INFO - PROCESS | 6121 | Values: 61.0 59.0 60.0 59.0 60.0 59.0 58.0 59.0 60.0 59.0 07:35:11 INFO - PROCESS | 6121 | 07:35:11 INFO - PROCESS | 6121 | [#10] stanford-crypto-aes Cycles:10 Average:81.00 Median:81.50 stddev:1.94 (2.4%) stddev-sans-first:1.73 07:35:11 INFO - PROCESS | 6121 | Values: 78.0 80.0 79.0 80.0 81.0 82.0 82.0 82.0 81.0 85.0 07:35:11 INFO - PROCESS | 6121 | 07:35:11 INFO - PROCESS | 6121 | [#11] stanford-crypto-ccm Cycles:10 Average:137.90 Median:133.50 stddev:18.14 (13.6%) stddev-sans-first:18.63 07:35:11 INFO - PROCESS | 6121 | Values: 125.0 127.0 140.0 135.0 128.0 143.0 131.0 131.0 187.0 132.0 07:35:11 INFO - PROCESS | 6121 | 07:35:11 INFO - PROCESS | 6121 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.90 Median:168.50 stddev:4.51 (2.7%) stddev-sans-first:2.95 07:35:11 INFO - PROCESS | 6121 | Values: 179.0 171.0 168.0 173.0 169.0 166.0 167.0 167.0 166.0 163.0 07:35:11 INFO - PROCESS | 6121 | 07:35:11 INFO - PROCESS | 6121 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.50 Median:65.00 stddev:1.78 (2.7%) stddev-sans-first:1.64 07:35:11 INFO - PROCESS | 6121 | Values: 67.0 63.0 65.0 66.0 63.0 65.0 67.0 64.0 63.0 62.0 07:35:11 INFO - PROCESS | 6121 | -------- Summary: end -------- 07:35:11 INFO - PROCESS | 6121 | 07:35:12 INFO - TEST-INFO | 6121: exit 0 07:35:12 INFO - TEST-OK | kraken | took 62709ms 07:35:12 INFO - SUITE-END | took 1173s 07:35:12 INFO - Completed test suite (00:19:33) 07:35:12 INFO - javascript benchmark 07:35:12 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3155.4162479941197, 3159.0680749178996, 3203.247236899328, 3221.8872339468107, 3223.3069889973635, 5394.083005889003, 5396.811111611094, 5448.073827449333, 5489.58828087894, 5492.093804522259, 5320.574354051676, 5476.507114359707, 5484.341878974518, 5526.364468086172, 5559.833205003856, 4920.114379411704, 4966.652334336598, 5044.899102017957, 5068.898622027557, 5120.180771076629, 4918.827841025565, 5129.871753206163, 5156.200788877712, 5172.534471897528, 5177.767000484969, 4924.28597853311, 4968.354113965198, 4982.451930287665, 4993.525615066563, 4993.825216117437, 5044.848654540333, 5051.343325367716, 5056.570191533724, 5064.873378165538, 5112.514311140436, 5035.496450354972, 5035.924461133086, 5040.269160971675, 5042.571381432583, 5061.190209566452, 5312.574994000509, 5331.680099194061, 5362.195670649395, 5362.597805164628, 5378.677279363212, 5828.737706803162, 5867.031939729939, 5887.705614719247, 5894.115882617642, 5910.881782364371, 5810.070388737824, 5823.039198532237, 5935.37678543751, 5944.019236825919, 5950.613210141327, 5446.2375267462585, 5491.588130890199, 5519.641223320471, 5534.252875861747, 5602.0, 5983.371745966698, 6015.4586087252355, 6031.065184896348, 6032.939670603238, 6036.9737144685505, 5631.549476041907, 5678.4037676044245, 5723.484886360247, 5765.4811067004175, 5779.653220806765, 5789.334226563999, 5829.912551311733, 5863.648181109147, 5867.14926335679, 5914.940850591439, 5764.193012978102, 5784.566157538202, 5812.099124635688, 5814.796482123105, 5820.505257053198, 5873.970630146822, 5919.3192782829665, 5940.821775346746, 5944.851378715567, 5977.013792724239, 4486.730796152241, 4497.482789479252, 4506.842260520932, 4516.728996260169, 4551.863444096616, 3887.494625698641, 4016.8393264269685, 4052.9392059119136, 4054.3715724062818, 4067.349224124126, 5536.252605898233, 5540.0, 5550.389457159709, 5565.6104072714525, 5599.076152434803, 5889.764409423575, 5890.587658863838, 5907.822765317047, 5916.437938395846, 5926.822195334147, 5402.810901618424, 5570.275864137636, 5576.191452239403, 5579.7489112990015, 5588.0, 5053.620978426633, 5094.133997220481, 5107.846764597068, 5117.488251174853, 5158.071547121479, 6009.609375390585, 6029.577929544977, 6063.666498342545, 6067.514598832083, 6078.969605151946, 5720.313562372542, 5898.793542226002, 5919.378465261258, 5982.042873140451, 5985.102234664835, 6078.149059131813, 6081.726322315418, 6082.330943596113, 6083.178770865877, 6111.205543279345, 5871.383504732113, 5899.616524925866, 5903.586748927705, 5907.143464197753, 5909.940900591111, 5697.259356283656, 5818.0, 5849.064149736192, 5901.557383196192, 5927.851803704942, 5731.914021289601, 5744.569157313134, 5746.310442746897, 5757.193992840922, 5759.452851979056, 5704.914426283526, 5737.655740655574, 5756.366799651951, 5760.020796464695, 5760.8271751847515, 5461.371942226695, 5523.6685798852195, 5530.281063461724, 5545.417731138173, 5570.777168913198, 5744.885102297847, 5748.396418376177, 5766.711664416678, 5816.156657284585, 5836.620619659709, 5687.573431992534, 5691.3170419549915, 5706.9714651426475, 5710.37185909558, 5712.171735098471], "value": 5419.932806492727, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [609.2962628164472, 641.6791604197902, 655.2595567009284, 659.498780926496, 662.8110988368313, 32749.508757368658, 44988.550114498845, 45902.0, 46057.0, 46111.53888461119, 47352.816179595524, 47718.284225736556, 47798.283025754645, 47893.760531197295, 47893.76053119738, 8992.730218093451, 9131.0, 9138.0, 9138.908610913906, 9148.17666410023, 8942.46345219289, 8984.416012959136, 8987.101289871025, 8992.910070899272, 9010.54947252638, 9000.954995225047, 9029.0, 9039.502827344493, 9066.365354425192, 9069.047749986255, 8974.775630609221, 9027.368084234105, 9035.0, 9039.548022598843, 9046.547672616376, 8892.59983300753, 8956.910430895672, 8970.192682658591, 8971.282297416255, 8978.326625503048, 42783.35824962628, 42825.78587107076, 42932.57067429317, 42981.78509107466, 43142.13715725668, 3576.8211589420425, 3654.0, 3749.381352076904, 3758.5113935188524, 4168.228877657612, 32350.83824580862, 32947.835260823784, 33163.17092072718, 33517.32965340679, 34455.13862153441, 4424.292113261895, 4439.223135951228, 4460.7323560586465, 4472.463304403493, 4494.07871386365, 295065.0, 297743.51128244435, 298353.0, 301298.0, 302803.0, 35669.821650892096, 58696.706516467995, 59075.40924590785, 59522.40477595255, 59607.0, 36323.63676363203, 37990.0, 38514.0, 38555.80722096372, 38580.421293680614, 14026.947978901419, 14079.296035198198, 14142.929285353714, 14171.433142674177, 14405.279736013366, 11439.771204575862, 11455.255408398427, 11470.311781292981, 11537.596184133683, 11537.653870383901, 7069.858602827914, 7083.433325334064, 7097.858042839114, 7176.031235783207, 7195.460340474486, 3249.5775549178456, 3298.0765385691566, 3300.3069355435628, 3307.074019274607, 3363.058343663778, 1068.2468859454066, 1111.5498223219608, 1121.607437396921, 1163.4531770068224, 1193.9522419103312, 32500.512492312635, 32949.341013179604, 33042.504362434585, 33521.32957340888, 33903.0, 1106.773111512138, 1156.9479373428217, 1198.316959333189, 1199.696582561484, 1231.9322437265857, 17460.126993650265, 17496.650066998587, 17561.67783569124, 17568.0, 18033.54916127081, 518014.0, 520841.0, 522428.0, 523532.0, 524255.0, 59630.0, 60199.09701354483, 60279.69860150671, 60329.39670603238, 60413.395866041654, 1396.6578188343717, 1410.182094385254, 1414.6746248362933, 1416.1715396492962, 1435.798988141661, 31512.842435787676, 31868.203294917814, 31885.20286992844, 32145.35709285848, 32221.194470138435, 52854.20718689146, 53020.0, 53030.0, 53269.733651331495, 53282.0, 407195.0, 412704.0, 413576.0, 413774.0, 414404.0, 29379.265518362212, 29487.26281842971, 29619.555706663985, 29676.10971670853, 29759.404811904074, 49671.751641241564, 50265.49734502754, 50482.74758626183, 50708.492915070376, 51472.22791658203, 41843.581564183965, 42814.35778463263, 43523.69428917138, 43632.56367436412, 44108.0, 41793.37309940414, 41995.0, 42218.36672449854, 43311.35032974571, 43707.781461093764, 36854.26291474209, 42808.357874631285, 43288.567114329715, 43588.56411435845, 43751.78124109359, 36064.8196759025, 37818.534826474184, 37840.81079594584, 38103.618963810004, 38346.80826595849, 28382.23359604868, 28685.713142868302, 29567.26081847971, 29603.407931841673, 29679.25801854971], "value": 19137.06109101628, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [409.6620288262184, 409.73162578511085, 411.2474172264756, 413.9855105071323, 426.69704509798044, 18006.909965450188, 19545.12046957887, 19762.505937351554, 19784.406467805988, 19799.109040093193, 18197.727034094467, 18608.34870779523, 19079.14143863526, 19681.70477442836, 19682.90158549205, 5787.21872547206, 5842.298924129111, 5890.617109887844, 5925.407459254062, 5967.910481342783, 5708.457696518844, 5841.065429531276, 5853.5902486825935, 5870.911936320958, 5883.264591926009, 5647.491725744682, 5772.682502462363, 5779.0, 5817.41825817417, 5839.620424672383, 5486.698231597261, 5750.511206547449, 5793.304803423574, 5807.128930660392, 5810.273715785527, 5631.63394379364, 5686.402927692616, 5719.799807006776, 5733.627314224562, 5745.913811292834, 22502.77497225023, 22568.322950311518, 22676.65985010226, 23199.3040208794, 23268.301950941328, 2290.541891621682, 2712.8101032927702, 2868.1969048666406, 2909.6799352071257, 3018.2303512604367, 10189.337693049929, 10244.846327305022, 13454.932725336408, 13667.726645467135, 14021.369038393297, 1769.7079981802988, 1862.5622978600018, 1873.334966087033, 1886.5674015466318, 1940.1560321260297, 64926.675366623334, 75103.0, 75188.62405687936, 80250.0, 82870.58564707199, 10764.13886889047, 10885.965833245988, 10957.12343012557, 11017.338959662446, 11264.972304985018, 14490.971264023045, 14577.489787857374, 14643.414263429344, 14662.633434164018, 14737.631559210891, 7914.841703165905, 7982.720604778805, 8018.839623207503, 8086.070101938235, 8145.877811832827, 7488.138864030598, 7601.923980760233, 7627.847443051219, 7647.311741943252, 7864.6854125834325, 4505.617022553054, 4592.265237561974, 4625.907481850344, 4682.672212945129, 4765.213739732905, 1838.531174550481, 1951.7170010348705, 1970.2808474906842, 1979.1786408640542, 1992.1334219614514, 991.667791289926, 1039.812833689943, 1071.8713754349528, 1166.6966588686832, 1187.1986409173774, 18921.148548315083, 19305.80694193068, 19378.0, 19482.902585487267, 19511.512212194808, 1034.4689859008558, 1036.1555332404216, 1062.3731998121145, 1092.4100985467758, 1098.5770478365728, 9578.281628877861, 10889.564417423373, 10977.28647637901, 11000.119990400748, 11136.498857551429, 533010.0, 555653.0, 570175.9642079633, 576831.0, 579161.0, 54501.45498545043, 64506.0, 94895.52552237333, 94944.05055949352, 95183.52408237914, 1026.1944373666636, 1033.194108595297, 1037.766502536923, 1061.883192848786, 1063.8936106389453, 16741.74887376715, 17152.399666011628, 17171.141442927554, 17225.0, 17489.737653934946, 27467.450650987266, 29696.40607187801, 32456.51315230226, 38984.41523377208, 39991.80004099961, 53418.465815342905, 54982.72508637431, 55025.1746223799, 55213.44786552083, 56134.157987631035, 8683.956580217311, 8685.39202255836, 8698.0, 8732.78168045804, 9028.458292502472, 9717.271204659537, 13256.80114798298, 13426.395812188279, 13489.055766096279, 13611.727765444833, 11448.3703396314, 11475.885241147482, 11520.88479115198, 11637.06903447739, 11748.941255293668, 11035.962220301964, 11291.491882865126, 11530.82703759461, 11563.884361156617, 11784.70538236551, 11556.306621602731, 11738.237014594366, 11767.293962362286, 12078.698032549257, 12171.81742273849, 8673.609687563949, 8727.825443491221, 8796.252318552739, 8852.070532593985, 8864.113588641085, 10332.276740628084, 11222.438878056228, 11230.270032448192, 11466.140039497239, 11505.482253298454], "value": 9249.679296558148, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1559.5711179425657, 1567.5454118305688, 1748.1958299182375, 1796.812749003985, 1806.1962426720115, 7614.428917831171, 8479.745607631774, 8492.49045057297, 9099.135582119696, 9104.499252541107, 8711.91288087119, 8713.0, 8734.126587341263, 8745.606447709852, 8747.431416957894, 2345.8827058647125, 2366.645003249509, 2366.7041619797524, 2387.9522409551887, 2393.964090538643, 2291.86248825071, 2341.988290058556, 2348.7416384197722, 2354.564405584972, 2361.728401233854, 2311.0, 2328.75548067453, 2343.5195784864145, 2366.4912043910554, 2366.8698221597806, 2257.3115199864037, 2273.2952784636814, 2275.055851821492, 2299.2297580310533, 2322.500662357584, 2266.5580211858696, 2299.9425014374606, 2303.896324665394, 2314.340412982292, 2314.5833749925005, 8819.162179592928, 8859.955700221522, 8874.911250887537, 8886.066962968924, 8909.910900890973, 5237.397699264595, 5353.197020446964, 5359.919601205985, 5364.785408583652, 5365.517103460707, 3337.8331083445732, 3338.21551935295, 3462.5844898612077, 3491.9476207856646, 3535.186907011376, 1129.1587767113554, 1134.183387960667, 1170.584442522909, 1192.8986036186848, 1204.2052245518003, 10809.67570972872, 11034.613788517443, 11036.392998385085, 11437.256578322382, 11451.48468318936, 4486.842960496367, 4501.257292546758, 4551.544845515488, 4576.244919588231, 4577.3362862384765, 9736.36713613627, 9755.414675119515, 9762.414255144715, 9762.560684769202, 9813.509324533745, 5302.072137375943, 5316.734163291897, 5366.436524164985, 5370.489803468664, 5373.65071270374, 4404.009097952935, 4733.9763301183275, 4876.487968763229, 4888.7311197884455, 4946.159152944008, 3765.7740535567955, 3785.848566057382, 3815.465834783133, 3854.845806167778, 3887.7861717605238, 1126.3129491010477, 1144.8683401408944, 1157.2073129906041, 1182.899453546441, 1187.5309252845077, 837.5937670230055, 948.2414068744977, 962.259060523393, 962.3985009369144, 988.7528117970508, 5289.100852855024, 5471.06991811393, 5526.972365138148, 5571.0, 5691.9146212806845, 963.0898800633335, 965.8116667249959, 965.82615129276, 1007.2395341517108, 1017.2929813779352, 3571.089372210122, 3600.351936651428, 3611.9277614447565, 3645.799481028516, 3654.0499470137956, 10666.839997400046, 11099.390588364642, 11159.72100697489, 11206.439678016066, 11219.102471802236, 10717.035466808025, 10821.513031913582, 10905.672829815117, 10989.725256868482, 11083.168762342857, 8379.706710265233, 8423.663053477914, 8435.578221088921, 8448.873266901, 8599.785005374915, 5711.942880571307, 5792.710364481674, 5899.085641725539, 6003.459688628044, 6056.788012419544, 9549.28380371461, 9741.512924353612, 9950.651727189803, 10255.58977640886, 10264.178865690876, 10154.898451015692, 10329.638462653771, 10353.482325883526, 10532.104771094237, 10681.51933162994, 7677.232276772278, 8383.37124715661, 8429.789255268668, 8469.830603388022, 8645.610947507503, 8742.825143496968, 8746.344024198082, 8757.124287571447, 8763.0, 8812.2950163988, 7462.992496012968, 7616.428767842323, 7673.0, 7844.254795794391, 7945.801354966172, 7535.472516923982, 7869.134395216407, 7901.051873775184, 8004.599770011592, 8022.358211343195, 7025.437964962688, 7185.568865868065, 7212.098487689039, 7231.566106033655, 7245.529040612343, 4946.08497427977, 5032.823851165192, 5084.847454576368, 5100.056489549445, 5126.871828204325, 5067.467915868928, 5079.72061536619, 5101.260317254051, 5120.436751957356, 5244.737763111905], "value": 4623.535124686283, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [328.5646518363169, 328.84872958439115, 336.23506522660944, 336.5574269835168, 337.0512008695522, 5497.587680923927, 5507.284053073105, 5525.530329921957, 5573.386927437979, 5631.746571404292, 5474.698891560963, 5490.56075513959, 5496.670199788015, 5499.257600223978, 5505.284313039299, 4092.77489738065, 4188.204241194163, 4230.619244268015, 4241.597048280409, 4303.074838909633, 4232.894177645553, 4251.298535741599, 4254.765987870666, 4326.502452217988, 4347.93473100278, 4297.226499230137, 4299.226139294926, 4302.333138363559, 4303.289957157065, 4308.931712777869, 4025.6175663311938, 4237.343211802176, 4254.617084462413, 4277.588395829369, 4293.969447332649, 3745.250949810049, 3753.343164946151, 3770.2082562661876, 3777.527809023872, 3789.6399842014966, 5310.070737620939, 5320.17537281722, 5334.4132145464355, 5336.30628018359, 5431.565474762009, 4629.606483448911, 4862.659613827033, 4870.464248932614, 4878.0, 4902.264660300948, 5710.71508910496, 5712.771489140429, 5740.4546568076385, 5807.444724321285, 5820.417958204146, 4110.520212723447, 4120.423140760296, 4123.8556650517085, 4129.834806607732, 4134.793260336971, 5963.1494130149595, 6030.66831324277, 6043.398499397663, 6057.666828324441, 6154.569180157391, 4149.170165966819, 4155.774046656244, 4167.8958026049595, 4175.144095460423, 4185.434966279574, 4239.491261048694, 4242.406063151161, 4249.766262855573, 4251.681123915719, 4256.893577660521, 4632.814687412533, 4822.903541929142, 4861.6353773467135, 4922.556969872729, 4922.990786888679, 5721.656700597978, 5798.59409841307, 5805.187273781674, 5809.88380232393, 5863.120531920246, 1401.9369128389044, 1409.873111419977, 1417.1284659934067, 1428.4857451317516, 1428.8785453236592, 896.8609865470946, 944.1832814615445, 945.1399226703667, 945.7257395355407, 958.990410095904, 5338.626296159232, 5338.866528336823, 5369.24830523727, 5390.380106287748, 5395.271638328775, 5660.377358490563, 5700.572457065737, 5714.914276285859, 5750.6262092963825, 5773.740181691834, 5167.379914410295, 5256.894862102737, 5352.4915133062295, 5391.892162156735, 5416.643759964428, 2967.4065186962694, 3038.769298434138, 3058.2720762768963, 3065.754739620825, 3086.27472543952, 5591.888162236733, 5766.596338256366, 5864.384239654775, 5929.436703513159, 5930.406959304121, 5864.589478736448, 5895.764169433174, 5896.498797602166, 5909.261342332208, 5915.556333274935, 5787.594868359174, 5801.82594522165, 5824.563157763185, 5834.737436815353, 5893.911591326134, 5541.171413433477, 5634.392941047325, 5707.8858422832145, 5735.36910939788, 5816.534677225896, 5694.943050569607, 5725.255716756795, 5760.683162426107, 5779.884402312015, 5787.479126878601, 5533.363663178786, 5824.0, 5850.0932355484965, 5855.560832937632, 5900.92205028821, 3968.583298753589, 4015.630777841088, 4028.43601895729, 4029.17401932609, 4037.8384864605086, 5773.509251713652, 5852.356240813422, 5859.648421094748, 5860.589758717019, 5874.534024925315, 5564.248826408383, 5664.801731939362, 5676.347220069745, 5682.460166284196, 5696.886062278814, 5437.1241921537, 5531.474509921551, 5575.7490912909825, 5657.773689052392, 5675.858103547444, 5384.223206341976, 5416.864578385572, 5446.591505637014, 5458.344998600034, 5489.819688766935, 5654.321481422256, 5781.710914454345, 5813.593048486566, 5840.707964601838, 5922.585419020627, 5668.914966275592, 5700.800471983461, 5754.53963682896, 5758.913616295675, 5774.700692344357], "value": 4323.164489581015, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [754.992450075499, 798.7411361644491, 836.126248070766, 886.162576365335, 899.9685011024616, 13945.302734863255, 14892.627684307898, 15020.849791502082, 15072.547823565297, 15076.396944122249, 14129.152250864956, 14134.50529231477, 14161.504347347845, 14181.858181418183, 14200.218987955684, 691.5297597633607, 806.770070529899, 824.1840577827967, 824.3240542754943, 834.2450082675189, 817.81190326225, 818.2186012358213, 826.68999125328, 826.89663792026, 829.1169904052196, 855.4054931822386, 857.8284343131368, 858.2061593026457, 860.9009963854143, 866.1771317248607, 849.8512760266959, 857.0529564830865, 861.6596444404425, 862.9784255393571, 863.011851430109, 637.1812221295659, 637.8692368064536, 640.5644161969859, 642.0401499757845, 642.2549842183092, 14013.719725605533, 14041.64895877601, 14068.71862562743, 14156.646083847883, 14177.220252886087, 14308.069975451666, 14349.13905165683, 14373.209473478955, 14410.855891441057, 14496.71006579873, 11383.178691409417, 11487.597934072352, 11601.303921764636, 11782.351970641612, 11827.408629568487, 3610.7833529988284, 3617.7467577269604, 3662.450632405134, 3690.2619476104887, 3702.2965636529243, 53920.0, 54108.72945635286, 56492.71753641246, 56608.35787168721, 56752.43247567554, 10945.23383363157, 10992.450377481095, 11000.22998390105, 11155.553777848796, 11288.0, 20471.0, 20481.2831550895, 20641.89679051595, 20690.793092069187, 21036.894815525826, 8060.637271322805, 8223.259906608433, 8233.423660343838, 8397.496150231005, 8543.273821725223, 4183.811728472226, 4208.915821683549, 4305.182015417061, 4392.0, 4415.5363686812425, 3422.3497535468678, 3495.9475607865393, 3496.091016335771, 3503.386907291214, 3509.438489841613, 630.3633330336302, 639.5491178718992, 646.1406329581645, 648.4488185042676, 654.3914159831307, 759.673340463606, 779.8557266905641, 784.2432053068702, 786.9842603147905, 788.6687591211705, 9661.758456038655, 9809.166220871162, 9912.504374781232, 10003.79992400148, 10031.69904902854, 790.2295262119387, 801.5831767480877, 807.3460496997451, 822.6709316273539, 828.6879605899593, 4601.4248218972625, 4758.310045043519, 4766.523347665275, 4772.665913386099, 4774.140654682121, 61168.38831611716, 62769.37230627727, 63401.68299158475, 64780.35219647743, 64810.675946619966, 49008.0, 51138.48861511412, 55921.720391398594, 56306.0, 56710.71644641833, 52607.47392526102, 52695.20957185645, 52944.47055529473, 53387.733061335224, 53897.0, 9631.43932013366, 9701.291577320158, 9781.236644104374, 9930.553125109533, 9944.15474684631, 33370.0, 33645.15887102842, 34302.0, 34366.14084647804, 34642.82678586591, 42241.15517689568, 44570.554294457936, 44781.10437791291, 45211.54788452073, 45288.54711452843, 12419.31693756816, 12449.0, 12535.623931282076, 12558.748825023631, 12727.109102362745, 12360.75278494443, 13338.399772010476, 13947.651308717363, 13973.301334933416, 14173.503927362493, 11648.650540483799, 11659.125565582446, 12176.269423834598, 12281.815772763595, 12774.0, 11622.535098595961, 12037.097217708882, 12393.132480726263, 12607.0, 12726.23642581411, 11950.521979120738, 12073.456694448596, 12080.335581543099, 12113.15207935436, 12137.393130343624, 9953.153981911619, 10040.0, 10071.0, 10168.0, 10274.589016439259, 10170.796584068425, 10372.118369938338, 10446.738831528968, 10450.163986881184, 10468.214883883587], "value": 6850.514150844934, "unit": "score"}], "name": "dromaeo_css", "value": 7129.999492370742, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 111.0, 105.0, 111.0, 112.0, 112.0, 107.0, 114.0, 111.0, 112.0], "value": 110.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 125.0, 151.0, 215.0, 128.0, 159.0, 152.0, 128.0, 185.0, 128.0], "value": 153.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 163.0, 162.0, 162.0, 166.0, 170.0, 165.0, 164.0, 161.0, 163.0], "value": 163.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 75.0, 162.0, 77.0, 74.0, 75.0, 77.0, 164.0, 77.0], "value": 93.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 91.0, 174.0, 92.0, 91.0, 92.0, 154.0, 91.0, 91.0, 152.0], "value": 112.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 118.0, 117.0, 118.0, 118.0, 117.0, 118.0, 116.0, 119.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 147.0, 146.0, 147.0, 147.0, 146.0, 146.0, 147.0, 147.0], "value": 146.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 96.0, 95.0, 96.0, 97.0, 97.0, 97.0, 95.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 56.0, 57.0, 57.0, 57.0, 57.0, 57.0, 106.0, 54.0, 57.0], "value": 61.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 59.0, 60.0, 59.0, 60.0, 59.0, 58.0, 59.0, 60.0, 59.0], "value": 59.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 80.0, 79.0, 80.0, 81.0, 82.0, 82.0, 82.0, 81.0, 85.0], "value": 81.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 127.0, 140.0, 135.0, 128.0, 143.0, 131.0, 131.0, 187.0, 132.0], "value": 137.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [179.0, 171.0, 168.0, 173.0, 169.0, 166.0, 167.0, 167.0, 166.0, 163.0], "value": 168.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 63.0, 65.0, 66.0, 63.0, 65.0, 67.0, 64.0, 63.0, 62.0], "value": 64.5, "unit": "score"}], "name": "kraken", "value": 1566.2, "alertThreshold": 2.0}]} 07:35:12 INFO - Return code: 0 07:35:12 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 07:35:12 ERROR - # TBPL SUCCESS # 07:35:12 INFO - Running post-action listener: _resource_record_post_action 07:35:12 INFO - ##### 07:35:12 INFO - ##### Finished run-tests step (success) 07:35:12 INFO - ##### 07:35:12 INFO - Running post-run listener: _resource_record_post_run 07:35:13 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 2207744; Write bytes: 535351296; Read time: 1456; Write time: 444440 07:35:13 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 186675200; Read time: 0; Write time: 208760 07:35:14 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 2207744; Write bytes: 290414592; Read time: 1456; Write time: 207812 07:35:14 INFO - Running post-run listener: _upload_blobber_files 07:35:14 INFO - Blob upload gear active. 07:35:14 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:35:14 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 07:35:14 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:35:14 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:35:14 INFO - (blobuploader) - INFO - Open directory for files ... 07:35:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 07:35:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:35:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:35:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 07:35:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:35:15 INFO - (blobuploader) - INFO - Done attempting. 07:35:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 07:35:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:35:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:35:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 07:35:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:35:15 INFO - (blobuploader) - INFO - Done attempting. 07:35:15 INFO - (blobuploader) - INFO - Iteration through files over. 07:35:15 INFO - Return code: 0 07:35:15 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:35:15 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:35:15 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d98b5d85a9220fede50832f46c4b6846b69ebce0faa7d2f03d75cbf2e82cf1a589028de37d5e60c77c5e005427e7df37bdf583e3ac660681d770bcc3730cd395", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bda302279057f09cdf623a66bccbbbcfe7c04c9bc073b14786ffc7507ef1cbc80f358ab3cac0d818c2f291d643f459fcf44157ff2eac763ce48ff76b56da8cdd"} 07:35:15 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:35:15 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:35:15 INFO - Contents: 07:35:15 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d98b5d85a9220fede50832f46c4b6846b69ebce0faa7d2f03d75cbf2e82cf1a589028de37d5e60c77c5e005427e7df37bdf583e3ac660681d770bcc3730cd395", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bda302279057f09cdf623a66bccbbbcfe7c04c9bc073b14786ffc7507ef1cbc80f358ab3cac0d818c2f291d643f459fcf44157ff2eac763ce48ff76b56da8cdd"} 07:35:15 INFO - Running post-run listener: copy_logs_to_upload_dir 07:35:15 INFO - Copying logs to upload dir... 07:35:15 INFO - mkdir: /builds/slave/test/build/upload/logs 07:35:15 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.856860 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-05-09 07:35:15.379063) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-09 07:35:15.382875) ========= 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=cbe409c6de289db6ac707de3000001d4-1462802875.667723-1287373266 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/Firefox/sha512/d98b5d85a9220fede50832f46c4b6846b69ebce0faa7d2f03d75cbf2e82cf1a589028de37d5e60c77c5e005427e7df37bdf583e3ac660681d770bcc3730cd395", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bda302279057f09cdf623a66bccbbbcfe7c04c9bc073b14786ffc7507ef1cbc80f358ab3cac0d818c2f291d643f459fcf44157ff2eac763ce48ff76b56da8cdd"} build_url:https://queue.taskcluster.net/v1/task/Gx7NyQHERGCqQDddiVh7kg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011391 build_url: 'https://queue.taskcluster.net/v1/task/Gx7NyQHERGCqQDddiVh7kg/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/Firefox/sha512/d98b5d85a9220fede50832f46c4b6846b69ebce0faa7d2f03d75cbf2e82cf1a589028de37d5e60c77c5e005427e7df37bdf583e3ac660681d770bcc3730cd395", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bda302279057f09cdf623a66bccbbbcfe7c04c9bc073b14786ffc7507ef1cbc80f358ab3cac0d818c2f291d643f459fcf44157ff2eac763ce48ff76b56da8cdd"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-09 07:35:15.407158) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 07:35:15.407473) ========= 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=cbe409c6de289db6ac707de3000001d4-1462802875.667723-1287373266 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004532 ========= master_lag: 0.21 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 07:35:15.624672) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-09 07:35:15.624987) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-09 07:35:15.625323) ========= ========= Total master_lag: 0.30 =========