builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-024 starttime: 1462409200.94 results: success (0) buildid: 20160504170944 builduid: 592364b9b0bb4f14a25b25ddb0f09f43 revision: 29662e28a9c93ac67ee0b8ddfb65a9f29bbf73f5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-04 17:46:40.939322) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-04 17:46:40.939818) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-04 17:46:40.940095) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-04 17:46:40.971282) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-04 17:46:40.971572) ========= 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=7cf709767345e0a0c5a90e72000001d4-1462408860.697390-566542548 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-04 17:46:41-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 223M=0s 2016-05-04 17:46:41 (223 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.132553 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-04 17:46:41.119591) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-04 17:46:41.119912) ========= 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=7cf709767345e0a0c5a90e72000001d4-1462408860.697390-566542548 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019141 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-04 17:46:41.169452) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-04 17:46:41.169826) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 29662e28a9c93ac67ee0b8ddfb65a9f29bbf73f5 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 29662e28a9c93ac67ee0b8ddfb65a9f29bbf73f5 --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=7cf709767345e0a0c5a90e72000001d4-1462408860.697390-566542548 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-04 17:46:41,665 truncating revision to first 12 chars 2016-05-04 17:46:41,665 Setting DEBUG logging. 2016-05-04 17:46:41,665 attempt 1/10 2016-05-04 17:46:41,665 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/29662e28a9c9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-04 17:46:41,908 unpacking tar archive at: fx-team-29662e28a9c9/testing/mozharness/ program finished with exit code 0 elapsedTime=0.526566 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-04 17:46:41.714731) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-04 17:46:41.715007) ========= script_repo_revision: 29662e28a9c93ac67ee0b8ddfb65a9f29bbf73f5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-04 17:46:41.715364) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-04 17:46:41.715637) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-04 17:46:41.725862) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-05-04 17:46:41.726176) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=7cf709767345e0a0c5a90e72000001d4-1462408860.697390-566542548 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:46:42 INFO - MultiFileLogger online at 20160504 17:46:42 in /builds/slave/test 17:46:42 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 17:46:42 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:46:42 INFO - {'append_to_log': False, 17:46:42 INFO - 'base_work_dir': '/builds/slave/test', 17:46:42 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 17:46:42 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:46:42 INFO - 'branch': 'Fx-Team-Non-PGO', 17:46:42 INFO - 'buildbot_json_path': 'buildprops.json', 17:46:42 INFO - 'config_files': ('talos/linux_config.py',), 17:46:42 INFO - 'default_actions': ('clobber', 17:46:42 INFO - 'read-buildbot-config', 17:46:42 INFO - 'download-and-extract', 17:46:42 INFO - 'populate-webroot', 17:46:42 INFO - 'create-virtualenv', 17:46:42 INFO - 'install', 17:46:42 INFO - 'run-tests'), 17:46:42 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:46:42 INFO - 'download_minidump_stackwalk': True, 17:46:42 INFO - 'download_symbols': 'ondemand', 17:46:42 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:46:42 INFO - 'tooltool.py': '/tools/tooltool.py', 17:46:42 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:46:42 INFO - '/tools/misc-python/virtualenv.py')}, 17:46:42 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:46:42 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:46:42 INFO - 'installer_path': 'installer.exe', 17:46:42 INFO - 'log_level': 'info', 17:46:42 INFO - 'log_name': 'talos', 17:46:42 INFO - 'log_to_console': True, 17:46:42 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:46:42 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:46:42 INFO - 'opt_config_files': (), 17:46:42 INFO - 'pip_index': False, 17:46:42 INFO - 'sps_profile': False, 17:46:42 INFO - 'sps_profile_interval': 0, 17:46:42 INFO - 'suite': 'dromaeojs-e10s', 17:46:42 INFO - 'system_bits': '32', 17:46:42 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:46:42 INFO - 'title': 'talos-linux64-ix-024', 17:46:42 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:46:42 INFO - 'use_talos_json': True, 17:46:42 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:46:42 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:46:42 INFO - 'work_dir': 'build'} 17:46:42 INFO - ##### 17:46:42 INFO - ##### Running clobber step. 17:46:42 INFO - ##### 17:46:42 INFO - Running pre-action listener: _resource_record_pre_action 17:46:42 INFO - Running main action method: clobber 17:46:42 INFO - rmtree: /builds/slave/test/build 17:46:42 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:46:42 INFO - Running post-action listener: _resource_record_post_action 17:46:42 INFO - ##### 17:46:42 INFO - ##### Running read-buildbot-config step. 17:46:42 INFO - ##### 17:46:42 INFO - Running pre-action listener: _resource_record_pre_action 17:46:42 INFO - Running main action method: read_buildbot_config 17:46:42 INFO - Using buildbot properties: 17:46:42 INFO - { 17:46:42 INFO - "project": "", 17:46:42 INFO - "product": "firefox", 17:46:42 INFO - "script_repo_revision": "production", 17:46:42 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 17:46:42 INFO - "repository": "", 17:46:42 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 17:46:42 INFO - "buildid": "20160504170944", 17:46:42 INFO - "pgo_build": "False", 17:46:42 INFO - "basedir": "/builds/slave/test", 17:46:42 INFO - "buildnumber": 1475, 17:46:42 INFO - "slavename": "talos-linux64-ix-024", 17:46:42 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 17:46:42 INFO - "platform": "ubuntu64_hw", 17:46:42 INFO - "scheduler": "tests-fx-team-linux64-talos", 17:46:42 INFO - "branch": "fx-team", 17:46:42 INFO - "repo_path": "integration/fx-team", 17:46:42 INFO - "revision": "29662e28a9c93ac67ee0b8ddfb65a9f29bbf73f5", 17:46:42 INFO - "stage_platform": "linux64", 17:46:42 INFO - "builduid": "592364b9b0bb4f14a25b25ddb0f09f43", 17:46:42 INFO - "slavebuilddir": "test" 17:46:42 INFO - } 17:46:42 INFO - Found installer url https://queue.taskcluster.net/v1/task/e_pVfAbEQe6SS62pUUgchA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 17:46:42 INFO - Running post-action listener: _resource_record_post_action 17:46:42 INFO - ##### 17:46:42 INFO - ##### Running download-and-extract step. 17:46:42 INFO - ##### 17:46:42 INFO - Running pre-action listener: _resource_record_pre_action 17:46:42 INFO - Running main action method: download_and_extract 17:46:42 INFO - mkdir: /builds/slave/test/build/tests 17:46:42 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')]} 17:46:42 INFO - https://queue.taskcluster.net/v1/task/e_pVfAbEQe6SS62pUUgchA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 17:46:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e_pVfAbEQe6SS62pUUgchA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 17:46:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e_pVfAbEQe6SS62pUUgchA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 17:46:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e_pVfAbEQe6SS62pUUgchA/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 17:46:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e_pVfAbEQe6SS62pUUgchA/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 17:46:47 INFO - Downloaded 1361 bytes. 17:46:47 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 17:46:47 INFO - Using the following test package requirements: 17:46:47 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 17:46:47 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:46:47 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 17:46:47 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:46:47 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 17:46:47 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:46:47 INFO - u'jsshell-linux-x86_64.zip'], 17:46:47 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:46:47 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 17:46:47 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 17:46:47 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:46:47 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 17:46:47 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:46:47 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 17:46:47 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:46:47 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 17:46:47 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:46:47 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 17:46:47 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:46: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')]} 17:46:47 INFO - https://queue.taskcluster.net/v1/task/e_pVfAbEQe6SS62pUUgchA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:46:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e_pVfAbEQe6SS62pUUgchA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 17:46:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e_pVfAbEQe6SS62pUUgchA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 17:46:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e_pVfAbEQe6SS62pUUgchA/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 17:46:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e_pVfAbEQe6SS62pUUgchA/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 17:46:52 INFO - Downloaded 22307347 bytes. 17:46:52 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'] 17:46:52 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 17:46:53 INFO - Return code: 0 17:46:53 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 17:46: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')]} 17:46:53 INFO - https://queue.taskcluster.net/v1/task/e_pVfAbEQe6SS62pUUgchA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:46:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e_pVfAbEQe6SS62pUUgchA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 17:46:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e_pVfAbEQe6SS62pUUgchA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 17:46:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e_pVfAbEQe6SS62pUUgchA/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 17:46:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e_pVfAbEQe6SS62pUUgchA/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 17:46:54 INFO - Downloaded 22307347 bytes. 17:46:54 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'] 17:46:54 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 17:46:55 INFO - Return code: 0 17:46:55 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')]} 17:46:55 INFO - https://queue.taskcluster.net/v1/task/e_pVfAbEQe6SS62pUUgchA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 17:46:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e_pVfAbEQe6SS62pUUgchA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 17:46:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e_pVfAbEQe6SS62pUUgchA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 17:46:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e_pVfAbEQe6SS62pUUgchA/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 17:46:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e_pVfAbEQe6SS62pUUgchA/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 17:46:57 INFO - Downloaded 10840152 bytes. 17:46:57 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'] 17:46:57 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 17:46:58 INFO - Return code: 0 17:46:58 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')]} 17:46:58 INFO - https://queue.taskcluster.net/v1/task/e_pVfAbEQe6SS62pUUgchA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 17:46:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e_pVfAbEQe6SS62pUUgchA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 17:46:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e_pVfAbEQe6SS62pUUgchA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 17:46:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e_pVfAbEQe6SS62pUUgchA/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 17:46:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e_pVfAbEQe6SS62pUUgchA/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 17:46:59 INFO - Downloaded 54865164 bytes. 17:46:59 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/e_pVfAbEQe6SS62pUUgchA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 17:46:59 INFO - mkdir: /builds/slave/test/properties 17:46:59 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:46:59 INFO - Writing to file /builds/slave/test/properties/build_url 17:46:59 INFO - Contents: 17:46:59 INFO - build_url:https://queue.taskcluster.net/v1/task/e_pVfAbEQe6SS62pUUgchA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 17:47:00 INFO - Running post-action listener: _resource_record_post_action 17:47:00 INFO - Running post-action listener: set_extra_try_arguments 17:47:00 INFO - ##### 17:47:00 INFO - ##### Running populate-webroot step. 17:47:00 INFO - ##### 17:47:00 INFO - Running pre-action listener: _resource_record_pre_action 17:47:00 INFO - Running main action method: populate_webroot 17:47:00 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:47:00 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:47:00 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:47:00 INFO - '--tppagecycles', 17:47:00 INFO - '7'], 17:47:00 INFO - 'tests': ['tsvgm']}}, 17:47:00 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:47:00 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:47:00 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:47:00 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:47:00 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:47:00 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:47:00 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:47:00 INFO - 'talos_options': ['--disable-e10s'], 17:47:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:47:00 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:47:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:47:00 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:47:00 INFO - 'talos_options': ['--disable-e10s'], 17:47:00 INFO - 'tests': ['damp', 'tps']}, 17:47:00 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:47:00 INFO - 'tests': ['damp', 'tps']}, 17:47:00 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:47:00 INFO - 'tests': ['dromaeo_dom']}, 17:47:00 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:47:00 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:47:00 INFO - 'tests': ['a11yr', 17:47:00 INFO - 'ts_paint', 17:47:00 INFO - 'tpaint', 17:47:00 INFO - 'sessionrestore', 17:47:00 INFO - 'sessionrestore_no_auto_restore', 17:47:00 INFO - 'tabpaint']}, 17:47:00 INFO - 'other-e10s': {'tests': ['a11yr', 17:47:00 INFO - 'ts_paint', 17:47:00 INFO - 'tpaint', 17:47:00 INFO - 'sessionrestore', 17:47:00 INFO - 'sessionrestore_no_auto_restore', 17:47:00 INFO - 'tabpaint']}, 17:47:00 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:47:00 INFO - 'ts_paint', 17:47:00 INFO - 'tpaint', 17:47:00 INFO - 'sessionrestore', 17:47:00 INFO - 'sessionrestore_no_auto_restore', 17:47:00 INFO - 'tabpaint']}, 17:47:00 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:47:00 INFO - 'ts_paint', 17:47:00 INFO - 'tpaint', 17:47:00 INFO - 'sessionrestore', 17:47:00 INFO - 'sessionrestore_no_auto_restore', 17:47:00 INFO - 'tabpaint']}, 17:47:00 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:47:00 INFO - 'tests': ['a11yr', 17:47:00 INFO - 'ts_paint', 17:47:00 INFO - 'tpaint', 17:47:00 INFO - 'sessionrestore', 17:47:00 INFO - 'sessionrestore_no_auto_restore', 17:47:00 INFO - 'tabpaint']}, 17:47:00 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:47:00 INFO - 'tests': ['a11yr', 17:47:00 INFO - 'ts_paint', 17:47:00 INFO - 'tpaint', 17:47:00 INFO - 'sessionrestore', 17:47:00 INFO - 'sessionrestore_no_auto_restore', 17:47:00 INFO - 'tabpaint']}, 17:47:00 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:47:00 INFO - 'tests': ['tsvgx', 17:47:00 INFO - 'tsvgr_opacity', 17:47:00 INFO - 'tart', 17:47:00 INFO - 'tscrollx', 17:47:00 INFO - 'cart']}, 17:47:00 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:47:00 INFO - 'tsvgr_opacity', 17:47:00 INFO - 'tart', 17:47:00 INFO - 'tscrollx', 17:47:00 INFO - 'cart']}, 17:47:00 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:47:00 INFO - 'talos_options': ['--disable-e10s'], 17:47:00 INFO - 'tests': ['tp5o']}, 17:47:00 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:47:00 INFO - 'tests': ['tp5o']}, 17:47:00 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:47:00 INFO - 'talos_options': ['--disable-e10s', 17:47:00 INFO - '--xperf_path', 17:47:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:47:00 INFO - 'tests': ['tp5n']}, 17:47:00 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:47:00 INFO - 'talos_options': ['--xperf_path', 17:47:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:47:00 INFO - 'tests': ['tp5n']}}, 17:47:00 INFO - 'talos.zip': {'path': '', 17:47:00 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:47:00 INFO - Running post-action listener: _resource_record_post_action 17:47:00 INFO - ##### 17:47:00 INFO - ##### Running create-virtualenv step. 17:47:00 INFO - ##### 17:47:00 INFO - Running pre-action listener: _resource_record_pre_action 17:47:00 INFO - Running main action method: create_virtualenv 17:47:00 INFO - Creating virtualenv /builds/slave/test/build/venv 17:47:00 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 17:47:00 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:47:00 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:47:00 INFO - Using real prefix '/usr' 17:47:00 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:47:01 INFO - Installing distribute.............................................................................................................................................................................................done. 17:47:03 INFO - Installing pip.................done. 17:47:03 INFO - Return code: 0 17:47:03 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:47:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:47:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:47:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:47:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:47:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:47:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:47:03 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 0x7fb7cec99f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16878a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17525a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e1410>, '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 0x17e2310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17e27a0>, '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': '7cf709767345e0a0c5a90e72000001d4-1462408860.697390-566542548', '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 17:47:03 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 17:47:03 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 17:47:03 INFO - Using env: {'DISPLAY': ':0', 17:47:03 INFO - 'HOME': '/home/cltbld', 17:47:03 INFO - 'LANG': 'en_US.UTF-8', 17:47:03 INFO - 'LANGUAGE': 'en_US:en', 17:47:03 INFO - 'LOGNAME': 'cltbld', 17:47:03 INFO - 'MAIL': '/var/mail/cltbld', 17:47:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:47:03 INFO - 'MOZ_NO_REMOTE': '1', 17:47:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:47:03 INFO - 'NO_EM_RESTART': '1', 17:47:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:47:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:47:03 INFO - 'PWD': '/builds/slave/test', 17:47:03 INFO - 'SHELL': '/bin/bash', 17:47:03 INFO - 'SHLVL': '1', 17:47:03 INFO - 'TERM': 'linux', 17:47:03 INFO - 'TMOUT': '86400', 17:47:03 INFO - 'USER': 'cltbld', 17:47:03 INFO - 'XDG_SESSION_COOKIE': '7cf709767345e0a0c5a90e72000001d4-1462408860.697390-566542548', 17:47:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:47:03 INFO - '_': '/tools/buildbot/bin/python'} 17:47:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:47:03 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 17:47:03 INFO - Cleaning up... 17:47:03 INFO - Return code: 0 17:47:03 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 17:47:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:47:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:47:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:47:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:47:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:47:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:47:03 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 0x7fb7cec99f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16878a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17525a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e1410>, '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 0x17e2310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17e27a0>, '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': '7cf709767345e0a0c5a90e72000001d4-1462408860.697390-566542548', '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 17:47:03 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 17:47:03 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 17:47:03 INFO - Using env: {'DISPLAY': ':0', 17:47:03 INFO - 'HOME': '/home/cltbld', 17:47:03 INFO - 'LANG': 'en_US.UTF-8', 17:47:03 INFO - 'LANGUAGE': 'en_US:en', 17:47:03 INFO - 'LOGNAME': 'cltbld', 17:47:03 INFO - 'MAIL': '/var/mail/cltbld', 17:47:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:47:03 INFO - 'MOZ_NO_REMOTE': '1', 17:47:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:47:03 INFO - 'NO_EM_RESTART': '1', 17:47:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:47:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:47:03 INFO - 'PWD': '/builds/slave/test', 17:47:03 INFO - 'SHELL': '/bin/bash', 17:47:03 INFO - 'SHLVL': '1', 17:47:03 INFO - 'TERM': 'linux', 17:47:03 INFO - 'TMOUT': '86400', 17:47:03 INFO - 'USER': 'cltbld', 17:47:03 INFO - 'XDG_SESSION_COOKIE': '7cf709767345e0a0c5a90e72000001d4-1462408860.697390-566542548', 17:47:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:47:03 INFO - '_': '/tools/buildbot/bin/python'} 17:47:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:47:03 INFO - Downloading/unpacking psutil>=0.7.1 17:47:03 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 17:47:03 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 17:47:03 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 17:47:03 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 17:47:03 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 17:47:03 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 17:47:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:47:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:47:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:47:05 INFO - Installing collected packages: psutil 17:47:05 INFO - Running setup.py install for psutil 17:47:06 INFO - building 'psutil._psutil_linux' extension 17:47:06 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 17:47:06 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 17:47:06 INFO - building 'psutil._psutil_posix' extension 17:47:06 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 17:47:06 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 17:47:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:47:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:47:06 INFO - Successfully installed psutil 17:47:06 INFO - Cleaning up... 17:47:06 INFO - Return code: 0 17:47:06 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 17:47:06 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')]} 17:47:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:47:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:47:06 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')]} 17:47:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:47:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:47:06 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 0x7fb7cec99f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16878a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17525a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e1410>, '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 0x17e2310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17e27a0>, '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': '7cf709767345e0a0c5a90e72000001d4-1462408860.697390-566542548', '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 17:47:06 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 17:47:06 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 17:47:06 INFO - Using env: {'DISPLAY': ':0', 17:47:06 INFO - 'HOME': '/home/cltbld', 17:47:06 INFO - 'LANG': 'en_US.UTF-8', 17:47:06 INFO - 'LANGUAGE': 'en_US:en', 17:47:06 INFO - 'LOGNAME': 'cltbld', 17:47:06 INFO - 'MAIL': '/var/mail/cltbld', 17:47:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:47:06 INFO - 'MOZ_NO_REMOTE': '1', 17:47:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:47:06 INFO - 'NO_EM_RESTART': '1', 17:47:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:47:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:47:06 INFO - 'PWD': '/builds/slave/test', 17:47:06 INFO - 'SHELL': '/bin/bash', 17:47:06 INFO - 'SHLVL': '1', 17:47:06 INFO - 'TERM': 'linux', 17:47:06 INFO - 'TMOUT': '86400', 17:47:06 INFO - 'USER': 'cltbld', 17:47:06 INFO - 'XDG_SESSION_COOKIE': '7cf709767345e0a0c5a90e72000001d4-1462408860.697390-566542548', 17:47:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:47:06 INFO - '_': '/tools/buildbot/bin/python'} 17:47:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:47:06 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 17:47: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 17:47: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 17:47: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 17:47: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 17:47: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 17:47: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 17:47:09 INFO - Downloading mozsystemmonitor-0.0.tar.gz 17:47:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:47:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 17:47:09 INFO - Installing collected packages: mozsystemmonitor 17:47:09 INFO - Running setup.py install for mozsystemmonitor 17:47:09 INFO - Successfully installed mozsystemmonitor 17:47:09 INFO - Cleaning up... 17:47:09 INFO - Return code: 0 17:47:09 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:47:09 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')]} 17:47:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:47:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:47:09 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')]} 17:47:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:47:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:47:09 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 0x7fb7cec99f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16878a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17525a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e1410>, '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 0x17e2310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17e27a0>, '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': '7cf709767345e0a0c5a90e72000001d4-1462408860.697390-566542548', '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 17:47:09 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 17:47:09 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 17:47:09 INFO - Using env: {'DISPLAY': ':0', 17:47:09 INFO - 'HOME': '/home/cltbld', 17:47:09 INFO - 'LANG': 'en_US.UTF-8', 17:47:09 INFO - 'LANGUAGE': 'en_US:en', 17:47:09 INFO - 'LOGNAME': 'cltbld', 17:47:09 INFO - 'MAIL': '/var/mail/cltbld', 17:47:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:47:09 INFO - 'MOZ_NO_REMOTE': '1', 17:47:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:47:09 INFO - 'NO_EM_RESTART': '1', 17:47:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:47:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:47:09 INFO - 'PWD': '/builds/slave/test', 17:47:09 INFO - 'SHELL': '/bin/bash', 17:47:09 INFO - 'SHLVL': '1', 17:47:09 INFO - 'TERM': 'linux', 17:47:09 INFO - 'TMOUT': '86400', 17:47:09 INFO - 'USER': 'cltbld', 17:47:09 INFO - 'XDG_SESSION_COOKIE': '7cf709767345e0a0c5a90e72000001d4-1462408860.697390-566542548', 17:47:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:47:09 INFO - '_': '/tools/buildbot/bin/python'} 17:47:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:47:09 INFO - Downloading/unpacking blobuploader==1.2.4 17:47:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:47:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:47:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:47:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:47:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:47:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:47:11 INFO - Downloading blobuploader-1.2.4.tar.gz 17:47:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:47:11 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:47:11 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 17:47:11 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 17:47:11 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 17:47:11 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 17:47:11 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 17:47:11 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 17:47:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:47:12 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:47: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 17:47: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 17:47: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 17:47: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 17:47: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 17:47: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 17:47:12 INFO - Downloading docopt-0.6.1.tar.gz 17:47:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:47:12 INFO - Installing collected packages: blobuploader, requests, docopt 17:47:12 INFO - Running setup.py install for blobuploader 17:47:12 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:47:12 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:47:12 INFO - Running setup.py install for requests 17:47:12 INFO - Running setup.py install for docopt 17:47:13 INFO - Successfully installed blobuploader requests docopt 17:47:13 INFO - Cleaning up... 17:47:13 INFO - Return code: 0 17:47:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:47:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:47:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:47:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:47:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:47:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:47:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:47:13 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 0x7fb7cec99f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16878a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17525a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e1410>, '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 0x17e2310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17e27a0>, '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': '7cf709767345e0a0c5a90e72000001d4-1462408860.697390-566542548', '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 17:47:13 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 17:47:13 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 17:47:13 INFO - Using env: {'DISPLAY': ':0', 17:47:13 INFO - 'HOME': '/home/cltbld', 17:47:13 INFO - 'LANG': 'en_US.UTF-8', 17:47:13 INFO - 'LANGUAGE': 'en_US:en', 17:47:13 INFO - 'LOGNAME': 'cltbld', 17:47:13 INFO - 'MAIL': '/var/mail/cltbld', 17:47:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:47:13 INFO - 'MOZ_NO_REMOTE': '1', 17:47:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:47:13 INFO - 'NO_EM_RESTART': '1', 17:47:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:47:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:47:13 INFO - 'PWD': '/builds/slave/test', 17:47:13 INFO - 'SHELL': '/bin/bash', 17:47:13 INFO - 'SHLVL': '1', 17:47:13 INFO - 'TERM': 'linux', 17:47:13 INFO - 'TMOUT': '86400', 17:47:13 INFO - 'USER': 'cltbld', 17:47:13 INFO - 'XDG_SESSION_COOKIE': '7cf709767345e0a0c5a90e72000001d4-1462408860.697390-566542548', 17:47:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:47:13 INFO - '_': '/tools/buildbot/bin/python'} 17:47:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:47:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:47:13 INFO - Running setup.py (path:/tmp/pip-6wTLC2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:47:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:47:13 INFO - Running setup.py (path:/tmp/pip-35_XWy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:47:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:47:13 INFO - Running setup.py (path:/tmp/pip-Xz8iVg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:47:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:47:13 INFO - Running setup.py (path:/tmp/pip-zTR09U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:47:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:47:13 INFO - Running setup.py (path:/tmp/pip-qx4nO9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:47:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:47:13 INFO - Running setup.py (path:/tmp/pip-VnfG0Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:47:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:47:13 INFO - Running setup.py (path:/tmp/pip-UxO8JV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:47:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:47:13 INFO - Running setup.py (path:/tmp/pip-kI1ivf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:47:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:47:13 INFO - Running setup.py (path:/tmp/pip-mVQWjN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:47:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:47:13 INFO - Running setup.py (path:/tmp/pip-BHAHkm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:47:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:47:14 INFO - Running setup.py (path:/tmp/pip-X5EAEr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:47:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:47:14 INFO - Running setup.py (path:/tmp/pip-hkDE8y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:47:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:47:14 INFO - Running setup.py (path:/tmp/pip-IyQVjq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:47:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:47:14 INFO - Running setup.py (path:/tmp/pip-4lLBUI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:47:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:47:14 INFO - Running setup.py (path:/tmp/pip-RcFFlw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:47:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:47:14 INFO - Running setup.py (path:/tmp/pip-9sZiq5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:47:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:47:14 INFO - Running setup.py (path:/tmp/pip-8VB4yO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:47:14 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:47:14 INFO - Running setup.py install for manifestparser 17:47:14 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:47:14 INFO - Running setup.py install for mozcrash 17:47:14 INFO - Running setup.py install for mozdebug 17:47:14 INFO - Running setup.py install for mozdevice 17:47:14 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:47:14 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:47:14 INFO - Running setup.py install for mozfile 17:47:15 INFO - Running setup.py install for mozhttpd 17:47:15 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:47:15 INFO - Running setup.py install for mozinfo 17:47:15 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:47:15 INFO - Running setup.py install for mozInstall 17:47:15 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:47:15 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:47:15 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:47:15 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:47:15 INFO - Running setup.py install for mozleak 17:47:15 INFO - Running setup.py install for mozlog 17:47:15 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:47:15 INFO - Running setup.py install for moznetwork 17:47:15 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:47:15 INFO - Running setup.py install for mozprocess 17:47:15 INFO - Running setup.py install for mozprofile 17:47:15 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:47:15 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:47:15 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:47:15 INFO - Running setup.py install for mozrunner 17:47:16 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:47:16 INFO - Running setup.py install for mozscreenshot 17:47:16 INFO - Running setup.py install for moztest 17:47:16 INFO - Running setup.py install for mozversion 17:47:16 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:47:16 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:47:16 INFO - Cleaning up... 17:47:16 INFO - Return code: 0 17:47:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:47:16 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')]} 17:47:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:47:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:47:16 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')]} 17:47:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:47:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:47:16 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 0x7fb7cec99f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16878a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17525a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e1410>, '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 0x17e2310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17e27a0>, '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': '7cf709767345e0a0c5a90e72000001d4-1462408860.697390-566542548', '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 17:47:16 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 17:47:16 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 17:47:16 INFO - Using env: {'DISPLAY': ':0', 17:47:16 INFO - 'HOME': '/home/cltbld', 17:47:16 INFO - 'LANG': 'en_US.UTF-8', 17:47:16 INFO - 'LANGUAGE': 'en_US:en', 17:47:16 INFO - 'LOGNAME': 'cltbld', 17:47:16 INFO - 'MAIL': '/var/mail/cltbld', 17:47:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:47:16 INFO - 'MOZ_NO_REMOTE': '1', 17:47:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:47:16 INFO - 'NO_EM_RESTART': '1', 17:47:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:47:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:47:16 INFO - 'PWD': '/builds/slave/test', 17:47:16 INFO - 'SHELL': '/bin/bash', 17:47:16 INFO - 'SHLVL': '1', 17:47:16 INFO - 'TERM': 'linux', 17:47:16 INFO - 'TMOUT': '86400', 17:47:16 INFO - 'USER': 'cltbld', 17:47:16 INFO - 'XDG_SESSION_COOKIE': '7cf709767345e0a0c5a90e72000001d4-1462408860.697390-566542548', 17:47:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:47:16 INFO - '_': '/tools/buildbot/bin/python'} 17:47:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:47:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:47:16 INFO - Running setup.py (path:/tmp/pip-2KGih6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:47:16 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)) 17:47:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:47:16 INFO - Running setup.py (path:/tmp/pip-E59Tpp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:47:16 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)) 17:47:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:47:16 INFO - Running setup.py (path:/tmp/pip-N89ODp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:47:16 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)) 17:47:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:47:16 INFO - Running setup.py (path:/tmp/pip-fNx30V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:47:16 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)) 17:47:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:47:16 INFO - Running setup.py (path:/tmp/pip-y1IcEB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:47:16 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)) 17:47:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:47:16 INFO - Running setup.py (path:/tmp/pip-A_llrd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:47:16 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)) 17:47:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:47:16 INFO - Running setup.py (path:/tmp/pip-xdM6uC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:47:17 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)) 17:47:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:47:17 INFO - Running setup.py (path:/tmp/pip-9NGMhk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:47:17 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)) 17:47:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:47:17 INFO - Running setup.py (path:/tmp/pip-Ct4IYq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:47:17 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)) 17:47:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:47:17 INFO - Running setup.py (path:/tmp/pip-R9DT0L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:47:17 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)) 17:47:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:47:17 INFO - Running setup.py (path:/tmp/pip-OwjA01-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:47:17 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)) 17:47:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:47:17 INFO - Running setup.py (path:/tmp/pip-ccvB_D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:47:17 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)) 17:47:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:47:17 INFO - Running setup.py (path:/tmp/pip-Pimup6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:47:17 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)) 17:47:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:47:17 INFO - Running setup.py (path:/tmp/pip-wcS4BA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:47:17 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)) 17:47:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:47:17 INFO - Running setup.py (path:/tmp/pip-R3pxJx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:47:17 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)) 17:47:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:47:17 INFO - Running setup.py (path:/tmp/pip-MgLhOv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:47:17 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)) 17:47:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:47:17 INFO - Running setup.py (path:/tmp/pip-tRD1tz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:47:17 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)) 17:47:17 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)) 17:47:17 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)) 17:47:17 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)) 17:47:17 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)) 17:47:17 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)) 17:47:17 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:47: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 17:47: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 17:47: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 17:47: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 17:47: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 17:47: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 17:47:19 INFO - Downloading blessings-1.6.tar.gz 17:47:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:47:19 INFO - Installing collected packages: blessings 17:47:19 INFO - Running setup.py install for blessings 17:47:19 INFO - Successfully installed blessings 17:47:19 INFO - Cleaning up... 17:47:19 INFO - Return code: 0 17:47:19 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:47:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:47:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:47:20 INFO - Reading from file tmpfile_stdout 17:47:20 INFO - Current package versions: 17:47:20 INFO - argparse == 1.2.1 17:47:20 INFO - blessings == 1.6 17:47:20 INFO - blobuploader == 1.2.4 17:47:20 INFO - docopt == 0.6.1 17:47:20 INFO - manifestparser == 1.1 17:47:20 INFO - mozInstall == 1.12 17:47:20 INFO - mozcrash == 0.17 17:47:20 INFO - mozdebug == 0.1 17:47:20 INFO - mozdevice == 0.48 17:47:20 INFO - mozfile == 1.2 17:47:20 INFO - mozhttpd == 0.7 17:47:20 INFO - mozinfo == 0.9 17:47:20 INFO - mozleak == 0.1 17:47:20 INFO - mozlog == 3.1 17:47:20 INFO - moznetwork == 0.27 17:47:20 INFO - mozprocess == 0.22 17:47:20 INFO - mozprofile == 0.28 17:47:20 INFO - mozrunner == 6.11 17:47:20 INFO - mozscreenshot == 0.1 17:47:20 INFO - mozsystemmonitor == 0.0 17:47:20 INFO - moztest == 0.7 17:47:20 INFO - mozversion == 1.4 17:47:20 INFO - psutil == 3.1.1 17:47:20 INFO - requests == 1.2.3 17:47:20 INFO - wsgiref == 0.1.2 17:47:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:47:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:47:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:47:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:47:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:47:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:47:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:47:20 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 0x7fb7cec99f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16878a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17525a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e1410>, '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 0x17e2310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17e27a0>, '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': '7cf709767345e0a0c5a90e72000001d4-1462408860.697390-566542548', '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 17:47:20 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 17:47:20 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 17:47:20 INFO - Using env: {'DISPLAY': ':0', 17:47:20 INFO - 'HOME': '/home/cltbld', 17:47:20 INFO - 'LANG': 'en_US.UTF-8', 17:47:20 INFO - 'LANGUAGE': 'en_US:en', 17:47:20 INFO - 'LOGNAME': 'cltbld', 17:47:20 INFO - 'MAIL': '/var/mail/cltbld', 17:47:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:47:20 INFO - 'MOZ_NO_REMOTE': '1', 17:47:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:47:20 INFO - 'NO_EM_RESTART': '1', 17:47:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:47:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:47:20 INFO - 'PWD': '/builds/slave/test', 17:47:20 INFO - 'SHELL': '/bin/bash', 17:47:20 INFO - 'SHLVL': '1', 17:47:20 INFO - 'TERM': 'linux', 17:47:20 INFO - 'TMOUT': '86400', 17:47:20 INFO - 'USER': 'cltbld', 17:47:20 INFO - 'XDG_SESSION_COOKIE': '7cf709767345e0a0c5a90e72000001d4-1462408860.697390-566542548', 17:47:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:47:20 INFO - '_': '/tools/buildbot/bin/python'} 17:47:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:47:20 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)) 17:47:20 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)) 17:47:20 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)) 17:47:20 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)) 17:47:20 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)) 17:47:20 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)) 17:47:20 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)) 17:47:20 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)) 17:47:20 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)) 17:47:20 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)) 17:47:20 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)) 17:47:20 INFO - Cleaning up... 17:47:20 INFO - Return code: 0 17:47:20 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:47:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:47:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:47:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:47:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:47:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:47:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:47:20 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 0x7fb7cec99f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16878a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17525a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e1410>, '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 0x17e2310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17e27a0>, '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': '7cf709767345e0a0c5a90e72000001d4-1462408860.697390-566542548', '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 17:47:20 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 17:47:20 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 17:47:20 INFO - Using env: {'DISPLAY': ':0', 17:47:20 INFO - 'HOME': '/home/cltbld', 17:47:20 INFO - 'LANG': 'en_US.UTF-8', 17:47:20 INFO - 'LANGUAGE': 'en_US:en', 17:47:20 INFO - 'LOGNAME': 'cltbld', 17:47:20 INFO - 'MAIL': '/var/mail/cltbld', 17:47:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:47:20 INFO - 'MOZ_NO_REMOTE': '1', 17:47:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:47:20 INFO - 'NO_EM_RESTART': '1', 17:47:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:47:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:47:20 INFO - 'PWD': '/builds/slave/test', 17:47:20 INFO - 'SHELL': '/bin/bash', 17:47:20 INFO - 'SHLVL': '1', 17:47:20 INFO - 'TERM': 'linux', 17:47:20 INFO - 'TMOUT': '86400', 17:47:20 INFO - 'USER': 'cltbld', 17:47:20 INFO - 'XDG_SESSION_COOKIE': '7cf709767345e0a0c5a90e72000001d4-1462408860.697390-566542548', 17:47:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:47:20 INFO - '_': '/tools/buildbot/bin/python'} 17:47:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:47:20 INFO - Downloading/unpacking jsonschema 17:47: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 17:47: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 17:47: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 17:47: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 17:47: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 17:47: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 17:47:22 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:47:22 INFO - Downloading/unpacking functools32 (from jsonschema) 17:47:22 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 17:47:22 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 17:47:22 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 17:47:22 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 17:47:22 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 17:47:22 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 17:47:22 INFO - Downloading functools32-3.2.3-2.tar.gz 17:47:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:47:22 INFO - warning: no files found matching '*.txt' 17:47:22 INFO - no previously-included directories found matching 'build' 17:47:22 INFO - no previously-included directories found matching 'dist' 17:47:22 INFO - no previously-included directories found matching '.git*' 17:47:22 INFO - Installing collected packages: jsonschema, functools32 17:47:22 INFO - Running setup.py install for functools32 17:47:23 INFO - warning: no files found matching '*.txt' 17:47:23 INFO - no previously-included directories found matching 'build' 17:47:23 INFO - no previously-included directories found matching 'dist' 17:47:23 INFO - no previously-included directories found matching '.git*' 17:47:23 INFO - Successfully installed jsonschema functools32 17:47:23 INFO - Cleaning up... 17:47:23 INFO - Return code: 0 17:47:23 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 17:47:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:47:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:47:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:47:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:47:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:47:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:47:23 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 0x7fb7cec99f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16878a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17525a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e1410>, '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 0x17e2310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17e27a0>, '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': '7cf709767345e0a0c5a90e72000001d4-1462408860.697390-566542548', '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 17:47:23 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 17:47:23 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 17:47:23 INFO - Using env: {'DISPLAY': ':0', 17:47:23 INFO - 'HOME': '/home/cltbld', 17:47:23 INFO - 'LANG': 'en_US.UTF-8', 17:47:23 INFO - 'LANGUAGE': 'en_US:en', 17:47:23 INFO - 'LOGNAME': 'cltbld', 17:47:23 INFO - 'MAIL': '/var/mail/cltbld', 17:47:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:47:23 INFO - 'MOZ_NO_REMOTE': '1', 17:47:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:47:23 INFO - 'NO_EM_RESTART': '1', 17:47:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:47:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:47:23 INFO - 'PWD': '/builds/slave/test', 17:47:23 INFO - 'SHELL': '/bin/bash', 17:47:23 INFO - 'SHLVL': '1', 17:47:23 INFO - 'TERM': 'linux', 17:47:23 INFO - 'TMOUT': '86400', 17:47:23 INFO - 'USER': 'cltbld', 17:47:23 INFO - 'XDG_SESSION_COOKIE': '7cf709767345e0a0c5a90e72000001d4-1462408860.697390-566542548', 17:47:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:47:23 INFO - '_': '/tools/buildbot/bin/python'} 17:47:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:47:23 INFO - Downloading/unpacking flake8 17:47:23 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 17:47:23 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 17:47:23 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 17:47:23 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 17:47:23 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 17:47:23 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 17:47:25 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 17:47:25 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 17:47:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:47:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:47:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:47:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:47:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:47:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:47:25 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 17:47:25 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 17:47:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:47:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:47:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:47:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:47:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:47:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:47:25 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 17:47:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:47:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:47:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:47:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:47:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:47:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:47:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 17:47:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:47:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:47:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:47:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:47:25 INFO - no previously-included directories found matching 'docs/_build' 17:47:25 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 17:47:25 INFO - Running setup.py install for pep8 17:47:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:47:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:47:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:47:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:47:26 INFO - no previously-included directories found matching 'docs/_build' 17:47:26 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 17:47:26 INFO - Successfully installed flake8 mccabe pyflakes pep8 17:47:26 INFO - Cleaning up... 17:47:26 INFO - Return code: 0 17:47:26 INFO - Running post-action listener: _resource_record_post_action 17:47:26 INFO - Running post-action listener: _start_resource_monitoring 17:47:26 INFO - Starting resource monitoring. 17:47:26 INFO - ##### 17:47:26 INFO - ##### Running install step. 17:47:26 INFO - ##### 17:47:26 INFO - Running pre-action listener: _resource_record_pre_action 17:47:26 INFO - Running main action method: install 17:47:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:47:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:47:26 INFO - Reading from file tmpfile_stdout 17:47:26 INFO - Detecting whether we're running mozinstall >=1.0... 17:47:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:47:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:47:26 INFO - Reading from file tmpfile_stdout 17:47:26 INFO - Output received: 17:47:26 INFO - Usage: mozinstall [options] installer 17:47:26 INFO - Options: 17:47:26 INFO - -h, --help show this help message and exit 17:47:26 INFO - -d DEST, --destination=DEST 17:47:26 INFO - Directory to install application into. [default: 17:47:26 INFO - "/builds/slave/test"] 17:47:26 INFO - --app=APP Application being installed. [default: firefox] 17:47:26 INFO - mkdir: /builds/slave/test/build/application 17:47:26 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'] 17:47:26 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 17:47:42 INFO - Reading from file tmpfile_stdout 17:47:42 INFO - Output received: 17:47:42 INFO - /builds/slave/test/build/application/firefox/firefox 17:47:42 INFO - Running post-action listener: _resource_record_post_action 17:47:42 INFO - ##### 17:47:42 INFO - ##### Running run-tests step. 17:47:42 INFO - ##### 17:47:42 INFO - Running pre-action listener: _resource_record_pre_action 17:47:42 INFO - Running main action method: run_tests 17:47:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:47:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:47:42 INFO - Python 2.7.3 17:47:42 INFO - Return code: 0 17:47:42 INFO - grabbing minidump binary from tooltool 17:47:42 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')]} 17:47:42 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 0x17e1410>, '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 0x17e2310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17e27a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:47:42 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 17:47:42 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 17:47:42 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:47:42 INFO - Return code: 0 17:47:42 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:47:42 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:47:42 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:47:42 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:47:42 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:47:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 17:47:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 17:47:43 INFO - Return code: 0 17:47:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/e_pVfAbEQe6SS62pUUgchA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-024', '--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 17:47:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/e_pVfAbEQe6SS62pUUgchA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-024 --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 17:47:43 INFO - Using env: {'DISPLAY': ':0', 17:47:43 INFO - 'HOME': '/home/cltbld', 17:47:43 INFO - 'LANG': 'en_US.UTF-8', 17:47:43 INFO - 'LANGUAGE': 'en_US:en', 17:47:43 INFO - 'LOGNAME': 'cltbld', 17:47:43 INFO - 'MAIL': '/var/mail/cltbld', 17:47:43 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:47:43 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:47:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:47:43 INFO - 'MOZ_NO_REMOTE': '1', 17:47:43 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:47:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:47:43 INFO - 'NO_EM_RESTART': '1', 17:47:43 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:47:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:47:43 INFO - 'PWD': '/builds/slave/test', 17:47:43 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:47:43 INFO - 'SHELL': '/bin/bash', 17:47:43 INFO - 'SHLVL': '1', 17:47:43 INFO - 'TERM': 'linux', 17:47:43 INFO - 'TMOUT': '86400', 17:47:43 INFO - 'USER': 'cltbld', 17:47:43 INFO - 'XDG_SESSION_COOKIE': '7cf709767345e0a0c5a90e72000001d4-1462408860.697390-566542548', 17:47:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:47:43 INFO - '_': '/tools/buildbot/bin/python'} 17:47:43 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/e_pVfAbEQe6SS62pUUgchA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-024', '--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 17:47:43 INFO - mozversion application_buildid: 20160504170944 17:47:43 INFO - mozversion application_changeset: 29662e28a9c93ac67ee0b8ddfb65a9f29bbf73f5 17:47:43 INFO - mozversion application_display_name: Nightly 17:47:43 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:47:43 INFO - mozversion application_name: Firefox 17:47:43 INFO - mozversion application_remotingname: firefox 17:47:43 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 17:47:43 INFO - mozversion application_vendor: Mozilla 17:47:43 INFO - mozversion application_version: 49.0a1 17:47:43 INFO - mozversion platform_buildid: 20160504170944 17:47:43 INFO - mozversion platform_changeset: 29662e28a9c93ac67ee0b8ddfb65a9f29bbf73f5 17:47:43 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 17:47:43 INFO - mozversion platform_version: 49.0a1 17:47:43 INFO - using testdate: 1462409263 17:47:43 INFO - actual date: 1462409263 17:47:43 INFO - starting webserver on 'localhost:45001' 17:47:43 INFO - SUITE-START | Running 2 tests 17:47:43 INFO - TEST-START | dromaeo_css 17:47:43 INFO - operating with platform_type : linux_ 17:47:43 INFO - Initialising browser for dromaeo_css test... 17:47:43 INFO - TEST-INFO | started process 24057 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfAjCUM/profile http://localhost:45001/getInfo.html) 17:47:47 INFO - PROCESS | 24057 | 17:47:47 INFO - PROCESS | 24057 | (process:24126): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:47:48 INFO - PROCESS | 24057 | __metrics Screen width/height:1600/1200 17:47:48 INFO - PROCESS | 24057 | colorDepth:24 17:47:48 INFO - PROCESS | 24057 | Browser inner width/height: 1024/697 17:47:48 INFO - PROCESS | 24057 | __metrics 17:47:48 ERROR - PROCESS | 24057 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 17:47:49 INFO - TEST-INFO | 24057: exit 0 17:47:49 INFO - Browser initialized. 17:47:49 INFO - Running cycle 1/1 for dromaeo_css test... 17:47:49 INFO - TEST-INFO | started process 24177 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfAjCUM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:47:51 INFO - PROCESS | 24177 | 17:47:51 INFO - PROCESS | 24177 | (process:24237): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:48:01 INFO - PROCESS | 24177 | RSS: Main: 165842944 17:48:01 INFO - PROCESS | 24177 | 17:48:51 INFO - PROCESS | 24177 | 1462409331039 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] 17:51:02 INFO - PROCESS | 24177 | Cycle 1(1): loaded http://localhost:45001/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45001/tests/dromaeo/cssquery-ext.html) 17:51:03 INFO - PROCESS | 24177 | RSS: Main: 170033152 17:51:03 INFO - PROCESS | 24177 | 17:54:05 INFO - PROCESS | 24177 | Cycle 1(1): loaded http://localhost:45001/tests/dromaeo/cssquery-ext.html (next: http://localhost:45001/tests/dromaeo/cssquery-jquery.html) 17:54:06 INFO - PROCESS | 24177 | RSS: Main: 167587840 17:54:06 INFO - PROCESS | 24177 | 17:57:08 INFO - PROCESS | 24177 | Cycle 1(1): loaded http://localhost:45001/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45001/tests/dromaeo/cssquery-mootools.html) 17:57:08 INFO - PROCESS | 24177 | RSS: Main: 168534016 17:57:08 INFO - PROCESS | 24177 | 18:00:10 INFO - PROCESS | 24177 | Cycle 1(1): loaded http://localhost:45001/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45001/tests/dromaeo/cssquery-prototype.html) 18:00:11 INFO - PROCESS | 24177 | RSS: Main: 166313984 18:00:11 INFO - PROCESS | 24177 | 18:03:13 INFO - PROCESS | 24177 | Cycle 1(1): loaded http://localhost:45001/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45001/tests/dromaeo/cssquery-yui.html) 18:03:14 INFO - PROCESS | 24177 | RSS: Main: 167813120 18:03:14 INFO - PROCESS | 24177 | 18:06:16 INFO - PROCESS | 24177 | Cycle 1(1): loaded http://localhost:45001/tests/dromaeo/cssquery-yui.html (next: http://localhost:45001/tests/dromaeo/cssquery-dojo.html) 18:06:17 INFO - PROCESS | 24177 | RSS: Main: 169971712 18:06:17 INFO - PROCESS | 24177 | 18:06:17 INFO - PROCESS | 24177 | __start_tp_report 18:06:17 INFO - PROCESS | 24177 | _x_x_mozilla_page_load 18:06:17 INFO - PROCESS | 24177 | _x_x_mozilla_page_load_details 18:06:17 INFO - PROCESS | 24177 | |i|pagename|runs| 18:06:17 INFO - PROCESS | 24177 | |0;dojo.html;2595.441979974306;2653.5488966875637;2665.880035398407;2704.7430494103055;2707.472042951624;4673.042026384592;4678.391809064825;4730.9053818923685;4738.881527961803;4767.284907263907;4694.084653492562;4784.234522476405;4786.904261914759;4841.685290456118;4903.705777653343;4355.803988820503;4446.419743222252;4504.572065653758;4510.819567217307;4541.909161816761;404.8802798132385;4309.590588894066;4380.058287468194;4385.736855788647;4446.933296000562;4439.977800110995;4440.933385999213;4445.155420470101;4459.843905463309;4468.4637843458995;4409.691321607489;4447.799849006802;4450.421445212101;4466.397036400077;4491.438570178728;4328.76630160406;4386.7367957922625;4441.800118994621;4467.620252278528;4481.887952801173;4545.0000999779995;4557.0885822835235;4573.085382923428;4582.060677561125;4583.931241031387;4920.138975679241;5050.39395272566;5066.873328166788;5079.076640440924;5104.234364845266;5064.696118232918;5099.260607211933;5116.462771409023;5130.07658621448;5191.454897235812;4739.763011849428;4782.521747825224;4787.61699064074;4814.15752243363;4825.372701548847;5215.6609820361555;5251.4485978972425;5271.604629652791;5333.546648534841;5342.9465705342445;4955.578775804025;4982.277569752366;4999.200127979506;5001.799928002839;5042.621803364762;5047.495250474996;5110.105731496973;5119.97440012805;5122.743862806919;5125.564327032244;4938.9012219755405;5024.49755024502;5125.154349532286;5202.323697919322;5229.607779416559;5022.296878437021;5045.621578381636;5076.314697515862;5079.08576456234;5152.562032227228;4294.291441912112;4304.3543468479975;4326.15639950213;4341.413909122291;4352.042550638855;3679.1354031802507;3763.717721170923;3803.676687481595;3804.391297392404;3865.6520913117956;4278.336857787048;4387.736735795863;4405.647548196137;4406.405135306757;4410.272305069628;5143.434222235551;5148.073346797612;5160.277561141444;5161.974190129101;5164.173732202829;4311.137772445523;4360.934585981213;4396.186705459436;4420.336949457607;4445.333200020023;4585.426821647294;4596.724196548218;4602.033572949718;4607.424071991001;4638.234691275901;4760.571548560646;4764.547368000034;4776.474587795409;4779.808807647794;4826.61387089025;5043.87390315245;5083.796648134034;5128.564072053917;5163.483651634807;5185.637005409585;4723.535703931792;4742.193827049341;4758.976205118952;4762.476127625889;4811.158047341772;4869.269609558594;4982.850514484571;4983.27742477346;4988.55103040728;5035.773390197523;5125.513076257749;5149.768260428365;5192.896142077213;5206.453322401093;5225.980933717889;5027.949720502895;5050.047533958096;5051.823186188466;5053.8736531587;5104.1578139606545;4870.634702397264;4948.109340318633;5041.773120209673;5049.141645920276;5056.84829455117;4923.08922849274;4931.3096166536;4961.727105009115;4993.101241776515;5027.974860125676;5054.519820617035;5070.771815268248;5087.821926232564;5107.693538387709;5116.181410974226;4587.678862479728;4931.753412329297;4962.801487940586;4979.891763070412;5023.572996295356 18:06:17 INFO - PROCESS | 24177 | |1;ext.html;571.2031715756519;617.2377114263884;629.2386212682653;634.9523785716071;635.9682015899203;36231.63768362316;37232.627673723255;37441.62558374416;37480.25039499209;37781.59965603095;37202.255954880886;37798.62201377985;37810.24379512408;37898.24203515928;38074.619253807454;7617.428692848045;7755.418343624223;7779.2998630123275;7796.883046754303;7802.648880800378;7669.6165191740465;7952.3638108951145;7955.72154974576;7965.362770978308;8003.5197888126895;7805.921940780577;7811.140774514799;7823.2176782321885;7830.647620857047;7831.490953088031;7856.450048496637;7889.250521200477;7900.64447099879;7903.525788452711;7921.881171782428;7791.337736292422;7844;7890.48711833729;7903.091144518339;7911.615467293201;27881;39508;40009.39985900214;40028.799856000536;40162.79918600388;3086.706762857525;3135.04381163745;3184.8407579621157;3235.8705651773903;3281.6390197078304;28417.289567760763;28521.714782852112;28693.28266793326;28787.56818647722;29001.694923728483;3353.3293341331832;3386.9039054088194;3419.692227699494;3459.7405194610255;3466.2374277658873;202719;208015;208305;208337;260473.9999999981;32430.83784581062;62367.6881615589;63811.72376552443;63903.36096639067;63922;35366;35378.469322960176;35727.285454290766;35736;35844;14057.22685252321;14363;14398.496052638317;14416.495422660366;14419.927900360432;11039.944800275947;11076.058535024613;11084;11086.667399978014;11150.553977840795;8416.326693864476;8494.258676971205;8526.40315177944;8535.103814099555;8643.135686431306;3304.3391321735267;3346.2972775716885;3406.829658517064;3452.102453362144;3475.6871881530783;888.8888888888889;958.8849338079475;996.3374356053289;1000.2698030437821;1042.6142327338932;29695.703042969726;29957.700422995928;30231.093067208018;30505.542416863766;30529.69470305313;1027.799579082072;1056.334509259162;1057.8519007338978;1108.7172770943357;1118.6364431559775;15618.9219053904;15954.601134971486;16019.519414417586;16149;16183;344373;345766;348311;351143;352010;53083.469165307855;53652;53786.193207101926;53866;54063.72968135213;1276.0557187681234;1276.8148618450273;1287.8454585449806;1288.3365066990507;1390.506370238571;27650.723492764813;29075;29318;29501.409971800873;29786.851065744533;43057.354139688556;44892.55107448884;44969.775151124035;45003.549964499936;45016;319428;321853;322114;323133;323839;41344.79327603343;41940.580594194886;42141.57858421376;42269.78865105655;42447.3632895513;45973.68787138038;46427;46446.767766160956;46819.29771053505;47034.76482617565;37885.81057094697;38873;39197.804010979766;39267.41098883576;39320.2135957285;37747;38323.61676383312;39193.41209881911;39366.606333936295;39591.208175836895;29492.705072949855;34526.48210276798;35463;35532.46701299431;39025.219495610494;28898.85550572234;30846.69153308438;31254.218644533157;31331.84334078315;31429.21426964253;25339.29014643832;25752.81101106427;25785;26135.869320653273;26598.335041624116 18:06:17 INFO - PROCESS | 24177 | |2;jquery.html;381.79955523350236;382.38627003659127;382.5676985006942;383.30047663014994;388.2313020219966;16033;16437;17353.7396939046;17355.132243387812;17361.131943402812;11303.321800691965;16176.19119044046;17040.573985650364;17069.231884565193;17096.751617192724;3540.4689296605457;4714.929276060853;4874.268859671042;4874.731889746063;4877.70733755974;5246.1606143017125;5583.972080139614;5586.469285417899;5589.74846131925;5601.691906945116;5336.199570064483;5543.972280138593;5545.916811247835;5557.3331200256025;5561.5828812839;5523.834284971457;5542.75057622408;5543;5547.11246200608;5569;5169.508896654812;5401.081816091274;5403.972980135074;5441.129419292934;5442.183672449125;12718.872811271862;12814.743705125939;12833.550825721055;12836.679083022906;16892;1792.5339411753039;1910.3695780392577;1980.9504762380911;2007.1971211515365;2075.3773867839586;9344.205742511895;9701.51492425376;9899.802003959952;10941.96051375118;13639.113457625223;1598.352667169798;1749.2303386509896;1800.297883825309;1975.3185151122984;2016.8588198825942;61715.69142154305;64594.354056459306;64652;65262;70772;9798.334283171878;10142.492875356204;10251.179905607534;10429.843552346721;10601.41692206936;14496.85503144976;14614;14650.340734666966;14655.413783448756;14663.046901951338;7457.515261507984;7680.039995000625;7740.651670674833;7749.4575379724;7833.686652533949;7123.109611298588;7173.856522869618;7350.70597176107;7380.077490313711;7431.665575049135;4043.8584649537715;4367.978160109179;4500.662450316239;4517.661175411791;4595.609373203249;1831.4688740265174;1894.7915729269769;1901.7337572739827;1909.465349702058;1917.9616407671767;563.5322682173786;858.0304256190465;892.2549671024638;927.4018258223408;937.386012162035;16741.414050508174;16859.662806743796;17338.479845604652;17516.737248941277;17521.82478175202;903.8373092843351;924.8150369926042;945.8675785390051;948.4729585367553;950.7005293332578;9744.269179811543;9770.169535589412;9943.900560994442;9985.650502232387;10024.097831195228;367611;370799;374285;374557;375412;46499.30251046237;60120.69939650361;74967;78163.60918195486;79326.20673793188;964.1611797736015;965.5220665770488;976.6728146071003;979.9216062714823;993.8807343118872;15245.466408675644;15429.691406172038;15517.301721422336;15606.609834754221;15775.974561653456;33561.49657755184;33753;33830;35608.28783424265;35616.643833561335;47717.761411192725;48371.27443088286;48420.273695893884;48666.5133348662;48940.265896010875;7533.773986780406;7748.418868584991;7778.299953004257;7885.3297469713425;8034.035915690155;5897.144913987534;8557.673560598118;8750.956245218733;10420;11759.235649682743;9962.452065136196;10106.343087699275;10368.533415996148;10445.268831181744;10747.140228781522;10244.231682623684;10254.333468324536;10362.481875906326;10508.684739457829;10547.472626368804;10468.895311046792;10578;10597.4701264938;10733.570657173626;10885.346879187275;7821.491603045783;7876.803079923047;8000.15998320168;8012.399070069885;8083.232092951161;8056.073551541648;10320.948395257976;10520.210984176065;10607.893921060999;10811.13510919109 18:06:17 INFO - PROCESS | 24177 | |3;mootools.html;1482.7998220240268;1533.8926275160738;1686.4940517844643;1823.2251293200402;1841.9723704144433;6689.431398331148;7430.108386993555;7464.925350746491;7718.459707820455;7723.111842138149;7523.398128149748;7578.128515220751;7581;7614.428917831157;7616.6191690415535;2138.0806253311107;2186.6501359782437;2198.351486311534;2201.2515744646817;2206.6689996500572;2035.623409669216;2048.3752455501067;2089.8014688604558;2093.8010888965523;2094.780048094943;2180.80372766451;2186.278528085736;2203.680466332381;2207.2164381644525;2216.091402524965;2165.317924853666;2168.3278183763005;2169.208238992764;2169.3275084723628;2172.7718589548026;2145.957080858374;2154.192177933275;2173.0438607012866;2186.5408264264524;2193.42970827586;7693.5383876967;7705;7707.6916923323;7722.343600793939;7726.420518461082;4564.612007979325;4707.105649926503;4743.715377077387;4746.240601503743;4748.715077095385;2739;2800;2831.8584070796583;2873.310405502685;2886.07645553423;915.2815040193483;925.2051021019201;930.8138372325494;937.6999360204737;947.9763005924838;10543.78912421755;10572;10615.57537698491;10623.84064239037;10633.415162166155;4180;4282.443282373271;4324.67564932625;4372.213001659668;4377.868663940087;8043.39674524413;8054.758357249292;8094.109647938722;8104;8133;4544;4550.931736023962;4573.49691533931;4582.175208462442;4593.701409408378;3786.1481166737813;4147.087640719037;4237.660987121085;4271.722338048017;4312.849050283225;3347.7489188310974;3412.4028295048265;3453.1194545390763;3485.5643044619424;3502.2470168913296;1037.2635428845454;1040.7554224757175;1043.6190790361616;1045.0751085289573;1076.2251179150999;800.1158719614858;833.3541505333416;870.2863651805459;888.2804928008334;891.5497673674753;5083.61872859537;5112.872178195575;5224.03355379256;5224.895502089937;5234.528892399702;419.67684882640197;419.88453175377015;426.8314015963677;430.5457742082071;435.27309393313243;3538.7699799512948;3626.637336266352;3645.234500754871;3649.7262705297208;3675.852965881388;9279.62881484733;9706.90293097074;9764.365316254421;9773.21814254858;9834.704958851245;9525;9670.613175473043;9672;9674.419534827934;9689.854652180224;6819.659017049227;7038.085048943707;7039.049728286615;7040.401565866959;7102.112235970504;5141.38303403594;5162.561182299547;5219.399769026459;5469.535089517276;5474.616776825584;8796.824063518821;8854.822903542023;8881.200691937498;8976.685815996409;9065.637374504946;8904.753145646762;9052;9064.365494415328;9129.5891684873;9137.725868223964;5935.554833387427;6417.39034791694;6515.413612774873;6635.966820166062;6637.933620663732;7500.699972001059;7509.474336796372;7545.283198096172;7600.695972161052;7634.389248859967;6785.694643740945;6911.827204319932;6969.58182509051;7010.298970103153;7042;6553.5084868635995;6568.211814582281;6720.865582688221;6785.5250132490255;6803.93196068033;6289.213848268966;6312.337204593451;6392.264889537577;6392.744290228339;6419.518536109904;4348.63036641889;4403.735775853459;4454.621357184676;4496.7301961882395;4540.704854184468;4499.077689073797;4566.429196350457;4582.358469814162;4613.331066995334;4616 18:06:17 INFO - PROCESS | 24177 | |4;prototype.html;312.82012842615495;318.42683170293463;319.3772144318579;319.57656105660004;320.0781748564136;4892.437369702485;4937.061958227934;4961.727105009223;4974.925376119361;4987.326710894033;4858.46556878743;4872.439669438016;4886.462489126193;4886.462489126202;4889.291052797343;3656.6160553141935;3812.866549670762;3898.4152377143373;3909.335412979786;3935.4490371348033;3911.823967921436;3925.568187499373;3927.803609819512;3941.708673257833;3953.960460395402;3911.6675082618012;3912.8826135215845;3913.256481268564;3919.9608003920025;3920.764754114762;3821.73247872649;3866.0283255539734;3882.2429626222897;3901.1417488152847;3916.3929590913453;3399.7280217582534;3403.6596340366013;3415.863365465403;3421.4867769834477;3426.8971930842113;4706.623470122417;4710.505396933307;4716.198246298138;4731.33761273422;4734.26618874075;4361.847335343247;4377.956220437787;4391.824327026915;4396.802143903532;4404.317330813697;4803.2554953981835;5147.433782283983;5157.252198431206;5169.974150129263;5177.430482646906;3624.912526242143;3626.2747450510005;3633.9273214535824;3659.6340365963456;3668.3763760160837;5394.676319420847;5407.134858422633;5415.187721841755;5446.291982042309;5463.710986875284;3658.725595580342;3659.2681463707363;3714.5542534895985;3723.6648701616987;3743.7271327748695;3707.8146092695256;3764.7176461765475;3767.7362584618813;3784.3188226119564;3791.2038471920655;4324.329728892027;4333.71830830995;4340.374073685438;4352.804123814436;4353.73877567347;4979.57673597741;5137.922931155961;5190.169572868323;5209.817656382009;5212.374515058217;1373.5535950816025;1385.6535866033491;1386.6117487103627;1391.304347826087;1391.8329800424015;863.9136086391311;903.7153296711647;925.5372313843078;953.9840070325082;954.1126752120595;4454.866354009385;4558.954410455853;4572.7713614319155;4585.495595484494;4590.862274131781;5344.75948582307;5392;5397.892042159214;5406.8918621627345;5419.99730049942;4410.16206920684;4537.705049171794;4599.9080018399445;4600.171969045604;4622.329762184464;3025.6520500142765;3042.969570304313;3061.8775248990237;3071.754259659222;3079.6920307969026;5375.919361209585;5382.865428364322;5385.5960802939935;5415.810446634349;5425.023495770799;5680.204771332017;5875.6474611523445;5880.7356418370255;5897.469227769521;5899.970500147558;5340.572754179656;5362.463753624606;5384.165454354503;5385.711072794047;5405.756740946746;5688.5733569981585;5772.451617096369;5781.364049954585;5783.306003279633;5794.420557944172;5433.429489903503;5613.298337707786;5624.184493248538;5632.802851900327;5644.971775141098;5360.571154307568;5366.470555891552;5387.111126664056;5399.136138217867;5406.405295417422;3884.7863367515056;3892.455056292065;3892.8832135035996;3900.707446941434;3903.277893589695;5102.183650615883;5394.32570928634;5394.406615272238;5399.865003374947;5402.514308565176;5235.188545775411;5239.790408383775;5240.659357141773;5259.710715910662;5264.025825408632;5107.540321371094;5153.484651534816;5179.274901513866;5179.766910488962;5242.370915490165;5060.975609756127;5067.189249720027;5087.542121209109;5118.641695081457;5133.281340612242;4983.25251212321;5066.771995260296;5209.739513024258;5217.217417387422;5226.973865130803;5120.359955005624;5137.51193636604;5147.202183661539;5151.6908985459495;5156.819511317086 18:06:17 INFO - PROCESS | 24177 | |5;yui.html;772.7295446593693;812.9634166462511;813;817.4523069543405;821.9342452603793;13815.37830797614;14203.076800007992;14307.78538321926;14366.066205696648;14377.784333234997;13374.531891383804;13436.731265374687;13467.393967271471;13540.39068241929;13606.659833504167;696.5333226738097;870.8040690844557;879.5030807593721;881.0528681667201;883.6642076011107;859.5530324231396;867.2541614211773;873.3231745397336;874.1258741258741;878.2490970220465;912.1152482092393;912.803747194353;914.7575892388522;916.9587368568397;921.8617207418873;904.9592768325408;907.3603109807569;913.9451632902047;916.8212198621271;927.4667066436825;666.8932970724661;668.6690088406222;670.2359310386164;674.1505702814441;675.9763408280736;13076.738465230737;13174.143680660822;13195.340232988312;13218.140820846615;13228.801567976489;12064.457099430547;12201.45093470796;12279.079069069767;12631.115821892472;12642.051846111579;10050.748731281703;10105.797884042351;10203.948980255125;10244.487775611264;10402.791944161074;3313.204830840605;3400.472926696366;3402.1664692150334;3431.9656803431894;3472.8437220325145;44330.33504497435;44696.3295550567;44755.77622111901;44766.776166119285;45149;9396;9508.381955172892;9616.75958101053;9620.182284505756;9766.9023309766;17443.73834392485;17462.301507939796;17477.38829140974;17478;17510.29958801659;6997.825054373681;7001.299870012958;7030.402415794715;7063.293670632896;7076.964615176891;3728.2729867675544;3774.226283611853;3775.093977445393;3788.0719223790347;3886.8250928708276;3208.967910320867;3398.116489712643;3415.829208539613;3416.350893330259;3419.7606167568033;586.2993722501569;591.798788411942;591.8727473593198;592.6651441935293;601.8405122642504;459.78849729124306;560.5655616896856;599.9238976274848;601.0803470689851;610.5909040942579;7806.453548251568;8323.500589964622;8336.124706905808;8467.280281176047;8489.108643592333;513.9306193663882;558.0095330787884;604.9667268300286;613.4662843326246;641.1696852575925;3383.424817780983;3680.981595092061;3695.6489133532273;3703.518542589446;3730.1420673245307;49735.25397119046;52702.472975270524;52994.470055299724;53349.1997620036;53565.732171338896;46547;46632;47622;48558;48894.75552622214;44107;44443.77778111089;44616.10767784626;44766.32850507245;44778.55221447809;7222.96388518054;7237.927620723725;7275.163356213891;7281.381082608038;7501.174870764321;27181;28576.857115714287;29646.851765741034;29849.55225671573;30247.69752302537;35037;38114.80942595269;38421.6157838418;38480.422793658676;39176.80411597924;10524.579016839241;10579.4710264488;10622.20333474977;10912.508937097691;10974.506147223554;11735.354555499529;11868.525258989544;11963.581274655346;12027.21823081497;12427.875721243034;10828.566857325619;11122.499487522919;11169.218154729091;11171.497282622464;11502.079833613458;10519.94740026295;10618;10638.521266543179;11058.944705276423;11105.888941110485;9936.751581210528;10024.348417352849;10409.68770936873;10775.784484310427;11196.552137914392;9230.769230769445;9243;9692.85460718104;9831.31180817336;9844.950775246078;9784.657536986171;10249.33379330371;10344.431056291976;10354;10356.533955971849 18:06:17 INFO - PROCESS | 24177 | __end_tp_report 18:06:17 INFO - PROCESS | 24177 | __start_cc_report 18:06:17 INFO - PROCESS | 24177 | _x_x_mozilla_cycle_collect,371 18:06:17 INFO - PROCESS | 24177 | __end_cc_report 18:06:17 INFO - PROCESS | 24177 | __startTimestamp1462410377174__endTimestamp 18:06:17 INFO - PROCESS | 24177 | 18:06:17 INFO - PROCESS | 24177 | ------- Summary: start ------- 18:06:17 INFO - PROCESS | 24177 | Number of tests: 6 18:06:17 INFO - PROCESS | 24177 | 18:06:17 INFO - PROCESS | 24177 | [#0] dojo.html Cycles:165 Average:4700.14 Median:4825.37 stddev:601.09 (12.5%) stddev-sans-first:579.82 18:06:17 INFO - PROCESS | 24177 | Values: 2595.4 2653.5 2665.9 2704.7 2707.5 4673.0 4678.4 4730.9 4738.9 4767.3 4694.1 4784.2 4786.9 4841.7 4903.7 4355.8 4446.4 4504.6 4510.8 4541.9 404.9 4309.6 4380.1 4385.7 4446.9 4440.0 4440.9 4445.2 4459.8 4468.5 4409.7 4447.8 4450.4 4466.4 4491.4 4328.8 4386.7 4441.8 4467.6 4481.9 4545.0 4557.1 4573.1 4582.1 4583.9 4920.1 5050.4 5066.9 5079.1 5104.2 5064.7 5099.3 5116.5 5130.1 5191.5 4739.8 4782.5 4787.6 4814.2 4825.4 5215.7 5251.4 5271.6 5333.5 5342.9 4955.6 4982.3 4999.2 5001.8 5042.6 5047.5 5110.1 5120.0 5122.7 5125.6 4938.9 5024.5 5125.2 5202.3 5229.6 5022.3 5045.6 5076.3 5079.1 5152.6 4294.3 4304.4 4326.2 4341.4 4352.0 3679.1 3763.7 3803.7 3804.4 3865.7 4278.3 4387.7 4405.6 4406.4 4410.3 5143.4 5148.1 5160.3 5162.0 5164.2 4311.1 4360.9 4396.2 4420.3 4445.3 4585.4 4596.7 4602.0 4607.4 4638.2 4760.6 4764.5 4776.5 4779.8 4826.6 5043.9 5083.8 5128.6 5163.5 5185.6 4723.5 4742.2 4759.0 4762.5 4811.2 4869.3 4982.9 4983.3 4988.6 5035.8 5125.5 5149.8 5192.9 5206.5 5226.0 5027.9 5050.0 5051.8 5053.9 5104.2 4870.6 4948.1 5041.8 5049.1 5056.8 4923.1 4931.3 4961.7 4993.1 5028.0 5054.5 5070.8 5087.8 5107.7 5116.2 4587.7 4931.8 4962.8 4979.9 5023.6 18:06:17 INFO - PROCESS | 24177 | 18:06:17 INFO - PROCESS | 24177 | [#1] ext.html Cycles:180 Average:45570.23 Median:35731.64 stddev:79331.81 (222.0%) stddev-sans-first:79482.41 18:06:17 INFO - PROCESS | 24177 | Values: 571.2 617.2 629.2 635.0 636.0 36231.6 37232.6 37441.6 37480.3 37781.6 37202.3 37798.6 37810.2 37898.2 38074.6 7617.4 7755.4 7779.3 7796.9 7802.6 7669.6 7952.4 7955.7 7965.4 8003.5 7805.9 7811.1 7823.2 7830.6 7831.5 7856.5 7889.3 7900.6 7903.5 7921.9 7791.3 7844.0 7890.5 7903.1 7911.6 27881.0 39508.0 40009.4 40028.8 40162.8 3086.7 3135.0 3184.8 3235.9 3281.6 28417.3 28521.7 28693.3 28787.6 29001.7 3353.3 3386.9 3419.7 3459.7 3466.2 202719.0 208015.0 208305.0 208337.0 260474.0 32430.8 62367.7 63811.7 63903.4 63922.0 35366.0 35378.5 35727.3 35736.0 35844.0 14057.2 14363.0 14398.5 14416.5 14419.9 11039.9 11076.1 11084.0 11086.7 11150.6 8416.3 8494.3 8526.4 8535.1 8643.1 3304.3 3346.3 3406.8 3452.1 3475.7 888.9 958.9 996.3 1000.3 1042.6 29695.7 29957.7 30231.1 30505.5 30529.7 1027.8 1056.3 1057.9 1108.7 1118.6 15618.9 15954.6 16019.5 16149.0 16183.0 344373.0 345766.0 348311.0 351143.0 352010.0 53083.5 53652.0 53786.2 53866.0 54063.7 1276.1 1276.8 1287.8 1288.3 1390.5 27650.7 29075.0 29318.0 29501.4 29786.9 43057.4 44892.6 44969.8 45003.5 45016.0 319428.0 321853.0 322114.0 323133.0 323839.0 41344.8 41940.6 42141.6 42269.8 42447.4 45973.7 46427.0 46446.8 46819.3 47034.8 37885.8 38873.0 39197.8 39267.4 39320.2 37747.0 38323.6 39193.4 39366.6 39591.2 29492.7 34526.5 35463.0 35532.5 39025.2 28898.9 30846.7 31254.2 31331.8 31429.2 25339.3 25752.8 25785.0 26135.9 26598.3 18:06:17 INFO - PROCESS | 24177 | 18:06:17 INFO - PROCESS | 24177 | [#2] jquery.html Cycles:180 Average:23168.10 Median:4509.16 stddev:61355.87 (1360.7%) stddev-sans-first:61504.14 18:06:17 INFO - PROCESS | 24177 | Values: 381.8 382.4 382.6 383.3 388.2 16033.0 16437.0 17353.7 17355.1 17361.1 11303.3 16176.2 17040.6 17069.2 17096.8 3540.5 4714.9 4874.3 4874.7 4877.7 5246.2 5584.0 5586.5 5589.7 5601.7 5336.2 5544.0 5545.9 5557.3 5561.6 5523.8 5542.8 5543.0 5547.1 5569.0 5169.5 5401.1 5404.0 5441.1 5442.2 12718.9 12814.7 12833.6 12836.7 16892.0 1792.5 1910.4 1981.0 2007.2 2075.4 9344.2 9701.5 9899.8 10942.0 13639.1 1598.4 1749.2 1800.3 1975.3 2016.9 61715.7 64594.4 64652.0 65262.0 70772.0 9798.3 10142.5 10251.2 10429.8 10601.4 14496.9 14614.0 14650.3 14655.4 14663.0 7457.5 7680.0 7740.7 7749.5 7833.7 7123.1 7173.9 7350.7 7380.1 7431.7 4043.9 4368.0 4500.7 4517.7 4595.6 1831.5 1894.8 1901.7 1909.5 1918.0 563.5 858.0 892.3 927.4 937.4 16741.4 16859.7 17338.5 17516.7 17521.8 903.8 924.8 945.9 948.5 950.7 9744.3 9770.2 9943.9 9985.7 10024.1 367611.0 370799.0 374285.0 374557.0 375412.0 46499.3 60120.7 74967.0 78163.6 79326.2 964.2 965.5 976.7 979.9 993.9 15245.5 15429.7 15517.3 15606.6 15776.0 33561.5 33753.0 33830.0 35608.3 35616.6 47717.8 48371.3 48420.3 48666.5 48940.3 7533.8 7748.4 7778.3 7885.3 8034.0 5897.1 8557.7 8751.0 10420.0 11759.2 9962.5 10106.3 10368.5 10445.3 10747.1 10244.2 10254.3 10362.5 10508.7 10547.5 10468.9 10578.0 10597.5 10733.6 10885.3 7821.5 7876.8 8000.2 8012.4 8083.2 8056.1 10320.9 10520.2 10607.9 10811.1 18:06:17 INFO - PROCESS | 24177 | 18:06:17 INFO - PROCESS | 24177 | [#3] mootools.html Cycles:180 Average:5069.72 Median:5098.25 stddev:2846.12 (55.8%) stddev-sans-first:2841.35 18:06:17 INFO - PROCESS | 24177 | Values: 1482.8 1533.9 1686.5 1823.2 1842.0 6689.4 7430.1 7464.9 7718.5 7723.1 7523.4 7578.1 7581.0 7614.4 7616.6 2138.1 2186.7 2198.4 2201.3 2206.7 2035.6 2048.4 2089.8 2093.8 2094.8 2180.8 2186.3 2203.7 2207.2 2216.1 2165.3 2168.3 2169.2 2169.3 2172.8 2146.0 2154.2 2173.0 2186.5 2193.4 7693.5 7705.0 7707.7 7722.3 7726.4 4564.6 4707.1 4743.7 4746.2 4748.7 2739.0 2800.0 2831.9 2873.3 2886.1 915.3 925.2 930.8 937.7 948.0 10543.8 10572.0 10615.6 10623.8 10633.4 4180.0 4282.4 4324.7 4372.2 4377.9 8043.4 8054.8 8094.1 8104.0 8133.0 4544.0 4550.9 4573.5 4582.2 4593.7 3786.1 4147.1 4237.7 4271.7 4312.8 3347.7 3412.4 3453.1 3485.6 3502.2 1037.3 1040.8 1043.6 1045.1 1076.2 800.1 833.4 870.3 888.3 891.5 5083.6 5112.9 5224.0 5224.9 5234.5 419.7 419.9 426.8 430.5 435.3 3538.8 3626.6 3645.2 3649.7 3675.9 9279.6 9706.9 9764.4 9773.2 9834.7 9525.0 9670.6 9672.0 9674.4 9689.9 6819.7 7038.1 7039.0 7040.4 7102.1 5141.4 5162.6 5219.4 5469.5 5474.6 8796.8 8854.8 8881.2 8976.7 9065.6 8904.8 9052.0 9064.4 9129.6 9137.7 5935.6 6417.4 6515.4 6636.0 6637.9 7500.7 7509.5 7545.3 7600.7 7634.4 6785.7 6911.8 6969.6 7010.3 7042.0 6553.5 6568.2 6720.9 6785.5 6803.9 6289.2 6312.3 6392.3 6392.7 6419.5 4348.6 4403.7 4454.6 4496.7 4540.7 4499.1 4566.4 4582.4 4613.3 4616.0 18:06:17 INFO - PROCESS | 24177 | 18:06:17 INFO - PROCESS | 24177 | [#4] prototype.html Cycles:180 Average:4377.61 Median:4890.86 stddev:1286.95 (26.3%) stddev-sans-first:1253.88 18:06:17 INFO - PROCESS | 24177 | Values: 312.8 318.4 319.4 319.6 320.1 4892.4 4937.1 4961.7 4974.9 4987.3 4858.5 4872.4 4886.5 4886.5 4889.3 3656.6 3812.9 3898.4 3909.3 3935.4 3911.8 3925.6 3927.8 3941.7 3954.0 3911.7 3912.9 3913.3 3920.0 3920.8 3821.7 3866.0 3882.2 3901.1 3916.4 3399.7 3403.7 3415.9 3421.5 3426.9 4706.6 4710.5 4716.2 4731.3 4734.3 4361.8 4378.0 4391.8 4396.8 4404.3 4803.3 5147.4 5157.3 5170.0 5177.4 3624.9 3626.3 3633.9 3659.6 3668.4 5394.7 5407.1 5415.2 5446.3 5463.7 3658.7 3659.3 3714.6 3723.7 3743.7 3707.8 3764.7 3767.7 3784.3 3791.2 4324.3 4333.7 4340.4 4352.8 4353.7 4979.6 5137.9 5190.2 5209.8 5212.4 1373.6 1385.7 1386.6 1391.3 1391.8 863.9 903.7 925.5 954.0 954.1 4454.9 4559.0 4572.8 4585.5 4590.9 5344.8 5392.0 5397.9 5406.9 5420.0 4410.2 4537.7 4599.9 4600.2 4622.3 3025.7 3043.0 3061.9 3071.8 3079.7 5375.9 5382.9 5385.6 5415.8 5425.0 5680.2 5875.6 5880.7 5897.5 5900.0 5340.6 5362.5 5384.2 5385.7 5405.8 5688.6 5772.5 5781.4 5783.3 5794.4 5433.4 5613.3 5624.2 5632.8 5645.0 5360.6 5366.5 5387.1 5399.1 5406.4 3884.8 3892.5 3892.9 3900.7 3903.3 5102.2 5394.3 5394.4 5399.9 5402.5 5235.2 5239.8 5240.7 5259.7 5264.0 5107.5 5153.5 5179.3 5179.8 5242.4 5061.0 5067.2 5087.5 5118.6 5133.3 4983.3 5066.8 5209.7 5217.2 5227.0 5120.4 5137.5 5147.2 5151.7 5156.8 18:06:17 INFO - PROCESS | 24177 | 18:06:17 INFO - PROCESS | 24177 | [#5] yui.html Cycles:180 Average:12926.98 Median:44529.94 stddev:14497.36 (32.6%) stddev-sans-first:14509.29 18:06:17 INFO - PROCESS | 24177 | Values: 772.7 813.0 813.0 817.5 821.9 13815.4 14203.1 14307.8 14366.1 14377.8 13374.5 13436.7 13467.4 13540.4 13606.7 696.5 870.8 879.5 881.1 883.7 859.6 867.3 873.3 874.1 878.2 912.1 912.8 914.8 917.0 921.9 905.0 907.4 913.9 916.8 927.5 666.9 668.7 670.2 674.2 676.0 13076.7 13174.1 13195.3 13218.1 13228.8 12064.5 12201.5 12279.1 12631.1 12642.1 10050.7 10105.8 10203.9 10244.5 10402.8 3313.2 3400.5 3402.2 3432.0 3472.8 44330.3 44696.3 44755.8 44766.8 45149.0 9396.0 9508.4 9616.8 9620.2 9766.9 17443.7 17462.3 17477.4 17478.0 17510.3 6997.8 7001.3 7030.4 7063.3 7077.0 3728.3 3774.2 3775.1 3788.1 3886.8 3209.0 3398.1 3415.8 3416.4 3419.8 586.3 591.8 591.9 592.7 601.8 459.8 560.6 599.9 601.1 610.6 7806.5 8323.5 8336.1 8467.3 8489.1 513.9 558.0 605.0 613.5 641.2 3383.4 3681.0 3695.6 3703.5 3730.1 49735.3 52702.5 52994.5 53349.2 53565.7 46547.0 46632.0 47622.0 48558.0 48894.8 44107.0 44443.8 44616.1 44766.3 44778.6 7223.0 7237.9 7275.2 7281.4 7501.2 27181.0 28576.9 29646.9 29849.6 30247.7 35037.0 38114.8 38421.6 38480.4 39176.8 10524.6 10579.5 10622.2 10912.5 10974.5 11735.4 11868.5 11963.6 12027.2 12427.9 10828.6 11122.5 11169.2 11171.5 11502.1 10519.9 10618.0 10638.5 11058.9 11105.9 9936.8 10024.3 10409.7 10775.8 11196.6 9230.8 9243.0 9692.9 9831.3 9845.0 9784.7 10249.3 10344.4 10354.0 10356.5 18:06:17 INFO - PROCESS | 24177 | -------- Summary: end -------- 18:06:17 INFO - PROCESS | 24177 | 18:06:17 INFO - TEST-INFO | 24177: exit 0 18:06:17 INFO - TEST-OK | dromaeo_css | took 1114360ms 18:06:17 INFO - TEST-START | kraken 18:06:17 INFO - operating with platform_type : linux_ 18:06:17 INFO - Initialising browser for kraken test... 18:06:17 INFO - TEST-INFO | started process 24413 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpD5wYm7/profile http://localhost:45001/getInfo.html) 18:06:21 INFO - PROCESS | 24413 | 18:06:21 INFO - PROCESS | 24413 | (process:24479): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 18:06:22 INFO - PROCESS | 24413 | __metrics Screen width/height:1600/1200 18:06:22 INFO - PROCESS | 24413 | colorDepth:24 18:06:22 INFO - PROCESS | 24413 | Browser inner width/height: 1024/697 18:06:22 INFO - PROCESS | 24413 | __metrics 18:06:23 ERROR - PROCESS | 24413 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 18:06:23 INFO - TEST-INFO | 24413: exit 0 18:06:23 INFO - Browser initialized. 18:06:23 INFO - Running cycle 1/1 for kraken test... 18:06:23 INFO - TEST-INFO | started process 24530 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpD5wYm7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:06:25 INFO - PROCESS | 24530 | 18:06:25 INFO - PROCESS | 24530 | (process:24592): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 18:06:35 INFO - PROCESS | 24530 | RSS: Main: 165552128 18:06:35 INFO - PROCESS | 24530 | 18:06:38 INFO - PROCESS | 24530 | Cycle 1(1): loaded http://localhost:45001/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45001/tests/kraken/driver.html?testName=audio-beat-detection) 18:06:39 INFO - PROCESS | 24530 | RSS: Main: 169439232 18:06:39 INFO - PROCESS | 24530 | 18:06:42 INFO - PROCESS | 24530 | Cycle 1(1): loaded http://localhost:45001/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45001/tests/kraken/driver.html?testName=audio-dft) 18:06:42 INFO - PROCESS | 24530 | RSS: Main: 171528192 18:06:42 INFO - PROCESS | 24530 | 18:06:45 INFO - PROCESS | 24530 | Cycle 1(1): loaded http://localhost:45001/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45001/tests/kraken/driver.html?testName=audio-fft) 18:06:46 INFO - PROCESS | 24530 | RSS: Main: 164237312 18:06:46 INFO - PROCESS | 24530 | 18:06:48 INFO - PROCESS | 24530 | Cycle 1(1): loaded http://localhost:45001/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45001/tests/kraken/driver.html?testName=audio-oscillator) 18:06:49 INFO - PROCESS | 24530 | RSS: Main: 164802560 18:06:49 INFO - PROCESS | 24530 | 18:06:51 INFO - PROCESS | 24530 | Cycle 1(1): loaded http://localhost:45001/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45001/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:06:52 INFO - PROCESS | 24530 | RSS: Main: 166301696 18:06:52 INFO - PROCESS | 24530 | 18:06:55 INFO - PROCESS | 24530 | Cycle 1(1): loaded http://localhost:45001/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45001/tests/kraken/driver.html?testName=imaging-darkroom) 18:06:56 INFO - PROCESS | 24530 | RSS: Main: 166785024 18:06:56 INFO - PROCESS | 24530 | 18:06:59 INFO - PROCESS | 24530 | Cycle 1(1): loaded http://localhost:45001/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45001/tests/kraken/driver.html?testName=imaging-desaturate) 18:07:00 INFO - PROCESS | 24530 | RSS: Main: 166105088 18:07:00 INFO - PROCESS | 24530 | 18:07:03 INFO - PROCESS | 24530 | Cycle 1(1): loaded http://localhost:45001/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45001/tests/kraken/driver.html?testName=json-parse-financial) 18:07:03 INFO - PROCESS | 24530 | RSS: Main: 166744064 18:07:03 INFO - PROCESS | 24530 | 18:07:05 INFO - PROCESS | 24530 | Cycle 1(1): loaded http://localhost:45001/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45001/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:07:06 INFO - PROCESS | 24530 | RSS: Main: 166965248 18:07:06 INFO - PROCESS | 24530 | 18:07:07 INFO - PROCESS | 24530 | Cycle 1(1): loaded http://localhost:45001/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45001/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:07:08 INFO - PROCESS | 24530 | RSS: Main: 167194624 18:07:08 INFO - PROCESS | 24530 | 18:07:10 INFO - PROCESS | 24530 | Cycle 1(1): loaded http://localhost:45001/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45001/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:07:11 INFO - PROCESS | 24530 | RSS: Main: 167563264 18:07:11 INFO - PROCESS | 24530 | 18:07:14 INFO - PROCESS | 24530 | Cycle 1(1): loaded http://localhost:45001/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45001/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:07:14 INFO - PROCESS | 24530 | RSS: Main: 167784448 18:07:14 INFO - PROCESS | 24530 | 18:07:17 INFO - PROCESS | 24530 | Cycle 1(1): loaded http://localhost:45001/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45001/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:07:18 INFO - PROCESS | 24530 | RSS: Main: 167657472 18:07:18 INFO - PROCESS | 24530 | 18:07:20 INFO - PROCESS | 24530 | Cycle 1(1): loaded http://localhost:45001/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45001/tests/kraken/driver.html?testName=ai-astar) 18:07:20 INFO - PROCESS | 24530 | RSS: Main: 169336832 18:07:20 INFO - PROCESS | 24530 | 18:07:20 INFO - PROCESS | 24530 | __start_tp_report 18:07:20 INFO - PROCESS | 24530 | _x_x_mozilla_page_load 18:07:20 INFO - PROCESS | 24530 | _x_x_mozilla_page_load_details 18:07:20 INFO - PROCESS | 24530 | |i|pagename|runs| 18:07:20 INFO - PROCESS | 24530 | |0;ai-astar;116;108;116;114;114;127;113;116;114;117 18:07:20 INFO - PROCESS | 24530 | |1;audio-beat-detection;164;132;162;189;136;169;155;135;205;141 18:07:20 INFO - PROCESS | 24530 | |2;audio-dft;163;165;181;176;163;162;163;163;168;162 18:07:20 INFO - PROCESS | 24530 | |3;audio-fft;73;76;73;152;74;75;76;78;158;74 18:07:20 INFO - PROCESS | 24530 | |4;audio-oscillator;95;95;147;95;95;94;156;95;94;144 18:07:20 INFO - PROCESS | 24530 | |5;imaging-gaussian-blur;119;117;118;118;118;118;118;118;118;117 18:07:20 INFO - PROCESS | 24530 | |6;imaging-darkroom;147;146;147;148;147;147;147;147;147;148 18:07:20 INFO - PROCESS | 24530 | |7;imaging-desaturate;95;95;95;96;95;96;96;95;96;96 18:07:20 INFO - PROCESS | 24530 | |8;json-parse-financial;76;67;68;67;67;68;66;86;66;66 18:07:20 INFO - PROCESS | 24530 | |9;json-stringify-tinderbox;65;65;67;64;65;66;65;64;64;65 18:07:20 INFO - PROCESS | 24530 | |10;stanford-crypto-aes;88;81;79;81;83;81;82;80;82;82 18:07:20 INFO - PROCESS | 24530 | |11;stanford-crypto-ccm;134;133;135;133;152;138;137;134;162;138 18:07:20 INFO - PROCESS | 24530 | |12;stanford-crypto-pbkdf2;182;181;184;186;180;179;183;180;183;178 18:07:20 INFO - PROCESS | 24530 | |13;stanford-crypto-sha256-iterative;74;70;77;73;78;73;75;77;73;73 18:07:20 INFO - PROCESS | 24530 | __end_tp_report 18:07:20 INFO - PROCESS | 24530 | __start_cc_report 18:07:20 INFO - PROCESS | 24530 | _x_x_mozilla_cycle_collect,945 18:07:20 INFO - PROCESS | 24530 | __end_cc_report 18:07:20 INFO - PROCESS | 24530 | __startTimestamp1462410440527__endTimestamp 18:07:20 INFO - PROCESS | 24530 | 18:07:20 INFO - PROCESS | 24530 | ------- Summary: start ------- 18:07:20 INFO - PROCESS | 24530 | Number of tests: 14 18:07:20 INFO - PROCESS | 24530 | 18:07:20 INFO - PROCESS | 24530 | [#0] ai-astar Cycles:10 Average:115.50 Median:116.00 stddev:4.77 (4.1%) stddev-sans-first:5.05 18:07:20 INFO - PROCESS | 24530 | Values: 116.0 108.0 116.0 114.0 114.0 127.0 113.0 116.0 114.0 117.0 18:07:20 INFO - PROCESS | 24530 | 18:07:20 INFO - PROCESS | 24530 | [#1] audio-beat-detection Cycles:10 Average:158.80 Median:163.00 stddev:24.32 (14.9%) stddev-sans-first:25.72 18:07:20 INFO - PROCESS | 24530 | Values: 164.0 132.0 162.0 189.0 136.0 169.0 155.0 135.0 205.0 141.0 18:07:20 INFO - PROCESS | 24530 | 18:07:20 INFO - PROCESS | 24530 | [#2] audio-dft Cycles:10 Average:166.60 Median:164.00 stddev:6.62 (4.0%) stddev-sans-first:6.89 18:07:20 INFO - PROCESS | 24530 | Values: 163.0 165.0 181.0 176.0 163.0 162.0 163.0 163.0 168.0 162.0 18:07:20 INFO - PROCESS | 24530 | 18:07:20 INFO - PROCESS | 24530 | [#3] audio-fft Cycles:10 Average:90.90 Median:74.50 stddev:33.85 (45.4%) stddev-sans-first:35.28 18:07:20 INFO - PROCESS | 24530 | Values: 73.0 76.0 73.0 152.0 74.0 75.0 76.0 78.0 158.0 74.0 18:07:20 INFO - PROCESS | 24530 | 18:07:20 INFO - PROCESS | 24530 | [#4] audio-oscillator Cycles:10 Average:111.00 Median:95.00 stddev:26.39 (27.8%) stddev-sans-first:27.35 18:07:20 INFO - PROCESS | 24530 | Values: 95.0 95.0 147.0 95.0 95.0 94.0 156.0 95.0 94.0 144.0 18:07:20 INFO - PROCESS | 24530 | 18:07:20 INFO - PROCESS | 24530 | [#5] imaging-gaussian-blur Cycles:10 Average:117.90 Median:118.00 stddev:0.57 (0.5%) stddev-sans-first:0.44 18:07:20 INFO - PROCESS | 24530 | Values: 119.0 117.0 118.0 118.0 118.0 118.0 118.0 118.0 118.0 117.0 18:07:20 INFO - PROCESS | 24530 | 18:07:20 INFO - PROCESS | 24530 | [#6] imaging-darkroom Cycles:10 Average:147.10 Median:147.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 18:07:20 INFO - PROCESS | 24530 | Values: 147.0 146.0 147.0 148.0 147.0 147.0 147.0 147.0 147.0 148.0 18:07:20 INFO - PROCESS | 24530 | 18:07:20 INFO - PROCESS | 24530 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 18:07:20 INFO - PROCESS | 24530 | Values: 95.0 95.0 95.0 96.0 95.0 96.0 96.0 95.0 96.0 96.0 18:07:20 INFO - PROCESS | 24530 | 18:07:20 INFO - PROCESS | 24530 | [#8] json-parse-financial Cycles:10 Average:69.70 Median:67.50 stddev:6.45 (9.6%) stddev-sans-first:6.42 18:07:20 INFO - PROCESS | 24530 | Values: 76.0 67.0 68.0 67.0 67.0 68.0 66.0 86.0 66.0 66.0 18:07:20 INFO - PROCESS | 24530 | 18:07:20 INFO - PROCESS | 24530 | [#9] json-stringify-tinderbox Cycles:10 Average:65.00 Median:65.00 stddev:0.94 (1.5%) stddev-sans-first:1.00 18:07:20 INFO - PROCESS | 24530 | Values: 65.0 65.0 67.0 64.0 65.0 66.0 65.0 64.0 64.0 65.0 18:07:20 INFO - PROCESS | 24530 | 18:07:20 INFO - PROCESS | 24530 | [#10] stanford-crypto-aes Cycles:10 Average:81.90 Median:82.00 stddev:2.42 (3.0%) stddev-sans-first:1.20 18:07:20 INFO - PROCESS | 24530 | Values: 88.0 81.0 79.0 81.0 83.0 81.0 82.0 80.0 82.0 82.0 18:07:20 INFO - PROCESS | 24530 | 18:07:20 INFO - PROCESS | 24530 | [#11] stanford-crypto-ccm Cycles:10 Average:139.60 Median:137.50 stddev:9.65 (7.0%) stddev-sans-first:10.02 18:07:20 INFO - PROCESS | 24530 | Values: 134.0 133.0 135.0 133.0 152.0 138.0 137.0 134.0 162.0 138.0 18:07:20 INFO - PROCESS | 24530 | 18:07:20 INFO - PROCESS | 24530 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:181.60 Median:182.50 stddev:2.46 (1.3%) stddev-sans-first:2.60 18:07:20 INFO - PROCESS | 24530 | Values: 182.0 181.0 184.0 186.0 180.0 179.0 183.0 180.0 183.0 178.0 18:07:20 INFO - PROCESS | 24530 | 18:07:20 INFO - PROCESS | 24530 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.30 Median:74.50 stddev:2.45 (3.3%) stddev-sans-first:2.60 18:07:20 INFO - PROCESS | 24530 | Values: 74.0 70.0 77.0 73.0 78.0 73.0 75.0 77.0 73.0 73.0 18:07:20 INFO - PROCESS | 24530 | -------- Summary: end -------- 18:07:20 INFO - PROCESS | 24530 | 18:07:21 INFO - TEST-INFO | 24530: exit 0 18:07:21 INFO - TEST-OK | kraken | took 63632ms 18:07:21 INFO - SUITE-END | took 1177s 18:07:21 INFO - Completed test suite (00:19:38) 18:07:21 INFO - javascript benchmark 18:07:21 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2595.441979974306, 2653.5488966875637, 2665.880035398407, 2704.7430494103055, 2707.472042951624, 4673.042026384592, 4678.391809064825, 4730.9053818923685, 4738.881527961803, 4767.284907263907, 4694.084653492562, 4784.234522476405, 4786.904261914759, 4841.685290456118, 4903.705777653343, 4355.803988820503, 4446.419743222252, 4504.572065653758, 4510.819567217307, 4541.909161816761, 404.8802798132385, 4309.590588894066, 4380.058287468194, 4385.736855788647, 4446.933296000562, 4439.977800110995, 4440.933385999213, 4445.155420470101, 4459.843905463309, 4468.4637843458995, 4409.691321607489, 4447.799849006802, 4450.421445212101, 4466.397036400077, 4491.438570178728, 4328.76630160406, 4386.7367957922625, 4441.800118994621, 4467.620252278528, 4481.887952801173, 4545.0000999779995, 4557.0885822835235, 4573.085382923428, 4582.060677561125, 4583.931241031387, 4920.138975679241, 5050.39395272566, 5066.873328166788, 5079.076640440924, 5104.234364845266, 5064.696118232918, 5099.260607211933, 5116.462771409023, 5130.07658621448, 5191.454897235812, 4739.763011849428, 4782.521747825224, 4787.61699064074, 4814.15752243363, 4825.372701548847, 5215.6609820361555, 5251.4485978972425, 5271.604629652791, 5333.546648534841, 5342.9465705342445, 4955.578775804025, 4982.277569752366, 4999.200127979506, 5001.799928002839, 5042.621803364762, 5047.495250474996, 5110.105731496973, 5119.97440012805, 5122.743862806919, 5125.564327032244, 4938.9012219755405, 5024.49755024502, 5125.154349532286, 5202.323697919322, 5229.607779416559, 5022.296878437021, 5045.621578381636, 5076.314697515862, 5079.08576456234, 5152.562032227228, 4294.291441912112, 4304.3543468479975, 4326.15639950213, 4341.413909122291, 4352.042550638855, 3679.1354031802507, 3763.717721170923, 3803.676687481595, 3804.391297392404, 3865.6520913117956, 4278.336857787048, 4387.736735795863, 4405.647548196137, 4406.405135306757, 4410.272305069628, 5143.434222235551, 5148.073346797612, 5160.277561141444, 5161.974190129101, 5164.173732202829, 4311.137772445523, 4360.934585981213, 4396.186705459436, 4420.336949457607, 4445.333200020023, 4585.426821647294, 4596.724196548218, 4602.033572949718, 4607.424071991001, 4638.234691275901, 4760.571548560646, 4764.547368000034, 4776.474587795409, 4779.808807647794, 4826.61387089025, 5043.87390315245, 5083.796648134034, 5128.564072053917, 5163.483651634807, 5185.637005409585, 4723.535703931792, 4742.193827049341, 4758.976205118952, 4762.476127625889, 4811.158047341772, 4869.269609558594, 4982.850514484571, 4983.27742477346, 4988.55103040728, 5035.773390197523, 5125.513076257749, 5149.768260428365, 5192.896142077213, 5206.453322401093, 5225.980933717889, 5027.949720502895, 5050.047533958096, 5051.823186188466, 5053.8736531587, 5104.1578139606545, 4870.634702397264, 4948.109340318633, 5041.773120209673, 5049.141645920276, 5056.84829455117, 4923.08922849274, 4931.3096166536, 4961.727105009115, 4993.101241776515, 5027.974860125676, 5054.519820617035, 5070.771815268248, 5087.821926232564, 5107.693538387709, 5116.181410974226, 4587.678862479728, 4931.753412329297, 4962.801487940586, 4979.891763070412, 5023.572996295356], "value": 4663.901776196024, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [571.2031715756519, 617.2377114263884, 629.2386212682653, 634.9523785716071, 635.9682015899203, 36231.63768362316, 37232.627673723255, 37441.62558374416, 37480.25039499209, 37781.59965603095, 37202.255954880886, 37798.62201377985, 37810.24379512408, 37898.24203515928, 38074.619253807454, 7617.428692848045, 7755.418343624223, 7779.2998630123275, 7796.883046754303, 7802.648880800378, 7669.6165191740465, 7952.3638108951145, 7955.72154974576, 7965.362770978308, 8003.5197888126895, 7805.921940780577, 7811.140774514799, 7823.2176782321885, 7830.647620857047, 7831.490953088031, 7856.450048496637, 7889.250521200477, 7900.64447099879, 7903.525788452711, 7921.881171782428, 7791.337736292422, 7844.0, 7890.48711833729, 7903.091144518339, 7911.615467293201, 27881.0, 39508.0, 40009.39985900214, 40028.799856000536, 40162.79918600388, 3086.706762857525, 3135.04381163745, 3184.8407579621157, 3235.8705651773903, 3281.6390197078304, 28417.289567760763, 28521.714782852112, 28693.28266793326, 28787.56818647722, 29001.694923728483, 3353.3293341331832, 3386.9039054088194, 3419.692227699494, 3459.7405194610255, 3466.2374277658873, 202719.0, 208015.0, 208305.0, 208337.0, 260473.9999999981, 32430.83784581062, 62367.6881615589, 63811.72376552443, 63903.36096639067, 63922.0, 35366.0, 35378.469322960176, 35727.285454290766, 35736.0, 35844.0, 14057.22685252321, 14363.0, 14398.496052638317, 14416.495422660366, 14419.927900360432, 11039.944800275947, 11076.058535024613, 11084.0, 11086.667399978014, 11150.553977840795, 8416.326693864476, 8494.258676971205, 8526.40315177944, 8535.103814099555, 8643.135686431306, 3304.3391321735267, 3346.2972775716885, 3406.829658517064, 3452.102453362144, 3475.6871881530783, 888.8888888888889, 958.8849338079475, 996.3374356053289, 1000.2698030437821, 1042.6142327338932, 29695.703042969726, 29957.700422995928, 30231.093067208018, 30505.542416863766, 30529.69470305313, 1027.799579082072, 1056.334509259162, 1057.8519007338978, 1108.7172770943357, 1118.6364431559775, 15618.9219053904, 15954.601134971486, 16019.519414417586, 16149.0, 16183.0, 344373.0, 345766.0, 348311.0, 351143.0, 352010.0, 53083.469165307855, 53652.0, 53786.193207101926, 53866.0, 54063.72968135213, 1276.0557187681234, 1276.8148618450273, 1287.8454585449806, 1288.3365066990507, 1390.506370238571, 27650.723492764813, 29075.0, 29318.0, 29501.409971800873, 29786.851065744533, 43057.354139688556, 44892.55107448884, 44969.775151124035, 45003.549964499936, 45016.0, 319428.0, 321853.0, 322114.0, 323133.0, 323839.0, 41344.79327603343, 41940.580594194886, 42141.57858421376, 42269.78865105655, 42447.3632895513, 45973.68787138038, 46427.0, 46446.767766160956, 46819.29771053505, 47034.76482617565, 37885.81057094697, 38873.0, 39197.804010979766, 39267.41098883576, 39320.2135957285, 37747.0, 38323.61676383312, 39193.41209881911, 39366.606333936295, 39591.208175836895, 29492.705072949855, 34526.48210276798, 35463.0, 35532.46701299431, 39025.219495610494, 28898.85550572234, 30846.69153308438, 31254.218644533157, 31331.84334078315, 31429.21426964253, 25339.29014643832, 25752.81101106427, 25785.0, 26135.869320653273, 26598.335041624116], "value": 17134.582543668952, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [381.79955523350236, 382.38627003659127, 382.5676985006942, 383.30047663014994, 388.2313020219966, 16033.0, 16437.0, 17353.7396939046, 17355.132243387812, 17361.131943402812, 11303.321800691965, 16176.19119044046, 17040.573985650364, 17069.231884565193, 17096.751617192724, 3540.4689296605457, 4714.929276060853, 4874.268859671042, 4874.731889746063, 4877.70733755974, 5246.1606143017125, 5583.972080139614, 5586.469285417899, 5589.74846131925, 5601.691906945116, 5336.199570064483, 5543.972280138593, 5545.916811247835, 5557.3331200256025, 5561.5828812839, 5523.834284971457, 5542.75057622408, 5543.0, 5547.11246200608, 5569.0, 5169.508896654812, 5401.081816091274, 5403.972980135074, 5441.129419292934, 5442.183672449125, 12718.872811271862, 12814.743705125939, 12833.550825721055, 12836.679083022906, 16892.0, 1792.5339411753039, 1910.3695780392577, 1980.9504762380911, 2007.1971211515365, 2075.3773867839586, 9344.205742511895, 9701.51492425376, 9899.802003959952, 10941.96051375118, 13639.113457625223, 1598.352667169798, 1749.2303386509896, 1800.297883825309, 1975.3185151122984, 2016.8588198825942, 61715.69142154305, 64594.354056459306, 64652.0, 65262.0, 70772.0, 9798.334283171878, 10142.492875356204, 10251.179905607534, 10429.843552346721, 10601.41692206936, 14496.85503144976, 14614.0, 14650.340734666966, 14655.413783448756, 14663.046901951338, 7457.515261507984, 7680.039995000625, 7740.651670674833, 7749.4575379724, 7833.686652533949, 7123.109611298588, 7173.856522869618, 7350.70597176107, 7380.077490313711, 7431.665575049135, 4043.8584649537715, 4367.978160109179, 4500.662450316239, 4517.661175411791, 4595.609373203249, 1831.4688740265174, 1894.7915729269769, 1901.7337572739827, 1909.465349702058, 1917.9616407671767, 563.5322682173786, 858.0304256190465, 892.2549671024638, 927.4018258223408, 937.386012162035, 16741.414050508174, 16859.662806743796, 17338.479845604652, 17516.737248941277, 17521.82478175202, 903.8373092843351, 924.8150369926042, 945.8675785390051, 948.4729585367553, 950.7005293332578, 9744.269179811543, 9770.169535589412, 9943.900560994442, 9985.650502232387, 10024.097831195228, 367611.0, 370799.0, 374285.0, 374557.0, 375412.0, 46499.30251046237, 60120.69939650361, 74967.0, 78163.60918195486, 79326.20673793188, 964.1611797736015, 965.5220665770488, 976.6728146071003, 979.9216062714823, 993.8807343118872, 15245.466408675644, 15429.691406172038, 15517.301721422336, 15606.609834754221, 15775.974561653456, 33561.49657755184, 33753.0, 33830.0, 35608.28783424265, 35616.643833561335, 47717.761411192725, 48371.27443088286, 48420.273695893884, 48666.5133348662, 48940.265896010875, 7533.773986780406, 7748.418868584991, 7778.299953004257, 7885.3297469713425, 8034.035915690155, 5897.144913987534, 8557.673560598118, 8750.956245218733, 10420.0, 11759.235649682743, 9962.452065136196, 10106.343087699275, 10368.533415996148, 10445.268831181744, 10747.140228781522, 10244.231682623684, 10254.333468324536, 10362.481875906326, 10508.684739457829, 10547.472626368804, 10468.895311046792, 10578.0, 10597.4701264938, 10733.570657173626, 10885.346879187275, 7821.491603045783, 7876.803079923047, 8000.15998320168, 8012.399070069885, 8083.232092951161, 8056.073551541648, 10320.948395257976, 10520.210984176065, 10607.893921060999, 10811.13510919109], "value": 8121.087674881745, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1482.7998220240268, 1533.8926275160738, 1686.4940517844643, 1823.2251293200402, 1841.9723704144433, 6689.431398331148, 7430.108386993555, 7464.925350746491, 7718.459707820455, 7723.111842138149, 7523.398128149748, 7578.128515220751, 7581.0, 7614.428917831157, 7616.6191690415535, 2138.0806253311107, 2186.6501359782437, 2198.351486311534, 2201.2515744646817, 2206.6689996500572, 2035.623409669216, 2048.3752455501067, 2089.8014688604558, 2093.8010888965523, 2094.780048094943, 2180.80372766451, 2186.278528085736, 2203.680466332381, 2207.2164381644525, 2216.091402524965, 2165.317924853666, 2168.3278183763005, 2169.208238992764, 2169.3275084723628, 2172.7718589548026, 2145.957080858374, 2154.192177933275, 2173.0438607012866, 2186.5408264264524, 2193.42970827586, 7693.5383876967, 7705.0, 7707.6916923323, 7722.343600793939, 7726.420518461082, 4564.612007979325, 4707.105649926503, 4743.715377077387, 4746.240601503743, 4748.715077095385, 2739.0, 2800.0, 2831.8584070796583, 2873.310405502685, 2886.07645553423, 915.2815040193483, 925.2051021019201, 930.8138372325494, 937.6999360204737, 947.9763005924838, 10543.78912421755, 10572.0, 10615.57537698491, 10623.84064239037, 10633.415162166155, 4180.0, 4282.443282373271, 4324.67564932625, 4372.213001659668, 4377.868663940087, 8043.39674524413, 8054.758357249292, 8094.109647938722, 8104.0, 8133.0, 4544.0, 4550.931736023962, 4573.49691533931, 4582.175208462442, 4593.701409408378, 3786.1481166737813, 4147.087640719037, 4237.660987121085, 4271.722338048017, 4312.849050283225, 3347.7489188310974, 3412.4028295048265, 3453.1194545390763, 3485.5643044619424, 3502.2470168913296, 1037.2635428845454, 1040.7554224757175, 1043.6190790361616, 1045.0751085289573, 1076.2251179150999, 800.1158719614858, 833.3541505333416, 870.2863651805459, 888.2804928008334, 891.5497673674753, 5083.61872859537, 5112.872178195575, 5224.03355379256, 5224.895502089937, 5234.528892399702, 419.67684882640197, 419.88453175377015, 426.8314015963677, 430.5457742082071, 435.27309393313243, 3538.7699799512948, 3626.637336266352, 3645.234500754871, 3649.7262705297208, 3675.852965881388, 9279.62881484733, 9706.90293097074, 9764.365316254421, 9773.21814254858, 9834.704958851245, 9525.0, 9670.613175473043, 9672.0, 9674.419534827934, 9689.854652180224, 6819.659017049227, 7038.085048943707, 7039.049728286615, 7040.401565866959, 7102.112235970504, 5141.38303403594, 5162.561182299547, 5219.399769026459, 5469.535089517276, 5474.616776825584, 8796.824063518821, 8854.822903542023, 8881.200691937498, 8976.685815996409, 9065.637374504946, 8904.753145646762, 9052.0, 9064.365494415328, 9129.5891684873, 9137.725868223964, 5935.554833387427, 6417.39034791694, 6515.413612774873, 6635.966820166062, 6637.933620663732, 7500.699972001059, 7509.474336796372, 7545.283198096172, 7600.695972161052, 7634.389248859967, 6785.694643740945, 6911.827204319932, 6969.58182509051, 7010.298970103153, 7042.0, 6553.5084868635995, 6568.211814582281, 6720.865582688221, 6785.5250132490255, 6803.93196068033, 6289.213848268966, 6312.337204593451, 6392.264889537577, 6392.744290228339, 6419.518536109904, 4348.63036641889, 4403.735775853459, 4454.621357184676, 4496.7301961882395, 4540.704854184468, 4499.077689073797, 4566.429196350457, 4582.358469814162, 4613.331066995334, 4616.0], "value": 4026.190973126991, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [312.82012842615495, 318.42683170293463, 319.3772144318579, 319.57656105660004, 320.0781748564136, 4892.437369702485, 4937.061958227934, 4961.727105009223, 4974.925376119361, 4987.326710894033, 4858.46556878743, 4872.439669438016, 4886.462489126193, 4886.462489126202, 4889.291052797343, 3656.6160553141935, 3812.866549670762, 3898.4152377143373, 3909.335412979786, 3935.4490371348033, 3911.823967921436, 3925.568187499373, 3927.803609819512, 3941.708673257833, 3953.960460395402, 3911.6675082618012, 3912.8826135215845, 3913.256481268564, 3919.9608003920025, 3920.764754114762, 3821.73247872649, 3866.0283255539734, 3882.2429626222897, 3901.1417488152847, 3916.3929590913453, 3399.7280217582534, 3403.6596340366013, 3415.863365465403, 3421.4867769834477, 3426.8971930842113, 4706.623470122417, 4710.505396933307, 4716.198246298138, 4731.33761273422, 4734.26618874075, 4361.847335343247, 4377.956220437787, 4391.824327026915, 4396.802143903532, 4404.317330813697, 4803.2554953981835, 5147.433782283983, 5157.252198431206, 5169.974150129263, 5177.430482646906, 3624.912526242143, 3626.2747450510005, 3633.9273214535824, 3659.6340365963456, 3668.3763760160837, 5394.676319420847, 5407.134858422633, 5415.187721841755, 5446.291982042309, 5463.710986875284, 3658.725595580342, 3659.2681463707363, 3714.5542534895985, 3723.6648701616987, 3743.7271327748695, 3707.8146092695256, 3764.7176461765475, 3767.7362584618813, 3784.3188226119564, 3791.2038471920655, 4324.329728892027, 4333.71830830995, 4340.374073685438, 4352.804123814436, 4353.73877567347, 4979.57673597741, 5137.922931155961, 5190.169572868323, 5209.817656382009, 5212.374515058217, 1373.5535950816025, 1385.6535866033491, 1386.6117487103627, 1391.304347826087, 1391.8329800424015, 863.9136086391311, 903.7153296711647, 925.5372313843078, 953.9840070325082, 954.1126752120595, 4454.866354009385, 4558.954410455853, 4572.7713614319155, 4585.495595484494, 4590.862274131781, 5344.75948582307, 5392.0, 5397.892042159214, 5406.8918621627345, 5419.99730049942, 4410.16206920684, 4537.705049171794, 4599.9080018399445, 4600.171969045604, 4622.329762184464, 3025.6520500142765, 3042.969570304313, 3061.8775248990237, 3071.754259659222, 3079.6920307969026, 5375.919361209585, 5382.865428364322, 5385.5960802939935, 5415.810446634349, 5425.023495770799, 5680.204771332017, 5875.6474611523445, 5880.7356418370255, 5897.469227769521, 5899.970500147558, 5340.572754179656, 5362.463753624606, 5384.165454354503, 5385.711072794047, 5405.756740946746, 5688.5733569981585, 5772.451617096369, 5781.364049954585, 5783.306003279633, 5794.420557944172, 5433.429489903503, 5613.298337707786, 5624.184493248538, 5632.802851900327, 5644.971775141098, 5360.571154307568, 5366.470555891552, 5387.111126664056, 5399.136138217867, 5406.405295417422, 3884.7863367515056, 3892.455056292065, 3892.8832135035996, 3900.707446941434, 3903.277893589695, 5102.183650615883, 5394.32570928634, 5394.406615272238, 5399.865003374947, 5402.514308565176, 5235.188545775411, 5239.790408383775, 5240.659357141773, 5259.710715910662, 5264.025825408632, 5107.540321371094, 5153.484651534816, 5179.274901513866, 5179.766910488962, 5242.370915490165, 5060.975609756127, 5067.189249720027, 5087.542121209109, 5118.641695081457, 5133.281340612242, 4983.25251212321, 5066.771995260296, 5209.739513024258, 5217.217417387422, 5226.973865130803, 5120.359955005624, 5137.51193636604, 5147.202183661539, 5151.6908985459495, 5156.819511317086], "value": 3976.228486410014, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [772.7295446593693, 812.9634166462511, 813.0, 817.4523069543405, 821.9342452603793, 13815.37830797614, 14203.076800007992, 14307.78538321926, 14366.066205696648, 14377.784333234997, 13374.531891383804, 13436.731265374687, 13467.393967271471, 13540.39068241929, 13606.659833504167, 696.5333226738097, 870.8040690844557, 879.5030807593721, 881.0528681667201, 883.6642076011107, 859.5530324231396, 867.2541614211773, 873.3231745397336, 874.1258741258741, 878.2490970220465, 912.1152482092393, 912.803747194353, 914.7575892388522, 916.9587368568397, 921.8617207418873, 904.9592768325408, 907.3603109807569, 913.9451632902047, 916.8212198621271, 927.4667066436825, 666.8932970724661, 668.6690088406222, 670.2359310386164, 674.1505702814441, 675.9763408280736, 13076.738465230737, 13174.143680660822, 13195.340232988312, 13218.140820846615, 13228.801567976489, 12064.457099430547, 12201.45093470796, 12279.079069069767, 12631.115821892472, 12642.051846111579, 10050.748731281703, 10105.797884042351, 10203.948980255125, 10244.487775611264, 10402.791944161074, 3313.204830840605, 3400.472926696366, 3402.1664692150334, 3431.9656803431894, 3472.8437220325145, 44330.33504497435, 44696.3295550567, 44755.77622111901, 44766.776166119285, 45149.0, 9396.0, 9508.381955172892, 9616.75958101053, 9620.182284505756, 9766.9023309766, 17443.73834392485, 17462.301507939796, 17477.38829140974, 17478.0, 17510.29958801659, 6997.825054373681, 7001.299870012958, 7030.402415794715, 7063.293670632896, 7076.964615176891, 3728.2729867675544, 3774.226283611853, 3775.093977445393, 3788.0719223790347, 3886.8250928708276, 3208.967910320867, 3398.116489712643, 3415.829208539613, 3416.350893330259, 3419.7606167568033, 586.2993722501569, 591.798788411942, 591.8727473593198, 592.6651441935293, 601.8405122642504, 459.78849729124306, 560.5655616896856, 599.9238976274848, 601.0803470689851, 610.5909040942579, 7806.453548251568, 8323.500589964622, 8336.124706905808, 8467.280281176047, 8489.108643592333, 513.9306193663882, 558.0095330787884, 604.9667268300286, 613.4662843326246, 641.1696852575925, 3383.424817780983, 3680.981595092061, 3695.6489133532273, 3703.518542589446, 3730.1420673245307, 49735.25397119046, 52702.472975270524, 52994.470055299724, 53349.1997620036, 53565.732171338896, 46547.0, 46632.0, 47622.0, 48558.0, 48894.75552622214, 44107.0, 44443.77778111089, 44616.10767784626, 44766.32850507245, 44778.55221447809, 7222.96388518054, 7237.927620723725, 7275.163356213891, 7281.381082608038, 7501.174870764321, 27181.0, 28576.857115714287, 29646.851765741034, 29849.55225671573, 30247.69752302537, 35037.0, 38114.80942595269, 38421.6157838418, 38480.422793658676, 39176.80411597924, 10524.579016839241, 10579.4710264488, 10622.20333474977, 10912.508937097691, 10974.506147223554, 11735.354555499529, 11868.525258989544, 11963.581274655346, 12027.21823081497, 12427.875721243034, 10828.566857325619, 11122.499487522919, 11169.218154729091, 11171.497282622464, 11502.079833613458, 10519.94740026295, 10618.0, 10638.521266543179, 11058.944705276423, 11105.888941110485, 9936.751581210528, 10024.348417352849, 10409.68770936873, 10775.784484310427, 11196.552137914392, 9230.769230769445, 9243.0, 9692.85460718104, 9831.31180817336, 9844.950775246078, 9784.657536986171, 10249.33379330371, 10344.431056291976, 10354.0, 10356.533955971849], "value": 6117.099150605948, "unit": "score"}], "name": "dromaeo_css", "value": 6317.316658441143, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 108.0, 116.0, 114.0, 114.0, 127.0, 113.0, 116.0, 114.0, 117.0], "value": 115.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 132.0, 162.0, 189.0, 136.0, 169.0, 155.0, 135.0, 205.0, 141.0], "value": 158.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 165.0, 181.0, 176.0, 163.0, 162.0, 163.0, 163.0, 168.0, 162.0], "value": 166.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 76.0, 73.0, 152.0, 74.0, 75.0, 76.0, 78.0, 158.0, 74.0], "value": 90.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 147.0, 95.0, 95.0, 94.0, 156.0, 95.0, 94.0, 144.0], "value": 111.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 117.0, 118.0, 118.0, 118.0, 118.0, 118.0, 118.0, 118.0, 117.0], "value": 117.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 147.0, 148.0, 147.0, 147.0, 147.0, 147.0, 147.0, 148.0], "value": 147.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 96.0, 95.0, 96.0, 96.0, 95.0, 96.0, 96.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 67.0, 68.0, 67.0, 67.0, 68.0, 66.0, 86.0, 66.0, 66.0], "value": 69.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 67.0, 64.0, 65.0, 66.0, 65.0, 64.0, 64.0, 65.0], "value": 65.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 81.0, 79.0, 81.0, 83.0, 81.0, 82.0, 80.0, 82.0, 82.0], "value": 81.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 133.0, 135.0, 133.0, 152.0, 138.0, 137.0, 134.0, 162.0, 138.0], "value": 139.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 181.0, 184.0, 186.0, 180.0, 179.0, 183.0, 180.0, 183.0, 178.0], "value": 181.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 70.0, 77.0, 73.0, 78.0, 73.0, 75.0, 77.0, 73.0, 73.0], "value": 74.3, "unit": "score"}], "name": "kraken", "value": 1615.3999999999999, "alertThreshold": 2.0}]} 18:07:21 INFO - Return code: 0 18:07:21 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 18:07:21 ERROR - # TBPL SUCCESS # 18:07:21 INFO - Running post-action listener: _resource_record_post_action 18:07:21 INFO - Running post-run listener: _resource_record_post_run 18:07:22 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 0; Write bytes: 519213056; Read time: 0; Write time: 351840 18:07:22 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 123576320; Read time: 0; Write time: 112216 18:07:22 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 0; Write bytes: 284409856; Read time: 0; Write time: 171608 18:07:22 INFO - Running post-run listener: _upload_blobber_files 18:07:22 INFO - Blob upload gear active. 18:07:22 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:07:22 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 18:07:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 18:07:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 18:07:23 INFO - (blobuploader) - INFO - Open directory for files ... 18:07:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 18:07:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:07:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:07:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 18:07:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:07:24 INFO - (blobuploader) - INFO - Done attempting. 18:07:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 18:07:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:07:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:07:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 18:07:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:07:25 INFO - (blobuploader) - INFO - Done attempting. 18:07:25 INFO - (blobuploader) - INFO - Iteration through files over. 18:07:25 INFO - Return code: 0 18:07:25 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:07:25 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:07:25 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f32c3c5e16d43fc8b019a562d6bfd2c8856a75159e090c83968ceb7ae73cded32ed40a04a11a1f3089405bf6cf5e2a7ef20284ee94ec4649b4a7d61feff261b6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1909838480e2f5c87f77729170abe3fcbd256b0fc3010c5917466a42aa5c428314847a4f88267db762dc22f42fdbff21a8c2c144a9e3ba5d25e3ac1320aee4a8"} 18:07:25 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:07:25 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:07:25 INFO - Contents: 18:07:25 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f32c3c5e16d43fc8b019a562d6bfd2c8856a75159e090c83968ceb7ae73cded32ed40a04a11a1f3089405bf6cf5e2a7ef20284ee94ec4649b4a7d61feff261b6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1909838480e2f5c87f77729170abe3fcbd256b0fc3010c5917466a42aa5c428314847a4f88267db762dc22f42fdbff21a8c2c144a9e3ba5d25e3ac1320aee4a8"} 18:07:25 INFO - Running post-run listener: copy_logs_to_upload_dir 18:07:25 INFO - Copying logs to upload dir... 18:07:25 INFO - mkdir: /builds/slave/test/build/upload/logs 18:07:25 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1243.115180 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-05-04 18:07:24.868219) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-04 18:07:24.874172) ========= 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=7cf709767345e0a0c5a90e72000001d4-1462408860.697390-566542548 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f32c3c5e16d43fc8b019a562d6bfd2c8856a75159e090c83968ceb7ae73cded32ed40a04a11a1f3089405bf6cf5e2a7ef20284ee94ec4649b4a7d61feff261b6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1909838480e2f5c87f77729170abe3fcbd256b0fc3010c5917466a42aa5c428314847a4f88267db762dc22f42fdbff21a8c2c144a9e3ba5d25e3ac1320aee4a8"} build_url:https://queue.taskcluster.net/v1/task/e_pVfAbEQe6SS62pUUgchA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011404 build_url: 'https://queue.taskcluster.net/v1/task/e_pVfAbEQe6SS62pUUgchA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f32c3c5e16d43fc8b019a562d6bfd2c8856a75159e090c83968ceb7ae73cded32ed40a04a11a1f3089405bf6cf5e2a7ef20284ee94ec4649b4a7d61feff261b6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1909838480e2f5c87f77729170abe3fcbd256b0fc3010c5917466a42aa5c428314847a4f88267db762dc22f42fdbff21a8c2c144a9e3ba5d25e3ac1320aee4a8"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-04 18:07:24.899923) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-04 18:07:24.900312) ========= 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=7cf709767345e0a0c5a90e72000001d4-1462408860.697390-566542548 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004367 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-04 18:07:24.981540) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-04 18:07:24.981902) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-04 18:07:24.982236) ========= ========= Total master_lag: 0.18 =========