builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-027 starttime: 1463001323.78 results: success (0) buildid: 20160511134706 builduid: 0931827588b74f4aa06eaa8feaf71ecf revision: 6afc5dab597975722542388390191a07ec0939d5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-11 14:15:23.784247) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-11 14:15:23.784694) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-11 14:15:23.784971) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-11 14:15:23.794335) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 14:15:23.794719) ========= 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=1f5564757af27664ca02d71f000001b0-1463001323.518521-1744516563 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-11 14:15:24-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 20.6M=0.001s 2016-05-11 14:15:24 (20.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.107268 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 14:15:23.912112) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 14:15:23.912673) ========= 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=1f5564757af27664ca02d71f000001b0-1463001323.518521-1744516563 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.009620 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 14:15:23.960559) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-05-11 14:15:23.960929) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 6afc5dab597975722542388390191a07ec0939d5 --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 6afc5dab597975722542388390191a07ec0939d5 --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=1f5564757af27664ca02d71f000001b0-1463001323.518521-1744516563 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-11 14:15:24,381 truncating revision to first 12 chars 2016-05-11 14:15:24,381 Setting DEBUG logging. 2016-05-11 14:15:24,381 attempt 1/10 2016-05-11 14:15:24,381 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/6afc5dab5979?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-11 14:15:25,319 unpacking tar archive at: fx-team-6afc5dab5979/testing/mozharness/ program finished with exit code 0 elapsedTime=1.500715 ========= master_lag: 0.69 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-05-11 14:15:26.156082) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-11 14:15:26.156653) ========= script_repo_revision: 6afc5dab597975722542388390191a07ec0939d5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-11 14:15:26.157353) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-11 14:15:26.160850) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-11 14:15:26.174657) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-05-11 14:15:26.175360) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=1f5564757af27664ca02d71f000001b0-1463001323.518521-1744516563 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:15:26 INFO - MultiFileLogger online at 20160511 14:15:26 in /builds/slave/test 14:15:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --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 14:15:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:15:26 INFO - {'append_to_log': False, 14:15:26 INFO - 'base_work_dir': '/builds/slave/test', 14:15:26 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 14:15:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:15:26 INFO - 'branch': 'Fx-Team-Non-PGO', 14:15:26 INFO - 'buildbot_json_path': 'buildprops.json', 14:15:26 INFO - 'config_files': ('talos/linux_config.py',), 14:15:26 INFO - 'default_actions': ('clobber', 14:15:26 INFO - 'read-buildbot-config', 14:15:26 INFO - 'download-and-extract', 14:15:26 INFO - 'populate-webroot', 14:15:26 INFO - 'create-virtualenv', 14:15:26 INFO - 'install', 14:15:26 INFO - 'run-tests'), 14:15:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:15:26 INFO - 'download_minidump_stackwalk': True, 14:15:26 INFO - 'download_symbols': 'ondemand', 14:15:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:15:26 INFO - 'tooltool.py': '/tools/tooltool.py', 14:15:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:15:26 INFO - '/tools/misc-python/virtualenv.py')}, 14:15:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:15:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:15:26 INFO - 'installer_path': 'installer.exe', 14:15:26 INFO - 'log_level': 'info', 14:15:26 INFO - 'log_name': 'talos', 14:15:26 INFO - 'log_to_console': True, 14:15:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:15:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:15:26 INFO - 'opt_config_files': (), 14:15:26 INFO - 'pip_index': False, 14:15:26 INFO - 'sps_profile': False, 14:15:26 INFO - 'sps_profile_interval': 0, 14:15:26 INFO - 'suite': 'dromaeojs', 14:15:26 INFO - 'system_bits': '32', 14:15:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:15:26 INFO - 'title': 'talos-linux64-ix-027', 14:15:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:15:26 INFO - 'use_talos_json': True, 14:15:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:15:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:15:26 INFO - 'work_dir': 'build'} 14:15:26 INFO - ##### 14:15:26 INFO - ##### Running clobber step. 14:15:26 INFO - ##### 14:15:26 INFO - Running pre-action listener: _resource_record_pre_action 14:15:26 INFO - Running main action method: clobber 14:15:26 INFO - rmtree: /builds/slave/test/build 14:15:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:15:27 INFO - Running post-action listener: _resource_record_post_action 14:15:27 INFO - ##### 14:15:27 INFO - ##### Finished clobber step (success) 14:15:27 INFO - ##### 14:15:27 INFO - ##### 14:15:27 INFO - ##### Running read-buildbot-config step. 14:15:27 INFO - ##### 14:15:27 INFO - Running pre-action listener: _resource_record_pre_action 14:15:27 INFO - Running main action method: read_buildbot_config 14:15:27 INFO - Using buildbot properties: 14:15:27 INFO - { 14:15:27 INFO - "project": "", 14:15:27 INFO - "product": "firefox", 14:15:27 INFO - "script_repo_revision": "production", 14:15:27 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 14:15:27 INFO - "repository": "", 14:15:27 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 14:15:27 INFO - "buildid": "20160511134706", 14:15:27 INFO - "pgo_build": "False", 14:15:27 INFO - "basedir": "/builds/slave/test", 14:15:27 INFO - "buildnumber": 2967, 14:15:27 INFO - "slavename": "talos-linux64-ix-027", 14:15:27 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 14:15:27 INFO - "platform": "ubuntu64_hw", 14:15:27 INFO - "scheduler": "tests-fx-team-linux64-talos", 14:15:27 INFO - "branch": "fx-team", 14:15:27 INFO - "repo_path": "integration/fx-team", 14:15:27 INFO - "revision": "6afc5dab597975722542388390191a07ec0939d5", 14:15:27 INFO - "stage_platform": "linux64", 14:15:27 INFO - "builduid": "0931827588b74f4aa06eaa8feaf71ecf", 14:15:27 INFO - "slavebuilddir": "test" 14:15:27 INFO - } 14:15:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/e1dwY0yBRbGlnhapsTkjpg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 14:15:27 INFO - Running post-action listener: _resource_record_post_action 14:15:27 INFO - ##### 14:15:27 INFO - ##### Finished read-buildbot-config step (success) 14:15:27 INFO - ##### 14:15:27 INFO - ##### 14:15:27 INFO - ##### Running download-and-extract step. 14:15:27 INFO - ##### 14:15:27 INFO - Running pre-action listener: _resource_record_pre_action 14:15:27 INFO - Running main action method: download_and_extract 14:15:27 INFO - mkdir: /builds/slave/test/build/tests 14:15:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:15:27 INFO - https://queue.taskcluster.net/v1/task/e1dwY0yBRbGlnhapsTkjpg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 14:15:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e1dwY0yBRbGlnhapsTkjpg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 14:15:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e1dwY0yBRbGlnhapsTkjpg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 14:15:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e1dwY0yBRbGlnhapsTkjpg/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 14:15:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e1dwY0yBRbGlnhapsTkjpg/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 14:15:28 INFO - Downloaded 1361 bytes. 14:15:28 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 14:15:28 INFO - Using the following test package requirements: 14:15:28 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 14:15:28 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:15:28 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 14:15:28 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:15:28 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 14:15:28 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:15:28 INFO - u'jsshell-linux-x86_64.zip'], 14:15:28 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:15:28 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 14:15:28 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 14:15:28 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:15:28 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 14:15:28 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:15:28 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 14:15:28 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:15:28 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 14:15:28 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:15:28 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 14:15:28 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:15:28 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')]} 14:15:28 INFO - https://queue.taskcluster.net/v1/task/e1dwY0yBRbGlnhapsTkjpg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:15:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e1dwY0yBRbGlnhapsTkjpg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 14:15:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e1dwY0yBRbGlnhapsTkjpg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 14:15:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e1dwY0yBRbGlnhapsTkjpg/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 14:15:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e1dwY0yBRbGlnhapsTkjpg/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 14:15:29 INFO - Downloaded 22329130 bytes. 14:15:29 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'] 14:15:29 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 14:15:31 INFO - Return code: 0 14:15:31 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 14:15:31 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')]} 14:15:31 INFO - https://queue.taskcluster.net/v1/task/e1dwY0yBRbGlnhapsTkjpg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:15:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e1dwY0yBRbGlnhapsTkjpg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 14:15:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e1dwY0yBRbGlnhapsTkjpg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 14:15:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e1dwY0yBRbGlnhapsTkjpg/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 14:15:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e1dwY0yBRbGlnhapsTkjpg/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 14:15:32 INFO - Downloaded 22329130 bytes. 14:15:32 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'] 14:15:32 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 14:15:33 INFO - Return code: 0 14:15:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:15:33 INFO - https://queue.taskcluster.net/v1/task/e1dwY0yBRbGlnhapsTkjpg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 14:15:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e1dwY0yBRbGlnhapsTkjpg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 14:15:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e1dwY0yBRbGlnhapsTkjpg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 14:15:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e1dwY0yBRbGlnhapsTkjpg/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 14:15:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e1dwY0yBRbGlnhapsTkjpg/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 14:15:35 INFO - Downloaded 10840152 bytes. 14:15:35 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'] 14:15:35 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 14:15:35 INFO - Return code: 0 14:15:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:15:35 INFO - https://queue.taskcluster.net/v1/task/e1dwY0yBRbGlnhapsTkjpg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 14:15:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e1dwY0yBRbGlnhapsTkjpg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 14:15:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e1dwY0yBRbGlnhapsTkjpg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 14:15:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e1dwY0yBRbGlnhapsTkjpg/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 14:15:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e1dwY0yBRbGlnhapsTkjpg/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 14:15:36 INFO - Downloaded 54683003 bytes. 14:15:36 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/e1dwY0yBRbGlnhapsTkjpg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 14:15:36 INFO - mkdir: /builds/slave/test/properties 14:15:36 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:15:36 INFO - Writing to file /builds/slave/test/properties/build_url 14:15:36 INFO - Contents: 14:15:36 INFO - build_url:https://queue.taskcluster.net/v1/task/e1dwY0yBRbGlnhapsTkjpg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 14:15:37 INFO - Running post-action listener: _resource_record_post_action 14:15:37 INFO - Running post-action listener: set_extra_try_arguments 14:15:37 INFO - ##### 14:15:37 INFO - ##### Finished download-and-extract step (success) 14:15:37 INFO - ##### 14:15:37 INFO - ##### 14:15:37 INFO - ##### Running populate-webroot step. 14:15:37 INFO - ##### 14:15:37 INFO - Running pre-action listener: _resource_record_pre_action 14:15:37 INFO - Running main action method: populate_webroot 14:15:37 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:15:37 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:15:37 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:15:37 INFO - '--tppagecycles', 14:15:37 INFO - '7'], 14:15:37 INFO - 'tests': ['tsvgm']}}, 14:15:37 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:15:37 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:15:37 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:15:37 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:15:37 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:15:37 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:15:37 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:15:37 INFO - 'talos_options': ['--disable-e10s'], 14:15:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:15:37 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:15:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:15:37 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:15:37 INFO - 'talos_options': ['--disable-e10s'], 14:15:37 INFO - 'tests': ['damp', 'tps']}, 14:15:37 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:15:37 INFO - 'tests': ['damp', 'tps']}, 14:15:37 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:15:37 INFO - 'tests': ['dromaeo_dom']}, 14:15:37 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:15:37 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:15:37 INFO - 'tests': ['a11yr', 14:15:37 INFO - 'ts_paint', 14:15:37 INFO - 'tpaint', 14:15:37 INFO - 'sessionrestore', 14:15:37 INFO - 'sessionrestore_no_auto_restore', 14:15:37 INFO - 'tabpaint']}, 14:15:37 INFO - 'other-e10s': {'tests': ['a11yr', 14:15:37 INFO - 'ts_paint', 14:15:37 INFO - 'tpaint', 14:15:37 INFO - 'sessionrestore', 14:15:37 INFO - 'sessionrestore_no_auto_restore', 14:15:37 INFO - 'tabpaint']}, 14:15:37 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:15:37 INFO - 'ts_paint', 14:15:37 INFO - 'tpaint', 14:15:37 INFO - 'sessionrestore', 14:15:37 INFO - 'sessionrestore_no_auto_restore', 14:15:37 INFO - 'tabpaint']}, 14:15:37 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:15:37 INFO - 'ts_paint', 14:15:37 INFO - 'tpaint', 14:15:37 INFO - 'sessionrestore', 14:15:37 INFO - 'sessionrestore_no_auto_restore', 14:15:37 INFO - 'tabpaint']}, 14:15:37 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:15:37 INFO - 'tests': ['a11yr', 14:15:37 INFO - 'ts_paint', 14:15:37 INFO - 'tpaint', 14:15:37 INFO - 'sessionrestore', 14:15:37 INFO - 'sessionrestore_no_auto_restore', 14:15:37 INFO - 'tabpaint']}, 14:15:37 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:15:37 INFO - 'tests': ['a11yr', 14:15:37 INFO - 'ts_paint', 14:15:37 INFO - 'tpaint', 14:15:37 INFO - 'sessionrestore', 14:15:37 INFO - 'sessionrestore_no_auto_restore', 14:15:37 INFO - 'tabpaint']}, 14:15:37 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:15:37 INFO - 'tests': ['tsvgx', 14:15:37 INFO - 'tsvgr_opacity', 14:15:37 INFO - 'tart', 14:15:37 INFO - 'tscrollx', 14:15:37 INFO - 'cart']}, 14:15:37 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:15:37 INFO - 'tsvgr_opacity', 14:15:37 INFO - 'tart', 14:15:37 INFO - 'tscrollx', 14:15:37 INFO - 'cart']}, 14:15:37 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:15:37 INFO - 'talos_options': ['--disable-e10s'], 14:15:37 INFO - 'tests': ['tp5o']}, 14:15:37 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:15:37 INFO - 'tests': ['tp5o']}, 14:15:37 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:15:37 INFO - 'talos_options': ['--disable-e10s', 14:15:37 INFO - '--xperf_path', 14:15:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:15:37 INFO - 'tests': ['tp5n']}, 14:15:37 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:15:37 INFO - 'talos_options': ['--xperf_path', 14:15:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:15:37 INFO - 'tests': ['tp5n']}}, 14:15:37 INFO - 'talos.zip': {'path': '', 14:15:37 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:15:37 INFO - Running post-action listener: _resource_record_post_action 14:15:37 INFO - ##### 14:15:37 INFO - ##### Finished populate-webroot step (success) 14:15:37 INFO - ##### 14:15:37 INFO - ##### 14:15:37 INFO - ##### Running create-virtualenv step. 14:15:37 INFO - ##### 14:15:37 INFO - Running pre-action listener: _resource_record_pre_action 14:15:37 INFO - Running main action method: create_virtualenv 14:15:37 INFO - Creating virtualenv /builds/slave/test/build/venv 14:15:37 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 14:15:37 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:15:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:15:37 INFO - Using real prefix '/usr' 14:15:37 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:15:38 INFO - Installing distribute.............................................................................................................................................................................................done. 14:15:40 INFO - Installing pip.................done. 14:15:40 INFO - Return code: 0 14:15:40 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:15:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:15:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:15:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:15:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:15:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:15:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:15:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb94ec91f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ef3770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f829c0>, '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 0x1f838c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f83d50>, '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': '1f5564757af27664ca02d71f000001b0-1463001323.518521-1744516563', '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 14:15:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 14:15:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 14:15:40 INFO - Using env: {'DISPLAY': ':0', 14:15:40 INFO - 'HOME': '/home/cltbld', 14:15:40 INFO - 'LANG': 'en_US.UTF-8', 14:15:40 INFO - 'LANGUAGE': 'en_US:en', 14:15:40 INFO - 'LOGNAME': 'cltbld', 14:15:40 INFO - 'MAIL': '/var/mail/cltbld', 14:15:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:15:40 INFO - 'MOZ_NO_REMOTE': '1', 14:15:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:15:40 INFO - 'NO_EM_RESTART': '1', 14:15:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:15:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:15:40 INFO - 'PWD': '/builds/slave/test', 14:15:40 INFO - 'SHELL': '/bin/bash', 14:15:40 INFO - 'SHLVL': '1', 14:15:40 INFO - 'TERM': 'linux', 14:15:40 INFO - 'TMOUT': '86400', 14:15:40 INFO - 'USER': 'cltbld', 14:15:40 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1463001323.518521-1744516563', 14:15:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:15:40 INFO - '_': '/tools/buildbot/bin/python'} 14:15:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:15:40 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 14:15:40 INFO - Cleaning up... 14:15:40 INFO - Return code: 0 14:15:40 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 14:15:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:15:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:15:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:15:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:15:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:15:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:15:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fb94ec91f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ef3770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f829c0>, '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 0x1f838c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f83d50>, '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': '1f5564757af27664ca02d71f000001b0-1463001323.518521-1744516563', '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 14:15:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 14:15:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 14:15:40 INFO - Using env: {'DISPLAY': ':0', 14:15:40 INFO - 'HOME': '/home/cltbld', 14:15:40 INFO - 'LANG': 'en_US.UTF-8', 14:15:40 INFO - 'LANGUAGE': 'en_US:en', 14:15:40 INFO - 'LOGNAME': 'cltbld', 14:15:40 INFO - 'MAIL': '/var/mail/cltbld', 14:15:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:15:40 INFO - 'MOZ_NO_REMOTE': '1', 14:15:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:15:40 INFO - 'NO_EM_RESTART': '1', 14:15:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:15:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:15:40 INFO - 'PWD': '/builds/slave/test', 14:15:40 INFO - 'SHELL': '/bin/bash', 14:15:40 INFO - 'SHLVL': '1', 14:15:40 INFO - 'TERM': 'linux', 14:15:40 INFO - 'TMOUT': '86400', 14:15:40 INFO - 'USER': 'cltbld', 14:15:40 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1463001323.518521-1744516563', 14:15:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:15:40 INFO - '_': '/tools/buildbot/bin/python'} 14:15:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:15:40 INFO - Downloading/unpacking psutil>=0.7.1 14:15:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:15:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:15:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:15:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:15:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:15:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:15:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:15:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:15:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:15:42 INFO - Installing collected packages: psutil 14:15:42 INFO - Running setup.py install for psutil 14:15:42 INFO - building 'psutil._psutil_linux' extension 14:15:42 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 14:15:42 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 14:15:42 INFO - building 'psutil._psutil_posix' extension 14:15:42 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 14:15:42 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 14:15:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:15:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:15:42 INFO - Successfully installed psutil 14:15:42 INFO - Cleaning up... 14:15:42 INFO - Return code: 0 14:15:42 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 14:15: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')]} 14:15:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:15:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:15: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')]} 14:15:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:15:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:15:42 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 0x7fb94ec91f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ef3770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f829c0>, '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 0x1f838c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f83d50>, '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': '1f5564757af27664ca02d71f000001b0-1463001323.518521-1744516563', '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 14:15:42 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 14:15:42 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 14:15:42 INFO - Using env: {'DISPLAY': ':0', 14:15:42 INFO - 'HOME': '/home/cltbld', 14:15:42 INFO - 'LANG': 'en_US.UTF-8', 14:15:42 INFO - 'LANGUAGE': 'en_US:en', 14:15:42 INFO - 'LOGNAME': 'cltbld', 14:15:42 INFO - 'MAIL': '/var/mail/cltbld', 14:15:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:15:42 INFO - 'MOZ_NO_REMOTE': '1', 14:15:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:15:42 INFO - 'NO_EM_RESTART': '1', 14:15:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:15:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:15:42 INFO - 'PWD': '/builds/slave/test', 14:15:42 INFO - 'SHELL': '/bin/bash', 14:15:42 INFO - 'SHLVL': '1', 14:15:42 INFO - 'TERM': 'linux', 14:15:42 INFO - 'TMOUT': '86400', 14:15:42 INFO - 'USER': 'cltbld', 14:15:42 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1463001323.518521-1744516563', 14:15:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:15:42 INFO - '_': '/tools/buildbot/bin/python'} 14:15:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:15:43 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 14:15:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:15:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:15:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:15:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:15:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:15:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:15:44 INFO - Downloading mozsystemmonitor-0.0.tar.gz 14:15:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:15:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 14:15:44 INFO - Installing collected packages: mozsystemmonitor 14:15:44 INFO - Running setup.py install for mozsystemmonitor 14:15:44 INFO - Successfully installed mozsystemmonitor 14:15:44 INFO - Cleaning up... 14:15:45 INFO - Return code: 0 14:15:45 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:15:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:15:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:15:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:15:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:15:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:15:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:15:45 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 0x7fb94ec91f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ef3770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f829c0>, '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 0x1f838c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f83d50>, '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': '1f5564757af27664ca02d71f000001b0-1463001323.518521-1744516563', '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 14:15:45 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 14:15:45 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 14:15:45 INFO - Using env: {'DISPLAY': ':0', 14:15:45 INFO - 'HOME': '/home/cltbld', 14:15:45 INFO - 'LANG': 'en_US.UTF-8', 14:15:45 INFO - 'LANGUAGE': 'en_US:en', 14:15:45 INFO - 'LOGNAME': 'cltbld', 14:15:45 INFO - 'MAIL': '/var/mail/cltbld', 14:15:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:15:45 INFO - 'MOZ_NO_REMOTE': '1', 14:15:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:15:45 INFO - 'NO_EM_RESTART': '1', 14:15:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:15:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:15:45 INFO - 'PWD': '/builds/slave/test', 14:15:45 INFO - 'SHELL': '/bin/bash', 14:15:45 INFO - 'SHLVL': '1', 14:15:45 INFO - 'TERM': 'linux', 14:15:45 INFO - 'TMOUT': '86400', 14:15:45 INFO - 'USER': 'cltbld', 14:15:45 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1463001323.518521-1744516563', 14:15:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:15:45 INFO - '_': '/tools/buildbot/bin/python'} 14:15:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:15:45 INFO - Downloading/unpacking blobuploader==1.2.4 14:15:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:15:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:15:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:15:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:15:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:15:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:15:47 INFO - Downloading blobuploader-1.2.4.tar.gz 14:15:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:15:47 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:15:47 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 14:15:47 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 14:15:47 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 14:15:47 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 14:15:47 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 14:15:47 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 14:15:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:15:47 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:15:47 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 14:15:47 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 14:15:47 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 14:15:47 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 14:15:47 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 14:15:47 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 14:15:47 INFO - Downloading docopt-0.6.1.tar.gz 14:15:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:15:47 INFO - Installing collected packages: blobuploader, requests, docopt 14:15:47 INFO - Running setup.py install for blobuploader 14:15:47 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:15:47 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:15:47 INFO - Running setup.py install for requests 14:15:48 INFO - Running setup.py install for docopt 14:15:48 INFO - Successfully installed blobuploader requests docopt 14:15:48 INFO - Cleaning up... 14:15:48 INFO - Return code: 0 14:15:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:15:48 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')]} 14:15:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:15:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:15:48 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')]} 14:15:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:15:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:15:48 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 0x7fb94ec91f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ef3770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f829c0>, '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 0x1f838c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f83d50>, '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': '1f5564757af27664ca02d71f000001b0-1463001323.518521-1744516563', '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 14:15:48 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 14:15:48 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 14:15:48 INFO - Using env: {'DISPLAY': ':0', 14:15:48 INFO - 'HOME': '/home/cltbld', 14:15:48 INFO - 'LANG': 'en_US.UTF-8', 14:15:48 INFO - 'LANGUAGE': 'en_US:en', 14:15:48 INFO - 'LOGNAME': 'cltbld', 14:15:48 INFO - 'MAIL': '/var/mail/cltbld', 14:15:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:15:48 INFO - 'MOZ_NO_REMOTE': '1', 14:15:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:15:48 INFO - 'NO_EM_RESTART': '1', 14:15:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:15:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:15:48 INFO - 'PWD': '/builds/slave/test', 14:15:48 INFO - 'SHELL': '/bin/bash', 14:15:48 INFO - 'SHLVL': '1', 14:15:48 INFO - 'TERM': 'linux', 14:15:48 INFO - 'TMOUT': '86400', 14:15:48 INFO - 'USER': 'cltbld', 14:15:48 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1463001323.518521-1744516563', 14:15:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:15:48 INFO - '_': '/tools/buildbot/bin/python'} 14:15:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:15:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:15:48 INFO - Running setup.py (path:/tmp/pip-9r6V2N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:15:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:15:48 INFO - Running setup.py (path:/tmp/pip-_UYOzf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:15:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:15:48 INFO - Running setup.py (path:/tmp/pip-QT3rrt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:15:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:15:48 INFO - Running setup.py (path:/tmp/pip-Kc_toz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:15:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:15:48 INFO - Running setup.py (path:/tmp/pip-9Y8_Hh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:15:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:15:48 INFO - Running setup.py (path:/tmp/pip-9aTO48-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:15:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:15:48 INFO - Running setup.py (path:/tmp/pip-5PD5mx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:15:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:15:48 INFO - Running setup.py (path:/tmp/pip-D92w_o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:15:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:15:48 INFO - Running setup.py (path:/tmp/pip-RK8nsX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:15:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:15:48 INFO - Running setup.py (path:/tmp/pip-yG5r5W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:15:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:15:49 INFO - Running setup.py (path:/tmp/pip-wFzAiw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:15:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:15:49 INFO - Running setup.py (path:/tmp/pip-IpoCvC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:15:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:15:49 INFO - Running setup.py (path:/tmp/pip-Easojf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:15:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:15:49 INFO - Running setup.py (path:/tmp/pip-uG3TIz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:15:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:15:49 INFO - Running setup.py (path:/tmp/pip-5ozFma-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:15:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:15:49 INFO - Running setup.py (path:/tmp/pip-VFVSWF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:15:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:15:49 INFO - Running setup.py (path:/tmp/pip-Ir64YA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:15:49 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:15:49 INFO - Running setup.py install for manifestparser 14:15:49 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:15:49 INFO - Running setup.py install for mozcrash 14:15:49 INFO - Running setup.py install for mozdebug 14:15:49 INFO - Running setup.py install for mozdevice 14:15:49 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:15:49 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:15:49 INFO - Running setup.py install for mozfile 14:15:49 INFO - Running setup.py install for mozhttpd 14:15:49 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:15:49 INFO - Running setup.py install for mozinfo 14:15:50 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:15:50 INFO - Running setup.py install for mozInstall 14:15:50 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:15:50 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:15:50 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:15:50 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:15:50 INFO - Running setup.py install for mozleak 14:15:50 INFO - Running setup.py install for mozlog 14:15:50 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:15:50 INFO - Running setup.py install for moznetwork 14:15:50 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:15:50 INFO - Running setup.py install for mozprocess 14:15:50 INFO - Running setup.py install for mozprofile 14:15:50 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:15:50 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:15:50 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:15:50 INFO - Running setup.py install for mozrunner 14:15:50 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:15:50 INFO - Running setup.py install for mozscreenshot 14:15:50 INFO - Running setup.py install for moztest 14:15:50 INFO - Running setup.py install for mozversion 14:15:51 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:15:51 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:15:51 INFO - Cleaning up... 14:15:51 INFO - Return code: 0 14:15:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:15:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:15:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:15:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:15:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:15:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:15:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:15:51 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 0x7fb94ec91f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ef3770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f829c0>, '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 0x1f838c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f83d50>, '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': '1f5564757af27664ca02d71f000001b0-1463001323.518521-1744516563', '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 14:15:51 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 14:15:51 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 14:15:51 INFO - Using env: {'DISPLAY': ':0', 14:15:51 INFO - 'HOME': '/home/cltbld', 14:15:51 INFO - 'LANG': 'en_US.UTF-8', 14:15:51 INFO - 'LANGUAGE': 'en_US:en', 14:15:51 INFO - 'LOGNAME': 'cltbld', 14:15:51 INFO - 'MAIL': '/var/mail/cltbld', 14:15:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:15:51 INFO - 'MOZ_NO_REMOTE': '1', 14:15:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:15:51 INFO - 'NO_EM_RESTART': '1', 14:15:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:15:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:15:51 INFO - 'PWD': '/builds/slave/test', 14:15:51 INFO - 'SHELL': '/bin/bash', 14:15:51 INFO - 'SHLVL': '1', 14:15:51 INFO - 'TERM': 'linux', 14:15:51 INFO - 'TMOUT': '86400', 14:15:51 INFO - 'USER': 'cltbld', 14:15:51 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1463001323.518521-1744516563', 14:15:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:15:51 INFO - '_': '/tools/buildbot/bin/python'} 14:15:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:15:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:15:51 INFO - Running setup.py (path:/tmp/pip-bC5BbN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:15:51 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)) 14:15:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:15:51 INFO - Running setup.py (path:/tmp/pip-k12sgm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:15:51 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)) 14:15:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:15:51 INFO - Running setup.py (path:/tmp/pip-xh73MZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:15:51 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)) 14:15:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:15:51 INFO - Running setup.py (path:/tmp/pip-EH2XP9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:15:51 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)) 14:15:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:15:51 INFO - Running setup.py (path:/tmp/pip-zJWaAB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:15:51 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)) 14:15:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:15:51 INFO - Running setup.py (path:/tmp/pip-Z_eUQR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:15:51 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)) 14:15:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:15:51 INFO - Running setup.py (path:/tmp/pip-922upD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:15:51 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)) 14:15:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:15:51 INFO - Running setup.py (path:/tmp/pip-33Kb3D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:15:51 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)) 14:15:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:15:51 INFO - Running setup.py (path:/tmp/pip-ctuvdu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:15:51 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)) 14:15:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:15:51 INFO - Running setup.py (path:/tmp/pip-mlch2l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:15:51 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)) 14:15:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:15:51 INFO - Running setup.py (path:/tmp/pip-UyDna_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:15:51 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)) 14:15:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:15:51 INFO - Running setup.py (path:/tmp/pip-SfR360-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:15:51 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)) 14:15:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:15:51 INFO - Running setup.py (path:/tmp/pip-OWeNlO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:15:52 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)) 14:15:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:15:52 INFO - Running setup.py (path:/tmp/pip-UGCke7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:15:52 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)) 14:15:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:15:52 INFO - Running setup.py (path:/tmp/pip-A_LXqN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:15:52 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)) 14:15:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:15:52 INFO - Running setup.py (path:/tmp/pip-NWlEe_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:15:52 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)) 14:15:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:15:52 INFO - Running setup.py (path:/tmp/pip-CV22dF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:15:52 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)) 14:15:52 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)) 14:15:52 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)) 14:15:52 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)) 14:15:52 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)) 14:15:52 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)) 14:15:52 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:15:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:15:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:15:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:15:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:15:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:15:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:15:54 INFO - Downloading blessings-1.6.tar.gz 14:15:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:15:54 INFO - Installing collected packages: blessings 14:15:54 INFO - Running setup.py install for blessings 14:15:54 INFO - Successfully installed blessings 14:15:54 INFO - Cleaning up... 14:15:54 INFO - Return code: 0 14:15:54 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:15:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:15:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:15:54 INFO - Reading from file tmpfile_stdout 14:15:54 INFO - Current package versions: 14:15:54 INFO - argparse == 1.2.1 14:15:54 INFO - blessings == 1.6 14:15:54 INFO - blobuploader == 1.2.4 14:15:54 INFO - docopt == 0.6.1 14:15:54 INFO - manifestparser == 1.1 14:15:54 INFO - mozInstall == 1.12 14:15:54 INFO - mozcrash == 0.17 14:15:54 INFO - mozdebug == 0.1 14:15:54 INFO - mozdevice == 0.48 14:15:54 INFO - mozfile == 1.2 14:15:54 INFO - mozhttpd == 0.7 14:15:54 INFO - mozinfo == 0.9 14:15:54 INFO - mozleak == 0.1 14:15:54 INFO - mozlog == 3.1 14:15:54 INFO - moznetwork == 0.27 14:15:54 INFO - mozprocess == 0.22 14:15:54 INFO - mozprofile == 0.28 14:15:54 INFO - mozrunner == 6.11 14:15:54 INFO - mozscreenshot == 0.1 14:15:54 INFO - mozsystemmonitor == 0.0 14:15:54 INFO - moztest == 0.7 14:15:54 INFO - mozversion == 1.4 14:15:54 INFO - psutil == 3.1.1 14:15:54 INFO - requests == 1.2.3 14:15:54 INFO - wsgiref == 0.1.2 14:15:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:15:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:15:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:15:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:15:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:15:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:15:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:15:54 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 0x7fb94ec91f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ef3770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f829c0>, '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 0x1f838c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f83d50>, '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': '1f5564757af27664ca02d71f000001b0-1463001323.518521-1744516563', '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 14:15:54 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 14:15:54 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 14:15:54 INFO - Using env: {'DISPLAY': ':0', 14:15:54 INFO - 'HOME': '/home/cltbld', 14:15:54 INFO - 'LANG': 'en_US.UTF-8', 14:15:54 INFO - 'LANGUAGE': 'en_US:en', 14:15:54 INFO - 'LOGNAME': 'cltbld', 14:15:54 INFO - 'MAIL': '/var/mail/cltbld', 14:15:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:15:54 INFO - 'MOZ_NO_REMOTE': '1', 14:15:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:15:54 INFO - 'NO_EM_RESTART': '1', 14:15:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:15:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:15:54 INFO - 'PWD': '/builds/slave/test', 14:15:54 INFO - 'SHELL': '/bin/bash', 14:15:54 INFO - 'SHLVL': '1', 14:15:54 INFO - 'TERM': 'linux', 14:15:54 INFO - 'TMOUT': '86400', 14:15:54 INFO - 'USER': 'cltbld', 14:15:54 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1463001323.518521-1744516563', 14:15:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:15:54 INFO - '_': '/tools/buildbot/bin/python'} 14:15:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:15:54 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)) 14:15:54 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)) 14:15:54 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)) 14:15:54 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)) 14:15:54 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)) 14:15:54 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)) 14:15:54 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)) 14:15:54 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)) 14:15:54 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)) 14:15:54 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)) 14:15:54 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)) 14:15:54 INFO - Cleaning up... 14:15:54 INFO - Return code: 0 14:15:54 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:15:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:15:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:15:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:15:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:15:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:15:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:15:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb94ec91f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ef3770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f829c0>, '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 0x1f838c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f83d50>, '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': '1f5564757af27664ca02d71f000001b0-1463001323.518521-1744516563', '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 14:15:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 14:15:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 14:15:54 INFO - Using env: {'DISPLAY': ':0', 14:15:54 INFO - 'HOME': '/home/cltbld', 14:15:54 INFO - 'LANG': 'en_US.UTF-8', 14:15:54 INFO - 'LANGUAGE': 'en_US:en', 14:15:54 INFO - 'LOGNAME': 'cltbld', 14:15:54 INFO - 'MAIL': '/var/mail/cltbld', 14:15:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:15:54 INFO - 'MOZ_NO_REMOTE': '1', 14:15:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:15:54 INFO - 'NO_EM_RESTART': '1', 14:15:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:15:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:15:54 INFO - 'PWD': '/builds/slave/test', 14:15:54 INFO - 'SHELL': '/bin/bash', 14:15:54 INFO - 'SHLVL': '1', 14:15:54 INFO - 'TERM': 'linux', 14:15:54 INFO - 'TMOUT': '86400', 14:15:54 INFO - 'USER': 'cltbld', 14:15:54 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1463001323.518521-1744516563', 14:15:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:15:54 INFO - '_': '/tools/buildbot/bin/python'} 14:15:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:15:54 INFO - Downloading/unpacking jsonschema 14:15:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:15:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:15:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:15:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:15:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:15:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:15:56 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:15:56 INFO - Downloading/unpacking functools32 (from jsonschema) 14:15:56 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 14:15:56 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 14:15:56 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 14:15:56 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 14:15:56 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 14:15:56 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 14:15:56 INFO - Downloading functools32-3.2.3-2.tar.gz 14:15:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:15:56 INFO - warning: no files found matching '*.txt' 14:15:56 INFO - no previously-included directories found matching 'build' 14:15:56 INFO - no previously-included directories found matching 'dist' 14:15:56 INFO - no previously-included directories found matching '.git*' 14:15:57 INFO - Installing collected packages: jsonschema, functools32 14:15:57 INFO - Running setup.py install for functools32 14:15:57 INFO - warning: no files found matching '*.txt' 14:15:57 INFO - no previously-included directories found matching 'build' 14:15:57 INFO - no previously-included directories found matching 'dist' 14:15:57 INFO - no previously-included directories found matching '.git*' 14:15:57 INFO - Successfully installed jsonschema functools32 14:15:57 INFO - Cleaning up... 14:15:57 INFO - Return code: 0 14:15:57 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 14:15:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:15:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:15:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:15:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:15:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:15:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:15:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb94ec91f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ef3770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f829c0>, '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 0x1f838c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f83d50>, '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': '1f5564757af27664ca02d71f000001b0-1463001323.518521-1744516563', '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 14:15:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 14:15:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 14:15:57 INFO - Using env: {'DISPLAY': ':0', 14:15:57 INFO - 'HOME': '/home/cltbld', 14:15:57 INFO - 'LANG': 'en_US.UTF-8', 14:15:57 INFO - 'LANGUAGE': 'en_US:en', 14:15:57 INFO - 'LOGNAME': 'cltbld', 14:15:57 INFO - 'MAIL': '/var/mail/cltbld', 14:15:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:15:57 INFO - 'MOZ_NO_REMOTE': '1', 14:15:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:15:57 INFO - 'NO_EM_RESTART': '1', 14:15:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:15:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:15:57 INFO - 'PWD': '/builds/slave/test', 14:15:57 INFO - 'SHELL': '/bin/bash', 14:15:57 INFO - 'SHLVL': '1', 14:15:57 INFO - 'TERM': 'linux', 14:15:57 INFO - 'TMOUT': '86400', 14:15:57 INFO - 'USER': 'cltbld', 14:15:57 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1463001323.518521-1744516563', 14:15:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:15:57 INFO - '_': '/tools/buildbot/bin/python'} 14:15:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:15:57 INFO - Downloading/unpacking flake8 14:15:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:15:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:15:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:15:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:15:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:15:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:15:59 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:15:59 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:15:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:15:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:15:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:15:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:15:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:15:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:15:59 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:15:59 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:15:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:15:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:15:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:15:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:15:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:15:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:15:59 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:15:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:15:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:15:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:15:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:15:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:15:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:15:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 14:15:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:15:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:15:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:15:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:15:59 INFO - no previously-included directories found matching 'docs/_build' 14:15:59 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:15:59 INFO - Running setup.py install for pep8 14:16:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:16:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:16:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:16:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:16:00 INFO - no previously-included directories found matching 'docs/_build' 14:16:00 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 14:16:00 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:16:00 INFO - Cleaning up... 14:16:00 INFO - Return code: 0 14:16:00 INFO - Running post-action listener: _resource_record_post_action 14:16:00 INFO - Running post-action listener: _start_resource_monitoring 14:16:00 INFO - Starting resource monitoring. 14:16:00 INFO - ##### 14:16:00 INFO - ##### Finished create-virtualenv step (success) 14:16:00 INFO - ##### 14:16:00 INFO - ##### 14:16:00 INFO - ##### Running install step. 14:16:00 INFO - ##### 14:16:00 INFO - Running pre-action listener: _resource_record_pre_action 14:16:00 INFO - Running main action method: install 14:16:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:16:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:16:00 INFO - Reading from file tmpfile_stdout 14:16:00 INFO - Detecting whether we're running mozinstall >=1.0... 14:16:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:16:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:16:00 INFO - Reading from file tmpfile_stdout 14:16:00 INFO - Output received: 14:16:00 INFO - Usage: mozinstall [options] installer 14:16:00 INFO - Options: 14:16:00 INFO - -h, --help show this help message and exit 14:16:00 INFO - -d DEST, --destination=DEST 14:16:00 INFO - Directory to install application into. [default: 14:16:00 INFO - "/builds/slave/test"] 14:16:00 INFO - --app=APP Application being installed. [default: firefox] 14:16:00 INFO - mkdir: /builds/slave/test/build/application 14:16:00 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'] 14:16:00 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 14:16:16 INFO - Reading from file tmpfile_stdout 14:16:16 INFO - Output received: 14:16:16 INFO - /builds/slave/test/build/application/firefox/firefox 14:16:16 INFO - Running post-action listener: _resource_record_post_action 14:16:16 INFO - ##### 14:16:16 INFO - ##### Finished install step (success) 14:16:16 INFO - ##### 14:16:16 INFO - ##### 14:16:16 INFO - ##### Running run-tests step. 14:16:16 INFO - ##### 14:16:16 INFO - Running pre-action listener: _resource_record_pre_action 14:16:16 INFO - Running main action method: run_tests 14:16:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:16:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:16:16 INFO - Python 2.7.3 14:16:16 INFO - Return code: 0 14:16:16 INFO - grabbing minidump binary from tooltool 14:16: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')]} 14:16:16 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: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f829c0>, '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 0x1f838c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f83d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:16:16 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 14:16:16 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 14:16:16 INFO - Calling ['/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'] with output_timeout 600 14:16:16 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:16:16 INFO - Return code: 0 14:16:16 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:16:16 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:16:16 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:16:16 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:16:16 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:16:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 14:16:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 14:16:17 INFO - Return code: 0 14:16:17 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/e1dwY0yBRbGlnhapsTkjpg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-027', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 14:16:17 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 --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/e1dwY0yBRbGlnhapsTkjpg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-027 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 14:16:17 INFO - Using env: {'DISPLAY': ':0', 14:16:17 INFO - 'HOME': '/home/cltbld', 14:16:17 INFO - 'LANG': 'en_US.UTF-8', 14:16:17 INFO - 'LANGUAGE': 'en_US:en', 14:16:17 INFO - 'LOGNAME': 'cltbld', 14:16:17 INFO - 'MAIL': '/var/mail/cltbld', 14:16:17 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:16:17 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:16:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:16:17 INFO - 'MOZ_NO_REMOTE': '1', 14:16:17 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:16:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:16:17 INFO - 'NO_EM_RESTART': '1', 14:16:17 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:16:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:16:17 INFO - 'PWD': '/builds/slave/test', 14:16:17 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:16:17 INFO - 'SHELL': '/bin/bash', 14:16:17 INFO - 'SHLVL': '1', 14:16:17 INFO - 'TERM': 'linux', 14:16:17 INFO - 'TMOUT': '86400', 14:16:17 INFO - 'USER': 'cltbld', 14:16:17 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1463001323.518521-1744516563', 14:16:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:16:17 INFO - '_': '/tools/buildbot/bin/python'} 14:16:17 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/e1dwY0yBRbGlnhapsTkjpg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-027', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 14:16:17 INFO - mozversion application_buildid: 20160511134706 14:16:17 INFO - mozversion application_changeset: 6afc5dab597975722542388390191a07ec0939d5 14:16:17 INFO - mozversion application_display_name: Nightly 14:16:17 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:16:17 INFO - mozversion application_name: Firefox 14:16:17 INFO - mozversion application_remotingname: firefox 14:16:17 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 14:16:17 INFO - mozversion application_vendor: Mozilla 14:16:17 INFO - mozversion application_version: 49.0a1 14:16:17 INFO - mozversion platform_buildid: 20160511134706 14:16:17 INFO - mozversion platform_changeset: 6afc5dab597975722542388390191a07ec0939d5 14:16:17 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 14:16:17 INFO - mozversion platform_version: 49.0a1 14:16:17 INFO - using testdate: 1463001377 14:16:17 INFO - actual date: 1463001377 14:16:17 INFO - starting webserver on 'localhost:43837' 14:16:17 INFO - SUITE-START | Running 2 tests 14:16:17 INFO - TEST-START | dromaeo_css 14:16:17 INFO - operating with platform_type : linux_ 14:16:17 INFO - Initialising browser for dromaeo_css test... 14:16:17 INFO - TEST-INFO | started process 8798 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmU1JFL/profile http://localhost:43837/getInfo.html) 14:16:21 INFO - PROCESS | 8798 | __metrics Screen width/height:1600/1200 14:16:21 INFO - PROCESS | 8798 | colorDepth:24 14:16:21 INFO - PROCESS | 8798 | Browser inner width/height: 1024/697 14:16:21 INFO - PROCESS | 8798 | __metrics 14:16:21 ERROR - PROCESS | 8798 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 14:16:22 INFO - TEST-INFO | 8798: exit 0 14:16:22 INFO - Browser initialized. 14:16:22 INFO - Running cycle 1/1 for dromaeo_css test... 14:16:22 INFO - TEST-INFO | started process 8876 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmU1JFL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:16:34 INFO - PROCESS | 8876 | RSS: Main: 153313280 14:16:34 INFO - PROCESS | 8876 | 14:17:25 INFO - PROCESS | 8876 | 1463001445837 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] 14:19:37 INFO - PROCESS | 8876 | Cycle 1(1): loaded http://localhost:43837/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43837/tests/dromaeo/cssquery-ext.html) 14:19:38 INFO - PROCESS | 8876 | RSS: Main: 234868736 14:19:38 INFO - PROCESS | 8876 | 14:22:40 INFO - PROCESS | 8876 | Cycle 1(1): loaded http://localhost:43837/tests/dromaeo/cssquery-ext.html (next: http://localhost:43837/tests/dromaeo/cssquery-jquery.html) 14:22:41 INFO - PROCESS | 8876 | RSS: Main: 236351488 14:22:41 INFO - PROCESS | 8876 | 14:25:43 INFO - PROCESS | 8876 | Cycle 1(1): loaded http://localhost:43837/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43837/tests/dromaeo/cssquery-mootools.html) 14:25:44 INFO - PROCESS | 8876 | RSS: Main: 235962368 14:25:44 INFO - PROCESS | 8876 | 14:28:46 INFO - PROCESS | 8876 | Cycle 1(1): loaded http://localhost:43837/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43837/tests/dromaeo/cssquery-prototype.html) 14:28:46 INFO - PROCESS | 8876 | RSS: Main: 231133184 14:28:46 INFO - PROCESS | 8876 | 14:31:49 INFO - PROCESS | 8876 | Cycle 1(1): loaded http://localhost:43837/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43837/tests/dromaeo/cssquery-yui.html) 14:31:50 INFO - PROCESS | 8876 | RSS: Main: 202944512 14:31:50 INFO - PROCESS | 8876 | 14:34:52 INFO - PROCESS | 8876 | Cycle 1(1): loaded http://localhost:43837/tests/dromaeo/cssquery-yui.html (next: http://localhost:43837/tests/dromaeo/cssquery-dojo.html) 14:34:53 INFO - PROCESS | 8876 | RSS: Main: 265535488 14:34:53 INFO - PROCESS | 8876 | 14:34:53 INFO - PROCESS | 8876 | __start_tp_report 14:34:53 INFO - PROCESS | 8876 | _x_x_mozilla_page_load 14:34:53 INFO - PROCESS | 8876 | _x_x_mozilla_page_load_details 14:34:53 INFO - PROCESS | 8876 | |i|pagename|runs| 14:34:53 INFO - PROCESS | 8876 | |0;dojo.html;2624.186502184323;2642.326206817261;2676;2685.409209973805;2690.596410538419;4631.8610441686715;4658.161530924433;4686.484486706459;4708.36437080994;4799.568038876505;4625.283081122423;4648.186567350708;4760.166970780108;4779.856604301868;4795.400574928125;4205.978970105145;4251.999999999992;4311.07311927937;4361.476622805268;4450.421445212118;4346.913061738764;4380.233459144652;4393.209222339993;4408.889777755566;4440.311751678495;4213.641840443566;4265.78671066447;4334.349847522865;4342.0013396918885;4377.5403582624;4327.134573085364;4343.283358245885;4348.717333373353;4385.627221686129;4391.143726973241;4364.018095928391;4370.278903980871;4382.408374869384;4407.713498622579;4425.7565833879125;4551.613112885409;4610.9308360374625;4653.674242803005;4662.906741865144;4663.60359369454;5144.305518754958;5147.022065807485;5149.588032957355;5151.278820965068;5177.715225662587;5076.187809950427;5108.795648174068;5151.150060240056;5183.844484665466;5203.271541984125;4621.907561848778;4725.716457012591;4810.759462026885;4822.541858523435;4859.781309840995;5290.391604965402;5305.761240744176;5339.065663508871;5362.088444964365;5372.979133964534;4889.266610008456;5075.492450754969;5124.461931497213;5134.204198349262;5148.253503242009;4976.178930476503;5005.924911126336;5038.546530812171;5041.168207245837;5062.367204099488;4990.800367985313;5003.799848006039;5013;5015.047141043263;5059.443461219263;4804.807807687724;4957.677750946177;4975.925361119586;4981.153203955337;5022.698638081727;4331.350297455344;4366.235908715962;4374.21264172452;4388.561143885586;4409.867703968886;3775.9433608495897;3787.14789172434;3795.1650636859845;3820.8471661133244;3837.270918525471;4161.542230354719;4200.558941311179;4278.379634952915;4359.651227901823;4377.890552736207;5039.899202015939;5042.445331013586;5051.090803655304;5062.519060689228;5113.15632920564;4294.613484786384;4301.956980430155;4303.182395344875;4306;4346.521882592912;4308.095299987038;4364.170807546556;4381.255186618282;4473.038296766211;4484.439445069366;4660.161170989254;4664.79008444614;4691.648126390534;4724.71651700899;4728.574428301469;4909.26361045846;4920.188168952082;4940.382452193476;4942.851714448572;4976.552110310089;4645.721256724607;4722.811087556459;4750.477447480844;4797.160496912957;4806.951930480651;4980.676256043491;5006.324146240211;5006.49935006511;5029.119904016709;5076.36545431821;5041.590384462269;5058.898822023465;5066.645334826527;5082.38005593007;5094.981003799181;4845.297431872429;4846.36997190363;4873.853784386474;4884.3650325457465;4903.04390643821;4865.245886887538;4907.533784290486;4914.8771280718265;4938.925916111333;4959.70241785494;4664.55686709762;4807.567318941312;4812.25410061441;4860.489648586989;4871.439784424837;4887.413510378778;4960.355153829979;4966.900661986668;4983.053219888209;4985.850424487271;4824.638152138534;4825.5174482551465;4836.709797412166;4842.128416884994;4884.218525035977 14:34:53 INFO - PROCESS | 8876 | |1;ext.html;568.991465128023;581.0267801432599;584.0567483514126;595.1905408644243;609.9085137229413;34560;38714.8064259679;38769;38941.80529097354;38976;39223.80388098056;39417.605823941754;39507.40738888919;39529;39584.604153958455;7338.266173382673;7515.210902855203;7614.923850761505;9745.805083898318;10066.597336106546;9891.159251463634;9946.353487023356;9973.90026099737;9999.800003999915;10013;7452.180260171377;9967.252456065788;10003.399796012263;10008.249381296395;10045.246606504505;9672.613095476172;10003.799924001552;10023.047810458067;10373.273870829045;10390.376577405379;9868.21054315653;9964;9966.302358834884;10012.89987100127;10023.44871032093;38248.42627360592;38479.422808657895;38680.41979370312;38705.806470967465;38786.61213387858;3144.5126005469187;3218.2919757653513;3252.1219270796987;3304.603447586305;3539.929201415983;29011.419771604662;29099.272518187005;29652;29856;30763.692363076305;3248.2204270974794;3267.281198136406;3267.3628642414737;3324.5511855899626;3327.8336083195745;230103;230682.84658576766;230976;231386;231735;52759.736201319516;53382;53610;53661.73169134207;53837;34151.82924085413;35267.647323526435;35383.29233415317;37215.25569488595;37271.62728372736;14211.50259740904;14329.64175895611;14337.426502939974;14360.425582976564;14442.350094245574;10945.124390048777;11102.666919992413;11106.888931110747;11132.666020019413;11134.61028864002;18941.90529047346;18970.52573685669;19021.904890475736;19065.854134068002;19116.2353505861;5811.476967072984;6948.687309071104;7181.994520767097;7227.060482137288;7339.88990165148;849.4775712936499;924.8658944453017;953.2278854128178;975.9609615615295;1064.4305296666246;26341.604875926878;27617;27790.583141252897;28273.43453130926;28440.431191376058;991.2169386184834;995.6963126246565;1012.427978192319;1019.4647809899861;1132.116948779953;14654.413823446943;14935.327910244065;15042.623934401508;15281.617959550878;15313.46402875894;356464;357683;361199;361787;365297;33196.3360732784;33353.3329333412;33388;33601;33617;1142.6914733022038;1199.8980086692554;1206.4148887789415;1275.7561377656896;1298.6298904812083;25655.743442565334;29278.8499722024;29281.85359073191;29757;29925.55111673283;43138.35292470553;53745.462545374045;55759.16361254503;55815.16277255763;55854.44145558492;322426;330129;330395;331314;333498;33805.3238935215;39771.40342894917;40087.59912400839;40537.59462405338;41171.176576468904;43678.56321436872;43693.56306436895;43997.34003990007;44417.77791111153;44460;36524.63475365318;37509.81245093757;37592.81203593964;37801;38449.80775096107;36032.81983590065;36089.45865811963;36969.075773104814;37167.25665486729;37200.25599487941;36312.818435907655;36540.45189322109;36944.81527592345;37168.44247336346;37352.62647373491;32328.83835580807;32754;33124.1718957028;33665.326693466486;33904.491432628034;24918.750812491642;24952.37619059538;25210;25618.743812561635;25774 14:34:53 INFO - PROCESS | 8876 | |2;jquery.html;377.55825683949774;382.0715660943906;384.5064755063413;391.7806028623971;396.50238950117597;15801.446949356774;17125.657486850254;17833.37583184589;17888.552786180353;17961.10194490275;16316;17095.487135385927;17104.914475427606;17333.306667733308;17357.82642173578;5077.213031980049;5232.136697444917;5233.058049551079;5268.236105764662;5344.4922732340365;3653.6894363979095;5244.501772331641;6031.819045428644;6037.094435834616;6128.601640893327;6016.067509536029;6018.909716354258;6047.7580896764075;6053.455189032986;6058.878822423549;5913.349531551526;5919.940800592003;5989.760409583633;6024.548158888079;6046.5767396281835;4757.976210118962;5312.574994000471;5327.413984461706;5337.946620533784;5349.14413693811;12447;12632.873671263353;12690.175138616052;12694.174878632952;12729.29988850622;1971.842252619787;1999.990000050005;2068.4725395024325;2220.7779222077825;2338.1933233034574;9062.320325975512;9067.138621830916;9201.769955751093;9540.904590954071;9665.758356041155;1596.162014942153;1598.8241293457827;1623.9525506048533;1633.2650307361735;1673.8158802531834;60312.69843650798;64412.67793661049;69273;69892.30107698908;69929;9698.95150524257;10022.398656080659;10173.186145108373;10186.185105191715;10298.794024119476;13880.93059534696;14084.2957852107;14111.294435278194;14133.363998620087;14205.78691319631;7522.210167932398;7572.5835079070075;7620.237976202336;7684.923150768421;7709.614519274014;7390.29792169743;7404.888926666104;7489.251074892467;7520.09758828944;7539.509931854412;4324.762138082373;4423.535528769497;4430.579094985971;4461.531539188403;4489.259272220047;1817.6637322095455;1857.1178690122083;1866.449397427762;1876.8404685601604;1882.6517094337592;825.4387016828614;854.6709516835939;890.8307421590007;911.1253196930888;942.7360339104924;16314.184290785413;16730.4144354947;16784.58038549046;16870.578235543962;17381.565460863327;896.9327300452362;899.7345782994032;900.2258058070055;900.3382513852313;909.8407778638845;7957.681692732226;9309.534523273946;9767.951160244153;9780.951095244478;9993.850092248622;383931;384898;386963;387250;394344;82643;83092;84162;84851;85212;892.0410558649348;893.4817805672694;956.067833861979;960.3386141974423;961.6730311694058;15309.770353444484;15668.294926728553;15725.292361843973;15999.12004839745;16182.757258641364;33046;34239.14402139966;34340.48489272613;34550.82724586462;35995.640043599225;48939.51060489492;49016;49521.75239123782;49601.26395576282;52684;7274.527155734861;7687.2697093776005;7701.576413297323;7770.611469426393;7836.882446763189;10072.395341517107;11686.649400517997;12138.453769580214;12348.506059757508;12382.318972456242;10590;10717.464126793786;10750.247482676137;10800.135989120694;10931.508082136164;10222.539985700512;10693.625723099654;10857.457127143769;10897.945510272715;10943.343399396063;10792;10821.621243256448;10845.240833141605;10895.836562451412;10948.616798412337;6847.657617119224;7877.133515313426;7940.285374316109;7964;7978.162292959156;10269.435181065113;10393.792124157626;10427.113695335982;10715.142788577052;10798.298110622783 14:34:53 INFO - PROCESS | 8876 | |3;mootools.html;1279.6608898641855;1463.0563286680087;1491.2394678713856;1635.3540351561135;1794.2284817528466;6661.134052573165;7611.885821712679;7895.447318687694;7897.644605992729;8199.91800081999;7810.648520816562;7999;8002.599870006506;8017.919820801791;8063.435559510836;1860.1815201311447;2159.4385459780415;2212.3031245157804;2239.2498512998163;2249.7975182233595;2244.820414366855;2267.7958983691465;2272.738635056973;2275.72691277047;2294.0135741631093;2191.7479489858633;2204.834637402201;2237.5524895021063;2239.317008312464;2258.0967612954787;1815.945521634353;2118.195085867368;2125.8724476531456;2172.2071443923014;2182.25803226902;2213.6236839737285;2219.223271854854;2219.87790671513;2230.7992280694652;2236.4185311818883;7887.408444366638;7918.920810791876;7932.960335198345;7941.523508589446;7959.0449146102255;4559.726416415026;4684.859454216379;4698.38920940279;4704.270838020112;4724.4094488188975;2802.8038037337396;2808.5085110105856;2848.9002884899137;2861.484932712111;2893.9131826045254;892.2861710631533;902.2376092202079;904.3895370624867;905.981880362389;921.2491819167424;9931.453770042644;9945.353552019023;9978.90021099787;10024.448655323955;10025.59897604095;4140.668746500272;4215.409842622035;4232.132412855357;4321.9135617287475;4322.805473753689;8522.403431759718;8575.571221438902;8576.699815506427;8631.180037896514;8645.049044605088;4505.954940450619;4521.751303678329;4549.977250113794;4554.544545545486;4559.54404559548;3544.291141771656;4223.97888010558;4334.609885110355;4390.824367025347;4415;3758.830852611639;3775.962240377561;3822.9235415291537;3844.1735026969336;3900.941485877714;1179.3749312864195;1259.2255762706054;1262.280500114944;1269.0672355818467;1274.2481935658006;810.0481933727846;810.2707563193173;896.9103089691109;928.8653145293895;930.7580029192324;5299.814506492331;5300.2049692546425;5426.321709786277;5438.954185656045;5658.519025882763;895.3732387328765;924.0343840686498;927.4667066436825;933.0576118120747;935.2658163341744;3714.68425183857;3852.325842977468;3880.2239552089695;3925.097227637659;3970.8411663533134;9424.62301507932;9788.119069283655;9850;9914.157296629723;10013.649522266685;9801.11789938909;9874.605015799287;9884.209263258923;9889.554970026365;9913.900860991442;7176.461765367619;7499.362554182955;7515.060617422822;7588.506747061423;7602.163761986177;5345.41200467956;5375.381831089475;5436.293281873332;5574.804881829116;5662.065759149694;8844.204021637826;8993.865092023756;9025.277977761632;9088.09119088086;9216.907830921606;8574.957125214334;9043.140901614335;9181.954090229774;9192;9274.489903055126;6030.638161710312;6297.307296197506;6343.714532845941;6433.678316084271;6608.669566521558;7763;7838.843223135619;7857.214278572097;7906.7627971160955;7913.525188488709;6967.686454109476;7130.572165670076;7180.281971802778;7253.694335019747;7292;7017.403520700594;7032.859342813217;7059.894101588377;7127.287271272831;7134.964325178341;6162.815115546541;6370.458511026614;6398.648074355769;6399.488040956805;6555.246146693191;4897.632677549127;4905.828296009622;4923.212286034217;4947.183714687037;5011.799528018839;4826.0830442215865;4845.709257444564;4870.561649451566;4873.147199240189;4943.505649435027 14:34:53 INFO - PROCESS | 8876 | |4;prototype.html;297.1812656132355;303.07108711798327;303.4371241347301;308.9320349523107;310.39163240049515;4619.953800461999;4647.23320652092;4661;4669.2062349400685;4690.765461726913;4609.815607375701;4609.838655647053;4621.976890115553;4622.6947732371345;4624.907501849961;3489.0056333944767;3569.5359603251673;3603.909732355228;3673.2286219893854;3695.316366472211;3659.0058418162166;3659.810561567488;3690.298843219793;3697.9075523112;3708;3450.7066899313463;3659.707223422133;3662.450632405134;3670.0915523927542;3677.227782165735;3512.822050328787;3602.35157671619;3607.3687104756696;3611.2596917632086;3612.837422316002;3245.6267529234206;3249.8375081245845;3249.9837500812346;3252;3258.478643417042;4397.8115865997215;4401.2395041983145;4401.713888597263;4404.581564751344;4413.7793110344355;4048.9595104048876;4108.650764685005;4137.234611596834;4143.7306575072525;4159.209750147463;4769.737664428455;4773.928391074137;4788.784504697297;4802.471728109905;4812.085703716282;3497.8600855965733;3511.3855075361707;3534.7879127252445;3540.5928318243473;3556.608773034964;4787.569118779326;5023.572996295283;5028.472010438888;5055.848324550233;5056.418511871145;3606.6753992140834;3607.9639203608153;3633.345997720383;3637.254362855608;3639.2159997601857;3657.1040095176318;3667.6149004354693;3669.7614655047337;3677.3380791457794;3677.687396571268;4116.670666346685;4120.093579412524;4121.567235440236;4127.772972486542;4132.111596006873;4628.4445866496235;4762.59517940972;4778.948631301108;4805.5915247204375;4834.516548345207;1231.7105480212322;1253.1541209683428;1256.8994480441543;1259.2444533279959;1263.879931406515;832.6835802395051;839.2488722593245;844.455326314536;863.4775960543781;887.9300442966211;4136.193442278727;4227.767472788964;4233.386159006988;4251.383549385384;4255.468066491689;4889.877753056131;4918.852434426973;4920.6801557898625;4934.432540257844;4961.479044700327;4082.857100001545;4179.97910010448;4213.620774130343;4228.302330115496;4274.081072569413;2587.624794404801;2608.9217323480325;2613.8954441822116;2617.6858776946506;2618.9738102619112;4591.79336929839;4636.11913736389;4654.301854721751;4657.557532034519;4665.367121507513;4804.174413722763;5016.824411145592;5017.623678224075;5027.120253955543;5054.498023478402;4623.329617205553;4624.5375462453485;4643.744594047293;4671.579557839811;4676.7661616919695;4834.154023046023;4834.7824347903725;4849.199882019428;4861.465238823797;4863.513648635108;4549.814170962656;4802.231642937113;4809;4821.46963833985;4849;4618;4666.230072038075;4666.580007799314;4675.812967481263;4692.436907571113;3622.7282953778044;3623.8912832615065;3641.927161456703;3643.817809109587;3650.9452358214116;4903.730294833818;4943.184374578154;4949.158643030765;4961.206207006861;4963.5780958618925;4677.485476597503;4772.809087636456;4793.089313030513;4801.735904525284;4810.446798618063;4714.740689262124;4734.171519984058;4738.431388233434;4745.810167593258;4771.091563374678;4669.252919532859;4675.812967481263;4686.835960741358;4702.365180700698;4702.576768090888;4320.4599425071865;4494.2135126352105;4520.796564154687;4785.688930219525;4867.975660121677;4681.297805329228;4740.976295118502;4742.359781429601;4750.026244619914;4764.976175119103 14:34:53 INFO - PROCESS | 8876 | |5;yui.html;743.0785825576286;750.2534977697192;788.0897563314373;800.4156965415247;811.0470197517911;11993.280403175815;12787.616371508859;12792.23246605202;12824.743505129893;12826.486940522367;12190.085743569223;12276.631701048982;12298.26210427375;12306.692332691688;12316.199447035937;669.1434963247052;831.3972370031739;856.687309132167;860.0711231869566;864.3301441382915;855.6021450025737;860.5396113079504;862.2024627219828;862.8490014247513;863.1282404771194;917.9724608261763;919.6919032124247;920.2086205862953;920.6455514626883;921.0973246218709;707.4941416886925;869.656485688156;898.3038145437273;900.1493588558815;907.7957459571544;665.1187176990459;669.1434963247052;671.412514050206;671.8824205763972;672.2000819025393;12698.301593412358;12762.872371276262;12811.359432028454;12832.871671283261;12878.29169395683;10816.621418250403;11943.820842687366;12323.938380308042;12353.75292494154;12619.558315459006;11106.722331941766;11110.222284440093;11243.100551955824;11303.943480282545;11606.36165010924;3958.5051868516434;4106.260873042851;4135.58644135587;4149.854755083557;4227.281362168408;42654.14691706149;43051.35422968658;43071.138577228594;43230;43441.56558434438;9788.265880058882;9861.063198996084;9883.308168428284;9982.900170998197;10046.99530047004;16729.49811505657;16747.33010679559;16755.413560525565;16792.160391980597;16934.745978810326;6650.567713098633;6676.799696009128;6700.798976030727;6762.425193858478;6958.860822783516;3710.962890371062;3734.5345226165578;3745;3781.8865434037025;3807.219519998449;2814.8451835149262;2906.3606006678497;2907.3749143934156;2910.2869796899895;2924.4151169766133;463.63372935381346;511.1897642237096;514.8995945790609;520.248241291338;521.5801279969585;565.7355809765171;578.5574035862569;590.3653572409677;603.2399177036965;619.6189343553772;7669.5398276103615;7678;7730.149683534807;7752.341051010614;7937.880931785912;533.66112518551;594.1948659566226;607.7629724407485;615.3876892491999;619.3031094800305;3260.250142467246;3498.317828023562;3667.8349474273723;3672.57765356982;3708.4066549352515;50976;53390.466095339325;56081;56792;56942.14586781202;48609;50207.74896125496;50411.243831341824;51519.48480515222;51753.22370164451;45191.322130168075;45670.543294567295;45788.3131753024;45803.77098114488;45999.540004600196;7409.407247420086;7564.092308922744;7576.507527010947;7668.194839541768;7756.92243077562;28181.295467613472;28662;30121.69878301189;30871.382572348877;31056.53415198819;36824.81587592045;36987.81506092452;37088.443673345464;37369.43945840869;37410;10682.519286631965;10790.622328218475;10830.566777329133;11017.779644407226;11044.447777611247;11014.614488492864;11292.548298067984;11497.94251028773;11624.54225246707;11752.11859110553;11128.833067503832;11216;11355.943220283845;11421.200515963803;11758.882411175779;10239.7440063999;10746.355218686904;10841.728956776144;11034.393108378796;11299.661010169708;9998.500224966314;10301.587936482456;10338.793224135325;10345.534450949575;10855.782884342427;9025;9378.765530861783;9405;9525.57134928916;9857.211423086279;9013.909860901307;9028.503432311023;9193.218576420812;9195.540222988957;9237.538123093953 14:34:53 INFO - PROCESS | 8876 | __end_tp_report 14:34:53 INFO - PROCESS | 8876 | __start_cc_report 14:34:53 INFO - PROCESS | 8876 | _x_x_mozilla_cycle_collect,792 14:34:53 INFO - PROCESS | 8876 | __end_cc_report 14:34:53 INFO - PROCESS | 8876 | __startTimestamp1463002493234__endTimestamp 14:34:53 INFO - PROCESS | 8876 | 14:34:53 INFO - PROCESS | 8876 | ------- Summary: start ------- 14:34:53 INFO - PROCESS | 8876 | Number of tests: 6 14:34:53 INFO - PROCESS | 8876 | 14:34:53 INFO - PROCESS | 8876 | [#0] dojo.html Cycles:165 Average:4667.42 Median:4804.81 stddev:492.45 (10.2%) stddev-sans-first:467.15 14:34:53 INFO - PROCESS | 8876 | Values: 2624.2 2642.3 2676.0 2685.4 2690.6 4631.9 4658.2 4686.5 4708.4 4799.6 4625.3 4648.2 4760.2 4779.9 4795.4 4206.0 4252.0 4311.1 4361.5 4450.4 4346.9 4380.2 4393.2 4408.9 4440.3 4213.6 4265.8 4334.3 4342.0 4377.5 4327.1 4343.3 4348.7 4385.6 4391.1 4364.0 4370.3 4382.4 4407.7 4425.8 4551.6 4610.9 4653.7 4662.9 4663.6 5144.3 5147.0 5149.6 5151.3 5177.7 5076.2 5108.8 5151.2 5183.8 5203.3 4621.9 4725.7 4810.8 4822.5 4859.8 5290.4 5305.8 5339.1 5362.1 5373.0 4889.3 5075.5 5124.5 5134.2 5148.3 4976.2 5005.9 5038.5 5041.2 5062.4 4990.8 5003.8 5013.0 5015.0 5059.4 4804.8 4957.7 4975.9 4981.2 5022.7 4331.4 4366.2 4374.2 4388.6 4409.9 3775.9 3787.1 3795.2 3820.8 3837.3 4161.5 4200.6 4278.4 4359.7 4377.9 5039.9 5042.4 5051.1 5062.5 5113.2 4294.6 4302.0 4303.2 4306.0 4346.5 4308.1 4364.2 4381.3 4473.0 4484.4 4660.2 4664.8 4691.6 4724.7 4728.6 4909.3 4920.2 4940.4 4942.9 4976.6 4645.7 4722.8 4750.5 4797.2 4807.0 4980.7 5006.3 5006.5 5029.1 5076.4 5041.6 5058.9 5066.6 5082.4 5095.0 4845.3 4846.4 4873.9 4884.4 4903.0 4865.2 4907.5 4914.9 4938.9 4959.7 4664.6 4807.6 4812.3 4860.5 4871.4 4887.4 4960.4 4966.9 4983.1 4985.9 4824.6 4825.5 4836.7 4842.1 4884.2 14:34:53 INFO - PROCESS | 8876 | 14:34:53 INFO - PROCESS | 8876 | [#1] ext.html Cycles:180 Average:46562.17 Median:34355.91 stddev:81829.35 (238.2%) stddev-sans-first:81986.03 14:34:53 INFO - PROCESS | 8876 | Values: 569.0 581.0 584.1 595.2 609.9 34560.0 38714.8 38769.0 38941.8 38976.0 39223.8 39417.6 39507.4 39529.0 39584.6 7338.3 7515.2 7614.9 9745.8 10066.6 9891.2 9946.4 9973.9 9999.8 10013.0 7452.2 9967.3 10003.4 10008.2 10045.2 9672.6 10003.8 10023.0 10373.3 10390.4 9868.2 9964.0 9966.3 10012.9 10023.4 38248.4 38479.4 38680.4 38705.8 38786.6 3144.5 3218.3 3252.1 3304.6 3539.9 29011.4 29099.3 29652.0 29856.0 30763.7 3248.2 3267.3 3267.4 3324.6 3327.8 230103.0 230682.8 230976.0 231386.0 231735.0 52759.7 53382.0 53610.0 53661.7 53837.0 34151.8 35267.6 35383.3 37215.3 37271.6 14211.5 14329.6 14337.4 14360.4 14442.4 10945.1 11102.7 11106.9 11132.7 11134.6 18941.9 18970.5 19021.9 19065.9 19116.2 5811.5 6948.7 7182.0 7227.1 7339.9 849.5 924.9 953.2 976.0 1064.4 26341.6 27617.0 27790.6 28273.4 28440.4 991.2 995.7 1012.4 1019.5 1132.1 14654.4 14935.3 15042.6 15281.6 15313.5 356464.0 357683.0 361199.0 361787.0 365297.0 33196.3 33353.3 33388.0 33601.0 33617.0 1142.7 1199.9 1206.4 1275.8 1298.6 25655.7 29278.8 29281.9 29757.0 29925.6 43138.4 53745.5 55759.2 55815.2 55854.4 322426.0 330129.0 330395.0 331314.0 333498.0 33805.3 39771.4 40087.6 40537.6 41171.2 43678.6 43693.6 43997.3 44417.8 44460.0 36524.6 37509.8 37592.8 37801.0 38449.8 36032.8 36089.5 36969.1 37167.3 37200.3 36312.8 36540.5 36944.8 37168.4 37352.6 32328.8 32754.0 33124.2 33665.3 33904.5 24918.8 24952.4 25210.0 25618.7 25774.0 14:34:53 INFO - PROCESS | 8876 | 14:34:53 INFO - PROCESS | 8876 | [#2] jquery.html Cycles:180 Average:24197.78 Median:4374.15 stddev:64092.71 (1465.3%) stddev-sans-first:64247.55 14:34:53 INFO - PROCESS | 8876 | Values: 377.6 382.1 384.5 391.8 396.5 15801.4 17125.7 17833.4 17888.6 17961.1 16316.0 17095.5 17104.9 17333.3 17357.8 5077.2 5232.1 5233.1 5268.2 5344.5 3653.7 5244.5 6031.8 6037.1 6128.6 6016.1 6018.9 6047.8 6053.5 6058.9 5913.3 5919.9 5989.8 6024.5 6046.6 4758.0 5312.6 5327.4 5337.9 5349.1 12447.0 12632.9 12690.2 12694.2 12729.3 1971.8 2000.0 2068.5 2220.8 2338.2 9062.3 9067.1 9201.8 9540.9 9665.8 1596.2 1598.8 1624.0 1633.3 1673.8 60312.7 64412.7 69273.0 69892.3 69929.0 9699.0 10022.4 10173.2 10186.2 10298.8 13880.9 14084.3 14111.3 14133.4 14205.8 7522.2 7572.6 7620.2 7684.9 7709.6 7390.3 7404.9 7489.3 7520.1 7539.5 4324.8 4423.5 4430.6 4461.5 4489.3 1817.7 1857.1 1866.4 1876.8 1882.7 825.4 854.7 890.8 911.1 942.7 16314.2 16730.4 16784.6 16870.6 17381.6 896.9 899.7 900.2 900.3 909.8 7957.7 9309.5 9768.0 9781.0 9993.9 383931.0 384898.0 386963.0 387250.0 394344.0 82643.0 83092.0 84162.0 84851.0 85212.0 892.0 893.5 956.1 960.3 961.7 15309.8 15668.3 15725.3 15999.1 16182.8 33046.0 34239.1 34340.5 34550.8 35995.6 48939.5 49016.0 49521.8 49601.3 52684.0 7274.5 7687.3 7701.6 7770.6 7836.9 10072.4 11686.6 12138.5 12348.5 12382.3 10590.0 10717.5 10750.2 10800.1 10931.5 10222.5 10693.6 10857.5 10897.9 10943.3 10792.0 10821.6 10845.2 10895.8 10948.6 6847.7 7877.1 7940.3 7964.0 7978.2 10269.4 10393.8 10427.1 10715.1 10798.3 14:34:53 INFO - PROCESS | 8876 | 14:34:53 INFO - PROCESS | 8876 | [#3] mootools.html Cycles:180 Average:5208.33 Median:5616.66 stddev:2861.44 (50.9%) stddev-sans-first:2854.23 14:34:53 INFO - PROCESS | 8876 | Values: 1279.7 1463.1 1491.2 1635.4 1794.2 6661.1 7611.9 7895.4 7897.6 8199.9 7810.6 7999.0 8002.6 8017.9 8063.4 1860.2 2159.4 2212.3 2239.2 2249.8 2244.8 2267.8 2272.7 2275.7 2294.0 2191.7 2204.8 2237.6 2239.3 2258.1 1815.9 2118.2 2125.9 2172.2 2182.3 2213.6 2219.2 2219.9 2230.8 2236.4 7887.4 7918.9 7933.0 7941.5 7959.0 4559.7 4684.9 4698.4 4704.3 4724.4 2802.8 2808.5 2848.9 2861.5 2893.9 892.3 902.2 904.4 906.0 921.2 9931.5 9945.4 9978.9 10024.4 10025.6 4140.7 4215.4 4232.1 4321.9 4322.8 8522.4 8575.6 8576.7 8631.2 8645.0 4506.0 4521.8 4550.0 4554.5 4559.5 3544.3 4224.0 4334.6 4390.8 4415.0 3758.8 3776.0 3822.9 3844.2 3900.9 1179.4 1259.2 1262.3 1269.1 1274.2 810.0 810.3 896.9 928.9 930.8 5299.8 5300.2 5426.3 5439.0 5658.5 895.4 924.0 927.5 933.1 935.3 3714.7 3852.3 3880.2 3925.1 3970.8 9424.6 9788.1 9850.0 9914.2 10013.6 9801.1 9874.6 9884.2 9889.6 9913.9 7176.5 7499.4 7515.1 7588.5 7602.2 5345.4 5375.4 5436.3 5574.8 5662.1 8844.2 8993.9 9025.3 9088.1 9216.9 8575.0 9043.1 9182.0 9192.0 9274.5 6030.6 6297.3 6343.7 6433.7 6608.7 7763.0 7838.8 7857.2 7906.8 7913.5 6967.7 7130.6 7180.3 7253.7 7292.0 7017.4 7032.9 7059.9 7127.3 7135.0 6162.8 6370.5 6398.6 6399.5 6555.2 4897.6 4905.8 4923.2 4947.2 5011.8 4826.1 4845.7 4870.6 4873.1 4943.5 14:34:53 INFO - PROCESS | 8876 | 14:34:53 INFO - PROCESS | 8876 | [#4] prototype.html Cycles:180 Average:4001.92 Median:4609.83 stddev:1133.07 (24.6%) stddev-sans-first:1101.60 14:34:53 INFO - PROCESS | 8876 | Values: 297.2 303.1 303.4 308.9 310.4 4620.0 4647.2 4661.0 4669.2 4690.8 4609.8 4609.8 4622.0 4622.7 4624.9 3489.0 3569.5 3603.9 3673.2 3695.3 3659.0 3659.8 3690.3 3697.9 3708.0 3450.7 3659.7 3662.5 3670.1 3677.2 3512.8 3602.4 3607.4 3611.3 3612.8 3245.6 3249.8 3250.0 3252.0 3258.5 4397.8 4401.2 4401.7 4404.6 4413.8 4049.0 4108.7 4137.2 4143.7 4159.2 4769.7 4773.9 4788.8 4802.5 4812.1 3497.9 3511.4 3534.8 3540.6 3556.6 4787.6 5023.6 5028.5 5055.8 5056.4 3606.7 3608.0 3633.3 3637.3 3639.2 3657.1 3667.6 3669.8 3677.3 3677.7 4116.7 4120.1 4121.6 4127.8 4132.1 4628.4 4762.6 4778.9 4805.6 4834.5 1231.7 1253.2 1256.9 1259.2 1263.9 832.7 839.2 844.5 863.5 887.9 4136.2 4227.8 4233.4 4251.4 4255.5 4889.9 4918.9 4920.7 4934.4 4961.5 4082.9 4180.0 4213.6 4228.3 4274.1 2587.6 2608.9 2613.9 2617.7 2619.0 4591.8 4636.1 4654.3 4657.6 4665.4 4804.2 5016.8 5017.6 5027.1 5054.5 4623.3 4624.5 4643.7 4671.6 4676.8 4834.2 4834.8 4849.2 4861.5 4863.5 4549.8 4802.2 4809.0 4821.5 4849.0 4618.0 4666.2 4666.6 4675.8 4692.4 3622.7 3623.9 3641.9 3643.8 3650.9 4903.7 4943.2 4949.2 4961.2 4963.6 4677.5 4772.8 4793.1 4801.7 4810.4 4714.7 4734.2 4738.4 4745.8 4771.1 4669.3 4675.8 4686.8 4702.4 4702.6 4320.5 4494.2 4520.8 4785.7 4868.0 4681.3 4741.0 4742.4 4750.0 4765.0 14:34:53 INFO - PROCESS | 8876 | 14:34:53 INFO - PROCESS | 8876 | [#5] yui.html Cycles:180 Average:12922.70 Median:45430.93 stddev:14842.84 (32.7%) stddev-sans-first:14856.29 14:34:53 INFO - PROCESS | 8876 | Values: 743.1 750.3 788.1 800.4 811.0 11993.3 12787.6 12792.2 12824.7 12826.5 12190.1 12276.6 12298.3 12306.7 12316.2 669.1 831.4 856.7 860.1 864.3 855.6 860.5 862.2 862.8 863.1 918.0 919.7 920.2 920.6 921.1 707.5 869.7 898.3 900.1 907.8 665.1 669.1 671.4 671.9 672.2 12698.3 12762.9 12811.4 12832.9 12878.3 10816.6 11943.8 12323.9 12353.8 12619.6 11106.7 11110.2 11243.1 11303.9 11606.4 3958.5 4106.3 4135.6 4149.9 4227.3 42654.1 43051.4 43071.1 43230.0 43441.6 9788.3 9861.1 9883.3 9982.9 10047.0 16729.5 16747.3 16755.4 16792.2 16934.7 6650.6 6676.8 6700.8 6762.4 6958.9 3711.0 3734.5 3745.0 3781.9 3807.2 2814.8 2906.4 2907.4 2910.3 2924.4 463.6 511.2 514.9 520.2 521.6 565.7 578.6 590.4 603.2 619.6 7669.5 7678.0 7730.1 7752.3 7937.9 533.7 594.2 607.8 615.4 619.3 3260.3 3498.3 3667.8 3672.6 3708.4 50976.0 53390.5 56081.0 56792.0 56942.1 48609.0 50207.7 50411.2 51519.5 51753.2 45191.3 45670.5 45788.3 45803.8 45999.5 7409.4 7564.1 7576.5 7668.2 7756.9 28181.3 28662.0 30121.7 30871.4 31056.5 36824.8 36987.8 37088.4 37369.4 37410.0 10682.5 10790.6 10830.6 11017.8 11044.4 11014.6 11292.5 11497.9 11624.5 11752.1 11128.8 11216.0 11355.9 11421.2 11758.9 10239.7 10746.4 10841.7 11034.4 11299.7 9998.5 10301.6 10338.8 10345.5 10855.8 9025.0 9378.8 9405.0 9525.6 9857.2 9013.9 9028.5 9193.2 9195.5 9237.5 14:34:53 INFO - PROCESS | 8876 | -------- Summary: end -------- 14:34:53 INFO - PROCESS | 8876 | 14:34:53 INFO - TEST-INFO | 8876: exit 0 14:34:53 INFO - TEST-OK | dromaeo_css | took 1116381ms 14:34:53 INFO - TEST-START | kraken 14:34:53 INFO - operating with platform_type : linux_ 14:34:53 INFO - Initialising browser for kraken test... 14:34:53 INFO - TEST-INFO | started process 9055 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4stb7D/profile http://localhost:43837/getInfo.html) 14:34:57 INFO - PROCESS | 9055 | __metrics Screen width/height:1600/1200 14:34:57 INFO - PROCESS | 9055 | colorDepth:24 14:34:57 INFO - PROCESS | 9055 | Browser inner width/height: 1024/697 14:34:57 INFO - PROCESS | 9055 | __metrics 14:34:58 ERROR - PROCESS | 9055 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 14:34:59 INFO - TEST-INFO | 9055: exit 0 14:34:59 INFO - Browser initialized. 14:34:59 INFO - Running cycle 1/1 for kraken test... 14:34:59 INFO - TEST-INFO | started process 9135 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4stb7D/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:35:10 INFO - PROCESS | 9135 | RSS: Main: 153157632 14:35:10 INFO - PROCESS | 9135 | 14:35:13 INFO - PROCESS | 9135 | Cycle 1(1): loaded http://localhost:43837/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43837/tests/kraken/driver.html?testName=audio-beat-detection) 14:35:14 INFO - PROCESS | 9135 | RSS: Main: 209240064 14:35:14 INFO - PROCESS | 9135 | 14:35:17 INFO - PROCESS | 9135 | Cycle 1(1): loaded http://localhost:43837/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43837/tests/kraken/driver.html?testName=audio-dft) 14:35:17 INFO - PROCESS | 9135 | RSS: Main: 197439488 14:35:17 INFO - PROCESS | 9135 | 14:35:21 INFO - PROCESS | 9135 | Cycle 1(1): loaded http://localhost:43837/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43837/tests/kraken/driver.html?testName=audio-fft) 14:35:21 INFO - PROCESS | 9135 | RSS: Main: 265670656 14:35:21 INFO - PROCESS | 9135 | 14:35:23 INFO - PROCESS | 9135 | Cycle 1(1): loaded http://localhost:43837/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43837/tests/kraken/driver.html?testName=audio-oscillator) 14:35:24 INFO - PROCESS | 9135 | RSS: Main: 174673920 14:35:24 INFO - PROCESS | 9135 | 14:35:26 INFO - PROCESS | 9135 | Cycle 1(1): loaded http://localhost:43837/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43837/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:35:27 INFO - PROCESS | 9135 | RSS: Main: 178528256 14:35:27 INFO - PROCESS | 9135 | 14:35:30 INFO - PROCESS | 9135 | Cycle 1(1): loaded http://localhost:43837/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43837/tests/kraken/driver.html?testName=imaging-darkroom) 14:35:31 INFO - PROCESS | 9135 | RSS: Main: 215093248 14:35:31 INFO - PROCESS | 9135 | 14:35:35 INFO - PROCESS | 9135 | Cycle 1(1): loaded http://localhost:43837/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43837/tests/kraken/driver.html?testName=imaging-desaturate) 14:35:35 INFO - PROCESS | 9135 | RSS: Main: 213630976 14:35:35 INFO - PROCESS | 9135 | 14:35:38 INFO - PROCESS | 9135 | Cycle 1(1): loaded http://localhost:43837/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43837/tests/kraken/driver.html?testName=json-parse-financial) 14:35:39 INFO - PROCESS | 9135 | RSS: Main: 213975040 14:35:39 INFO - PROCESS | 9135 | 14:35:41 INFO - PROCESS | 9135 | Cycle 1(1): loaded http://localhost:43837/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43837/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:35:41 INFO - PROCESS | 9135 | RSS: Main: 206934016 14:35:41 INFO - PROCESS | 9135 | 14:35:43 INFO - PROCESS | 9135 | Cycle 1(1): loaded http://localhost:43837/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43837/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:35:44 INFO - PROCESS | 9135 | RSS: Main: 210157568 14:35:44 INFO - PROCESS | 9135 | 14:35:46 INFO - PROCESS | 9135 | Cycle 1(1): loaded http://localhost:43837/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43837/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:35:47 INFO - PROCESS | 9135 | RSS: Main: 213356544 14:35:47 INFO - PROCESS | 9135 | 14:35:50 INFO - PROCESS | 9135 | Cycle 1(1): loaded http://localhost:43837/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43837/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:35:50 INFO - PROCESS | 9135 | RSS: Main: 217247744 14:35:50 INFO - PROCESS | 9135 | 14:35:53 INFO - PROCESS | 9135 | Cycle 1(1): loaded http://localhost:43837/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43837/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:35:54 INFO - PROCESS | 9135 | RSS: Main: 216363008 14:35:54 INFO - PROCESS | 9135 | 14:35:56 INFO - PROCESS | 9135 | Cycle 1(1): loaded http://localhost:43837/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43837/tests/kraken/driver.html?testName=ai-astar) 14:35:56 INFO - PROCESS | 9135 | RSS: Main: 262549504 14:35:56 INFO - PROCESS | 9135 | 14:35:56 INFO - PROCESS | 9135 | __start_tp_report 14:35:56 INFO - PROCESS | 9135 | _x_x_mozilla_page_load 14:35:56 INFO - PROCESS | 9135 | _x_x_mozilla_page_load_details 14:35:56 INFO - PROCESS | 9135 | |i|pagename|runs| 14:35:56 INFO - PROCESS | 9135 | |0;ai-astar;119;110;115;119;115;116;115;115;115;115 14:35:56 INFO - PROCESS | 9135 | |1;audio-beat-detection;159;136;157;218;136;158;161;138;187;144 14:35:56 INFO - PROCESS | 9135 | |2;audio-dft;163;163;162;162;163;163;162;162;163;161 14:35:56 INFO - PROCESS | 9135 | |3;audio-fft;77;78;78;150;80;76;80;79;129;77 14:35:56 INFO - PROCESS | 9135 | |4;audio-oscillator;94;95;147;95;95;95;119;108;94;117 14:35:56 INFO - PROCESS | 9135 | |5;imaging-gaussian-blur;118;118;118;118;119;117;118;118;119;117 14:35:56 INFO - PROCESS | 9135 | |6;imaging-darkroom;148;147;153;149;149;148;148;148;147;148 14:35:56 INFO - PROCESS | 9135 | |7;imaging-desaturate;95;95;96;96;95;96;96;96;96;95 14:35:56 INFO - PROCESS | 9135 | |8;json-parse-financial;67;68;67;66;68;67;66;68;66;66 14:35:56 INFO - PROCESS | 9135 | |9;json-stringify-tinderbox;65;65;64;64;66;64;64;64;65;65 14:35:56 INFO - PROCESS | 9135 | |10;stanford-crypto-aes;88;86;86;85;86;90;86;86;167;90 14:35:56 INFO - PROCESS | 9135 | |11;stanford-crypto-ccm;157;143;143;140;141;142;140;145;177;142 14:35:56 INFO - PROCESS | 9135 | |12;stanford-crypto-pbkdf2;183;180;181;177;180;180;180;181;179;178 14:35:56 INFO - PROCESS | 9135 | |13;stanford-crypto-sha256-iterative;73;72;72;71;72;74;70;70;69;69 14:35:56 INFO - PROCESS | 9135 | __end_tp_report 14:35:56 INFO - PROCESS | 9135 | __start_cc_report 14:35:56 INFO - PROCESS | 9135 | _x_x_mozilla_cycle_collect,1944 14:35:56 INFO - PROCESS | 9135 | __end_cc_report 14:35:56 INFO - PROCESS | 9135 | __startTimestamp1463002556392__endTimestamp 14:35:56 INFO - PROCESS | 9135 | 14:35:56 INFO - PROCESS | 9135 | ------- Summary: start ------- 14:35:56 INFO - PROCESS | 9135 | Number of tests: 14 14:35:56 INFO - PROCESS | 9135 | 14:35:56 INFO - PROCESS | 9135 | [#0] ai-astar Cycles:10 Average:115.40 Median:115.00 stddev:2.50 (2.2%) stddev-sans-first:2.29 14:35:56 INFO - PROCESS | 9135 | Values: 119.0 110.0 115.0 119.0 115.0 116.0 115.0 115.0 115.0 115.0 14:35:56 INFO - PROCESS | 9135 | 14:35:56 INFO - PROCESS | 9135 | [#1] audio-beat-detection Cycles:10 Average:159.40 Median:158.50 stddev:25.81 (16.3%) stddev-sans-first:27.38 14:35:56 INFO - PROCESS | 9135 | Values: 159.0 136.0 157.0 218.0 136.0 158.0 161.0 138.0 187.0 144.0 14:35:56 INFO - PROCESS | 9135 | 14:35:56 INFO - PROCESS | 9135 | [#2] audio-dft Cycles:10 Average:162.40 Median:163.00 stddev:0.70 (0.4%) stddev-sans-first:0.71 14:35:56 INFO - PROCESS | 9135 | Values: 163.0 163.0 162.0 162.0 163.0 163.0 162.0 162.0 163.0 161.0 14:35:56 INFO - PROCESS | 9135 | 14:35:56 INFO - PROCESS | 9135 | [#3] audio-fft Cycles:10 Average:90.40 Median:78.00 stddev:26.38 (33.8%) stddev-sans-first:27.53 14:35:56 INFO - PROCESS | 9135 | Values: 77.0 78.0 78.0 150.0 80.0 76.0 80.0 79.0 129.0 77.0 14:35:56 INFO - PROCESS | 9135 | 14:35:56 INFO - PROCESS | 9135 | [#4] audio-oscillator Cycles:10 Average:105.90 Median:94.50 stddev:17.47 (18.5%) stddev-sans-first:17.99 14:35:56 INFO - PROCESS | 9135 | Values: 94.0 95.0 147.0 95.0 95.0 95.0 119.0 108.0 94.0 117.0 14:35:56 INFO - PROCESS | 9135 | 14:35:56 INFO - PROCESS | 9135 | [#5] imaging-gaussian-blur Cycles:10 Average:118.00 Median:118.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 14:35:56 INFO - PROCESS | 9135 | Values: 118.0 118.0 118.0 118.0 119.0 117.0 118.0 118.0 119.0 117.0 14:35:56 INFO - PROCESS | 9135 | 14:35:56 INFO - PROCESS | 9135 | [#6] imaging-darkroom Cycles:10 Average:148.50 Median:148.00 stddev:1.72 (1.2%) stddev-sans-first:1.81 14:35:56 INFO - PROCESS | 9135 | Values: 148.0 147.0 153.0 149.0 149.0 148.0 148.0 148.0 147.0 148.0 14:35:56 INFO - PROCESS | 9135 | 14:35:56 INFO - PROCESS | 9135 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.52 (0.5%) stddev-sans-first:0.50 14:35:56 INFO - PROCESS | 9135 | Values: 95.0 95.0 96.0 96.0 95.0 96.0 96.0 96.0 96.0 95.0 14:35:56 INFO - PROCESS | 9135 | 14:35:56 INFO - PROCESS | 9135 | [#8] json-parse-financial Cycles:10 Average:66.90 Median:67.00 stddev:0.88 (1.3%) stddev-sans-first:0.93 14:35:56 INFO - PROCESS | 9135 | Values: 67.0 68.0 67.0 66.0 68.0 67.0 66.0 68.0 66.0 66.0 14:35:56 INFO - PROCESS | 9135 | 14:35:56 INFO - PROCESS | 9135 | [#9] json-stringify-tinderbox Cycles:10 Average:64.60 Median:65.00 stddev:0.70 (1.1%) stddev-sans-first:0.73 14:35:56 INFO - PROCESS | 9135 | Values: 65.0 65.0 64.0 64.0 66.0 64.0 64.0 64.0 65.0 65.0 14:35:56 INFO - PROCESS | 9135 | 14:35:56 INFO - PROCESS | 9135 | [#10] stanford-crypto-aes Cycles:10 Average:95.00 Median:86.00 stddev:25.36 (29.5%) stddev-sans-first:26.77 14:35:56 INFO - PROCESS | 9135 | Values: 88.0 86.0 86.0 85.0 86.0 90.0 86.0 86.0 167.0 90.0 14:35:56 INFO - PROCESS | 9135 | 14:35:56 INFO - PROCESS | 9135 | [#11] stanford-crypto-ccm Cycles:10 Average:147.00 Median:143.00 stddev:11.64 (8.1%) stddev-sans-first:11.77 14:35:56 INFO - PROCESS | 9135 | Values: 157.0 143.0 143.0 140.0 141.0 142.0 140.0 145.0 177.0 142.0 14:35:56 INFO - PROCESS | 9135 | 14:35:56 INFO - PROCESS | 9135 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:179.90 Median:180.00 stddev:1.66 (0.9%) stddev-sans-first:1.33 14:35:56 INFO - PROCESS | 9135 | Values: 183.0 180.0 181.0 177.0 180.0 180.0 180.0 181.0 179.0 178.0 14:35:56 INFO - PROCESS | 9135 | 14:35:56 INFO - PROCESS | 9135 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.20 Median:72.00 stddev:1.69 (2.3%) stddev-sans-first:1.66 14:35:56 INFO - PROCESS | 9135 | Values: 73.0 72.0 72.0 71.0 72.0 74.0 70.0 70.0 69.0 69.0 14:35:56 INFO - PROCESS | 9135 | -------- Summary: end -------- 14:35:56 INFO - PROCESS | 9135 | 14:35:57 INFO - TEST-INFO | 9135: exit 0 14:35:57 INFO - TEST-OK | kraken | took 63467ms 14:35:57 INFO - SUITE-END | took 1179s 14:35:57 INFO - Completed test suite (00:19:40) 14:35:57 INFO - javascript benchmark 14:35:57 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2624.186502184323, 2642.326206817261, 2676.0, 2685.409209973805, 2690.596410538419, 4631.8610441686715, 4658.161530924433, 4686.484486706459, 4708.36437080994, 4799.568038876505, 4625.283081122423, 4648.186567350708, 4760.166970780108, 4779.856604301868, 4795.400574928125, 4205.978970105145, 4251.999999999992, 4311.07311927937, 4361.476622805268, 4450.421445212118, 4346.913061738764, 4380.233459144652, 4393.209222339993, 4408.889777755566, 4440.311751678495, 4213.641840443566, 4265.78671066447, 4334.349847522865, 4342.0013396918885, 4377.5403582624, 4327.134573085364, 4343.283358245885, 4348.717333373353, 4385.627221686129, 4391.143726973241, 4364.018095928391, 4370.278903980871, 4382.408374869384, 4407.713498622579, 4425.7565833879125, 4551.613112885409, 4610.9308360374625, 4653.674242803005, 4662.906741865144, 4663.60359369454, 5144.305518754958, 5147.022065807485, 5149.588032957355, 5151.278820965068, 5177.715225662587, 5076.187809950427, 5108.795648174068, 5151.150060240056, 5183.844484665466, 5203.271541984125, 4621.907561848778, 4725.716457012591, 4810.759462026885, 4822.541858523435, 4859.781309840995, 5290.391604965402, 5305.761240744176, 5339.065663508871, 5362.088444964365, 5372.979133964534, 4889.266610008456, 5075.492450754969, 5124.461931497213, 5134.204198349262, 5148.253503242009, 4976.178930476503, 5005.924911126336, 5038.546530812171, 5041.168207245837, 5062.367204099488, 4990.800367985313, 5003.799848006039, 5013.0, 5015.047141043263, 5059.443461219263, 4804.807807687724, 4957.677750946177, 4975.925361119586, 4981.153203955337, 5022.698638081727, 4331.350297455344, 4366.235908715962, 4374.21264172452, 4388.561143885586, 4409.867703968886, 3775.9433608495897, 3787.14789172434, 3795.1650636859845, 3820.8471661133244, 3837.270918525471, 4161.542230354719, 4200.558941311179, 4278.379634952915, 4359.651227901823, 4377.890552736207, 5039.899202015939, 5042.445331013586, 5051.090803655304, 5062.519060689228, 5113.15632920564, 4294.613484786384, 4301.956980430155, 4303.182395344875, 4306.0, 4346.521882592912, 4308.095299987038, 4364.170807546556, 4381.255186618282, 4473.038296766211, 4484.439445069366, 4660.161170989254, 4664.79008444614, 4691.648126390534, 4724.71651700899, 4728.574428301469, 4909.26361045846, 4920.188168952082, 4940.382452193476, 4942.851714448572, 4976.552110310089, 4645.721256724607, 4722.811087556459, 4750.477447480844, 4797.160496912957, 4806.951930480651, 4980.676256043491, 5006.324146240211, 5006.49935006511, 5029.119904016709, 5076.36545431821, 5041.590384462269, 5058.898822023465, 5066.645334826527, 5082.38005593007, 5094.981003799181, 4845.297431872429, 4846.36997190363, 4873.853784386474, 4884.3650325457465, 4903.04390643821, 4865.245886887538, 4907.533784290486, 4914.8771280718265, 4938.925916111333, 4959.70241785494, 4664.55686709762, 4807.567318941312, 4812.25410061441, 4860.489648586989, 4871.439784424837, 4887.413510378778, 4960.355153829979, 4966.900661986668, 4983.053219888209, 4985.850424487271, 4824.638152138534, 4825.5174482551465, 4836.709797412166, 4842.128416884994, 4884.218525035977], "value": 4636.2944752278845, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [568.991465128023, 581.0267801432599, 584.0567483514126, 595.1905408644243, 609.9085137229413, 34560.0, 38714.8064259679, 38769.0, 38941.80529097354, 38976.0, 39223.80388098056, 39417.605823941754, 39507.40738888919, 39529.0, 39584.604153958455, 7338.266173382673, 7515.210902855203, 7614.923850761505, 9745.805083898318, 10066.597336106546, 9891.159251463634, 9946.353487023356, 9973.90026099737, 9999.800003999915, 10013.0, 7452.180260171377, 9967.252456065788, 10003.399796012263, 10008.249381296395, 10045.246606504505, 9672.613095476172, 10003.799924001552, 10023.047810458067, 10373.273870829045, 10390.376577405379, 9868.21054315653, 9964.0, 9966.302358834884, 10012.89987100127, 10023.44871032093, 38248.42627360592, 38479.422808657895, 38680.41979370312, 38705.806470967465, 38786.61213387858, 3144.5126005469187, 3218.2919757653513, 3252.1219270796987, 3304.603447586305, 3539.929201415983, 29011.419771604662, 29099.272518187005, 29652.0, 29856.0, 30763.692363076305, 3248.2204270974794, 3267.281198136406, 3267.3628642414737, 3324.5511855899626, 3327.8336083195745, 230103.0, 230682.84658576766, 230976.0, 231386.0, 231735.0, 52759.736201319516, 53382.0, 53610.0, 53661.73169134207, 53837.0, 34151.82924085413, 35267.647323526435, 35383.29233415317, 37215.25569488595, 37271.62728372736, 14211.50259740904, 14329.64175895611, 14337.426502939974, 14360.425582976564, 14442.350094245574, 10945.124390048777, 11102.666919992413, 11106.888931110747, 11132.666020019413, 11134.61028864002, 18941.90529047346, 18970.52573685669, 19021.904890475736, 19065.854134068002, 19116.2353505861, 5811.476967072984, 6948.687309071104, 7181.994520767097, 7227.060482137288, 7339.88990165148, 849.4775712936499, 924.8658944453017, 953.2278854128178, 975.9609615615295, 1064.4305296666246, 26341.604875926878, 27617.0, 27790.583141252897, 28273.43453130926, 28440.431191376058, 991.2169386184834, 995.6963126246565, 1012.427978192319, 1019.4647809899861, 1132.116948779953, 14654.413823446943, 14935.327910244065, 15042.623934401508, 15281.617959550878, 15313.46402875894, 356464.0, 357683.0, 361199.0, 361787.0, 365297.0, 33196.3360732784, 33353.3329333412, 33388.0, 33601.0, 33617.0, 1142.6914733022038, 1199.8980086692554, 1206.4148887789415, 1275.7561377656896, 1298.6298904812083, 25655.743442565334, 29278.8499722024, 29281.85359073191, 29757.0, 29925.55111673283, 43138.35292470553, 53745.462545374045, 55759.16361254503, 55815.16277255763, 55854.44145558492, 322426.0, 330129.0, 330395.0, 331314.0, 333498.0, 33805.3238935215, 39771.40342894917, 40087.59912400839, 40537.59462405338, 41171.176576468904, 43678.56321436872, 43693.56306436895, 43997.34003990007, 44417.77791111153, 44460.0, 36524.63475365318, 37509.81245093757, 37592.81203593964, 37801.0, 38449.80775096107, 36032.81983590065, 36089.45865811963, 36969.075773104814, 37167.25665486729, 37200.25599487941, 36312.818435907655, 36540.45189322109, 36944.81527592345, 37168.44247336346, 37352.62647373491, 32328.83835580807, 32754.0, 33124.1718957028, 33665.326693466486, 33904.491432628034, 24918.750812491642, 24952.37619059538, 25210.0, 25618.743812561635, 25774.0], "value": 18078.708318757257, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [377.55825683949774, 382.0715660943906, 384.5064755063413, 391.7806028623971, 396.50238950117597, 15801.446949356774, 17125.657486850254, 17833.37583184589, 17888.552786180353, 17961.10194490275, 16316.0, 17095.487135385927, 17104.914475427606, 17333.306667733308, 17357.82642173578, 5077.213031980049, 5232.136697444917, 5233.058049551079, 5268.236105764662, 5344.4922732340365, 3653.6894363979095, 5244.501772331641, 6031.819045428644, 6037.094435834616, 6128.601640893327, 6016.067509536029, 6018.909716354258, 6047.7580896764075, 6053.455189032986, 6058.878822423549, 5913.349531551526, 5919.940800592003, 5989.760409583633, 6024.548158888079, 6046.5767396281835, 4757.976210118962, 5312.574994000471, 5327.413984461706, 5337.946620533784, 5349.14413693811, 12447.0, 12632.873671263353, 12690.175138616052, 12694.174878632952, 12729.29988850622, 1971.842252619787, 1999.990000050005, 2068.4725395024325, 2220.7779222077825, 2338.1933233034574, 9062.320325975512, 9067.138621830916, 9201.769955751093, 9540.904590954071, 9665.758356041155, 1596.162014942153, 1598.8241293457827, 1623.9525506048533, 1633.2650307361735, 1673.8158802531834, 60312.69843650798, 64412.67793661049, 69273.0, 69892.30107698908, 69929.0, 9698.95150524257, 10022.398656080659, 10173.186145108373, 10186.185105191715, 10298.794024119476, 13880.93059534696, 14084.2957852107, 14111.294435278194, 14133.363998620087, 14205.78691319631, 7522.210167932398, 7572.5835079070075, 7620.237976202336, 7684.923150768421, 7709.614519274014, 7390.29792169743, 7404.888926666104, 7489.251074892467, 7520.09758828944, 7539.509931854412, 4324.762138082373, 4423.535528769497, 4430.579094985971, 4461.531539188403, 4489.259272220047, 1817.6637322095455, 1857.1178690122083, 1866.449397427762, 1876.8404685601604, 1882.6517094337592, 825.4387016828614, 854.6709516835939, 890.8307421590007, 911.1253196930888, 942.7360339104924, 16314.184290785413, 16730.4144354947, 16784.58038549046, 16870.578235543962, 17381.565460863327, 896.9327300452362, 899.7345782994032, 900.2258058070055, 900.3382513852313, 909.8407778638845, 7957.681692732226, 9309.534523273946, 9767.951160244153, 9780.951095244478, 9993.850092248622, 383931.0, 384898.0, 386963.0, 387250.0, 394344.0, 82643.0, 83092.0, 84162.0, 84851.0, 85212.0, 892.0410558649348, 893.4817805672694, 956.067833861979, 960.3386141974423, 961.6730311694058, 15309.770353444484, 15668.294926728553, 15725.292361843973, 15999.12004839745, 16182.757258641364, 33046.0, 34239.14402139966, 34340.48489272613, 34550.82724586462, 35995.640043599225, 48939.51060489492, 49016.0, 49521.75239123782, 49601.26395576282, 52684.0, 7274.527155734861, 7687.2697093776005, 7701.576413297323, 7770.611469426393, 7836.882446763189, 10072.395341517107, 11686.649400517997, 12138.453769580214, 12348.506059757508, 12382.318972456242, 10590.0, 10717.464126793786, 10750.247482676137, 10800.135989120694, 10931.508082136164, 10222.539985700512, 10693.625723099654, 10857.457127143769, 10897.945510272715, 10943.343399396063, 10792.0, 10821.621243256448, 10845.240833141605, 10895.836562451412, 10948.616798412337, 6847.657617119224, 7877.133515313426, 7940.285374316109, 7964.0, 7978.162292959156, 10269.435181065113, 10393.792124157626, 10427.113695335982, 10715.142788577052, 10798.298110622783], "value": 8263.535076479156, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1279.6608898641855, 1463.0563286680087, 1491.2394678713856, 1635.3540351561135, 1794.2284817528466, 6661.134052573165, 7611.885821712679, 7895.447318687694, 7897.644605992729, 8199.91800081999, 7810.648520816562, 7999.0, 8002.599870006506, 8017.919820801791, 8063.435559510836, 1860.1815201311447, 2159.4385459780415, 2212.3031245157804, 2239.2498512998163, 2249.7975182233595, 2244.820414366855, 2267.7958983691465, 2272.738635056973, 2275.72691277047, 2294.0135741631093, 2191.7479489858633, 2204.834637402201, 2237.5524895021063, 2239.317008312464, 2258.0967612954787, 1815.945521634353, 2118.195085867368, 2125.8724476531456, 2172.2071443923014, 2182.25803226902, 2213.6236839737285, 2219.223271854854, 2219.87790671513, 2230.7992280694652, 2236.4185311818883, 7887.408444366638, 7918.920810791876, 7932.960335198345, 7941.523508589446, 7959.0449146102255, 4559.726416415026, 4684.859454216379, 4698.38920940279, 4704.270838020112, 4724.4094488188975, 2802.8038037337396, 2808.5085110105856, 2848.9002884899137, 2861.484932712111, 2893.9131826045254, 892.2861710631533, 902.2376092202079, 904.3895370624867, 905.981880362389, 921.2491819167424, 9931.453770042644, 9945.353552019023, 9978.90021099787, 10024.448655323955, 10025.59897604095, 4140.668746500272, 4215.409842622035, 4232.132412855357, 4321.9135617287475, 4322.805473753689, 8522.403431759718, 8575.571221438902, 8576.699815506427, 8631.180037896514, 8645.049044605088, 4505.954940450619, 4521.751303678329, 4549.977250113794, 4554.544545545486, 4559.54404559548, 3544.291141771656, 4223.97888010558, 4334.609885110355, 4390.824367025347, 4415.0, 3758.830852611639, 3775.962240377561, 3822.9235415291537, 3844.1735026969336, 3900.941485877714, 1179.3749312864195, 1259.2255762706054, 1262.280500114944, 1269.0672355818467, 1274.2481935658006, 810.0481933727846, 810.2707563193173, 896.9103089691109, 928.8653145293895, 930.7580029192324, 5299.814506492331, 5300.2049692546425, 5426.321709786277, 5438.954185656045, 5658.519025882763, 895.3732387328765, 924.0343840686498, 927.4667066436825, 933.0576118120747, 935.2658163341744, 3714.68425183857, 3852.325842977468, 3880.2239552089695, 3925.097227637659, 3970.8411663533134, 9424.62301507932, 9788.119069283655, 9850.0, 9914.157296629723, 10013.649522266685, 9801.11789938909, 9874.605015799287, 9884.209263258923, 9889.554970026365, 9913.900860991442, 7176.461765367619, 7499.362554182955, 7515.060617422822, 7588.506747061423, 7602.163761986177, 5345.41200467956, 5375.381831089475, 5436.293281873332, 5574.804881829116, 5662.065759149694, 8844.204021637826, 8993.865092023756, 9025.277977761632, 9088.09119088086, 9216.907830921606, 8574.957125214334, 9043.140901614335, 9181.954090229774, 9192.0, 9274.489903055126, 6030.638161710312, 6297.307296197506, 6343.714532845941, 6433.678316084271, 6608.669566521558, 7763.0, 7838.843223135619, 7857.214278572097, 7906.7627971160955, 7913.525188488709, 6967.686454109476, 7130.572165670076, 7180.281971802778, 7253.694335019747, 7292.0, 7017.403520700594, 7032.859342813217, 7059.894101588377, 7127.287271272831, 7134.964325178341, 6162.815115546541, 6370.458511026614, 6398.648074355769, 6399.488040956805, 6555.246146693191, 4897.632677549127, 4905.828296009622, 4923.212286034217, 4947.183714687037, 5011.799528018839, 4826.0830442215865, 4845.709257444564, 4870.561649451566, 4873.147199240189, 4943.505649435027], "value": 4216.720669961203, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [297.1812656132355, 303.07108711798327, 303.4371241347301, 308.9320349523107, 310.39163240049515, 4619.953800461999, 4647.23320652092, 4661.0, 4669.2062349400685, 4690.765461726913, 4609.815607375701, 4609.838655647053, 4621.976890115553, 4622.6947732371345, 4624.907501849961, 3489.0056333944767, 3569.5359603251673, 3603.909732355228, 3673.2286219893854, 3695.316366472211, 3659.0058418162166, 3659.810561567488, 3690.298843219793, 3697.9075523112, 3708.0, 3450.7066899313463, 3659.707223422133, 3662.450632405134, 3670.0915523927542, 3677.227782165735, 3512.822050328787, 3602.35157671619, 3607.3687104756696, 3611.2596917632086, 3612.837422316002, 3245.6267529234206, 3249.8375081245845, 3249.9837500812346, 3252.0, 3258.478643417042, 4397.8115865997215, 4401.2395041983145, 4401.713888597263, 4404.581564751344, 4413.7793110344355, 4048.9595104048876, 4108.650764685005, 4137.234611596834, 4143.7306575072525, 4159.209750147463, 4769.737664428455, 4773.928391074137, 4788.784504697297, 4802.471728109905, 4812.085703716282, 3497.8600855965733, 3511.3855075361707, 3534.7879127252445, 3540.5928318243473, 3556.608773034964, 4787.569118779326, 5023.572996295283, 5028.472010438888, 5055.848324550233, 5056.418511871145, 3606.6753992140834, 3607.9639203608153, 3633.345997720383, 3637.254362855608, 3639.2159997601857, 3657.1040095176318, 3667.6149004354693, 3669.7614655047337, 3677.3380791457794, 3677.687396571268, 4116.670666346685, 4120.093579412524, 4121.567235440236, 4127.772972486542, 4132.111596006873, 4628.4445866496235, 4762.59517940972, 4778.948631301108, 4805.5915247204375, 4834.516548345207, 1231.7105480212322, 1253.1541209683428, 1256.8994480441543, 1259.2444533279959, 1263.879931406515, 832.6835802395051, 839.2488722593245, 844.455326314536, 863.4775960543781, 887.9300442966211, 4136.193442278727, 4227.767472788964, 4233.386159006988, 4251.383549385384, 4255.468066491689, 4889.877753056131, 4918.852434426973, 4920.6801557898625, 4934.432540257844, 4961.479044700327, 4082.857100001545, 4179.97910010448, 4213.620774130343, 4228.302330115496, 4274.081072569413, 2587.624794404801, 2608.9217323480325, 2613.8954441822116, 2617.6858776946506, 2618.9738102619112, 4591.79336929839, 4636.11913736389, 4654.301854721751, 4657.557532034519, 4665.367121507513, 4804.174413722763, 5016.824411145592, 5017.623678224075, 5027.120253955543, 5054.498023478402, 4623.329617205553, 4624.5375462453485, 4643.744594047293, 4671.579557839811, 4676.7661616919695, 4834.154023046023, 4834.7824347903725, 4849.199882019428, 4861.465238823797, 4863.513648635108, 4549.814170962656, 4802.231642937113, 4809.0, 4821.46963833985, 4849.0, 4618.0, 4666.230072038075, 4666.580007799314, 4675.812967481263, 4692.436907571113, 3622.7282953778044, 3623.8912832615065, 3641.927161456703, 3643.817809109587, 3650.9452358214116, 4903.730294833818, 4943.184374578154, 4949.158643030765, 4961.206207006861, 4963.5780958618925, 4677.485476597503, 4772.809087636456, 4793.089313030513, 4801.735904525284, 4810.446798618063, 4714.740689262124, 4734.171519984058, 4738.431388233434, 4745.810167593258, 4771.091563374678, 4669.252919532859, 4675.812967481263, 4686.835960741358, 4702.365180700698, 4702.576768090888, 4320.4599425071865, 4494.2135126352105, 4520.796564154687, 4785.688930219525, 4867.975660121677, 4681.297805329228, 4740.976295118502, 4742.359781429601, 4750.026244619914, 4764.976175119103], "value": 3648.806394590583, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [743.0785825576286, 750.2534977697192, 788.0897563314373, 800.4156965415247, 811.0470197517911, 11993.280403175815, 12787.616371508859, 12792.23246605202, 12824.743505129893, 12826.486940522367, 12190.085743569223, 12276.631701048982, 12298.26210427375, 12306.692332691688, 12316.199447035937, 669.1434963247052, 831.3972370031739, 856.687309132167, 860.0711231869566, 864.3301441382915, 855.6021450025737, 860.5396113079504, 862.2024627219828, 862.8490014247513, 863.1282404771194, 917.9724608261763, 919.6919032124247, 920.2086205862953, 920.6455514626883, 921.0973246218709, 707.4941416886925, 869.656485688156, 898.3038145437273, 900.1493588558815, 907.7957459571544, 665.1187176990459, 669.1434963247052, 671.412514050206, 671.8824205763972, 672.2000819025393, 12698.301593412358, 12762.872371276262, 12811.359432028454, 12832.871671283261, 12878.29169395683, 10816.621418250403, 11943.820842687366, 12323.938380308042, 12353.75292494154, 12619.558315459006, 11106.722331941766, 11110.222284440093, 11243.100551955824, 11303.943480282545, 11606.36165010924, 3958.5051868516434, 4106.260873042851, 4135.58644135587, 4149.854755083557, 4227.281362168408, 42654.14691706149, 43051.35422968658, 43071.138577228594, 43230.0, 43441.56558434438, 9788.265880058882, 9861.063198996084, 9883.308168428284, 9982.900170998197, 10046.99530047004, 16729.49811505657, 16747.33010679559, 16755.413560525565, 16792.160391980597, 16934.745978810326, 6650.567713098633, 6676.799696009128, 6700.798976030727, 6762.425193858478, 6958.860822783516, 3710.962890371062, 3734.5345226165578, 3745.0, 3781.8865434037025, 3807.219519998449, 2814.8451835149262, 2906.3606006678497, 2907.3749143934156, 2910.2869796899895, 2924.4151169766133, 463.63372935381346, 511.1897642237096, 514.8995945790609, 520.248241291338, 521.5801279969585, 565.7355809765171, 578.5574035862569, 590.3653572409677, 603.2399177036965, 619.6189343553772, 7669.5398276103615, 7678.0, 7730.149683534807, 7752.341051010614, 7937.880931785912, 533.66112518551, 594.1948659566226, 607.7629724407485, 615.3876892491999, 619.3031094800305, 3260.250142467246, 3498.317828023562, 3667.8349474273723, 3672.57765356982, 3708.4066549352515, 50976.0, 53390.466095339325, 56081.0, 56792.0, 56942.14586781202, 48609.0, 50207.74896125496, 50411.243831341824, 51519.48480515222, 51753.22370164451, 45191.322130168075, 45670.543294567295, 45788.3131753024, 45803.77098114488, 45999.540004600196, 7409.407247420086, 7564.092308922744, 7576.507527010947, 7668.194839541768, 7756.92243077562, 28181.295467613472, 28662.0, 30121.69878301189, 30871.382572348877, 31056.53415198819, 36824.81587592045, 36987.81506092452, 37088.443673345464, 37369.43945840869, 37410.0, 10682.519286631965, 10790.622328218475, 10830.566777329133, 11017.779644407226, 11044.447777611247, 11014.614488492864, 11292.548298067984, 11497.94251028773, 11624.54225246707, 11752.11859110553, 11128.833067503832, 11216.0, 11355.943220283845, 11421.200515963803, 11758.882411175779, 10239.7440063999, 10746.355218686904, 10841.728956776144, 11034.393108378796, 11299.661010169708, 9998.500224966314, 10301.587936482456, 10338.793224135325, 10345.534450949575, 10855.782884342427, 9025.0, 9378.765530861783, 9405.0, 9525.57134928916, 9857.211423086279, 9013.909860901307, 9028.503432311023, 9193.218576420812, 9195.540222988957, 9237.538123093953], "value": 6027.324915809055, "unit": "score"}], "name": "dromaeo_css", "value": 6328.505806833039, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 110.0, 115.0, 119.0, 115.0, 116.0, 115.0, 115.0, 115.0, 115.0], "value": 115.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 136.0, 157.0, 218.0, 136.0, 158.0, 161.0, 138.0, 187.0, 144.0], "value": 159.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 162.0, 162.0, 163.0, 163.0, 162.0, 162.0, 163.0, 161.0], "value": 162.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 78.0, 78.0, 150.0, 80.0, 76.0, 80.0, 79.0, 129.0, 77.0], "value": 90.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 147.0, 95.0, 95.0, 95.0, 119.0, 108.0, 94.0, 117.0], "value": 105.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 118.0, 119.0, 117.0, 118.0, 118.0, 119.0, 117.0], "value": 118.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 153.0, 149.0, 149.0, 148.0, 148.0, 148.0, 147.0, 148.0], "value": 148.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 96.0, 95.0, 96.0, 96.0, 96.0, 96.0, 95.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 67.0, 66.0, 68.0, 67.0, 66.0, 68.0, 66.0, 66.0], "value": 66.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 64.0, 64.0, 66.0, 64.0, 64.0, 64.0, 65.0, 65.0], "value": 64.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 86.0, 86.0, 85.0, 86.0, 90.0, 86.0, 86.0, 167.0, 90.0], "value": 95.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 143.0, 143.0, 140.0, 141.0, 142.0, 140.0, 145.0, 177.0, 142.0], "value": 147.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 180.0, 181.0, 177.0, 180.0, 180.0, 180.0, 181.0, 179.0, 178.0], "value": 179.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 72.0, 72.0, 71.0, 72.0, 74.0, 70.0, 70.0, 69.0, 69.0], "value": 71.2, "unit": "score"}], "name": "kraken", "value": 1620.2, "alertThreshold": 2.0}]} 14:35:57 INFO - Return code: 0 14:35:57 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 14:35:57 ERROR - # TBPL SUCCESS # 14:35:57 INFO - Running post-action listener: _resource_record_post_action 14:35:57 INFO - ##### 14:35:57 INFO - ##### Finished run-tests step (success) 14:35:57 INFO - ##### 14:35:57 INFO - Running post-run listener: _resource_record_post_run 14:35:58 INFO - Total resource usage - Wall time: 1197s; CPU: 26.0%; Read bytes: 4096; Write bytes: 520880128; Read time: 20; Write time: 406376 14:35:58 INFO - install - Wall time: 16s; CPU: 26.0%; Read bytes: 0; Write bytes: 234139648; Read time: 0; Write time: 218412 14:35:58 INFO - run-tests - Wall time: 1181s; CPU: 26.0%; Read bytes: 4096; Write bytes: 285495296; Read time: 20; Write time: 187956 14:35:58 INFO - Running post-run listener: _upload_blobber_files 14:35:58 INFO - Blob upload gear active. 14:35:58 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:35:58 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 14:35:58 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'] 14:35:58 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 14:35:59 INFO - (blobuploader) - INFO - Open directory for files ... 14:35:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:35:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:35:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:35:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:35:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:35:59 INFO - (blobuploader) - INFO - Done attempting. 14:35:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:35:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:35:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:36:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:36:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:36:00 INFO - (blobuploader) - INFO - Done attempting. 14:36:00 INFO - (blobuploader) - INFO - Iteration through files over. 14:36:00 INFO - Return code: 0 14:36:00 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:36:00 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:36:00 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7dca74a86d53ebf3e9d4924586151a0748c4a03ae7c9234e0aa1a87c3e9d80dcb40e9695a466d19b9c7514d0191b7535401d1708b4734bc0c5050b4e1a036edf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/bbe54443277e1cbca99295d8117cb975344044f589776b8777512ebf09fa584a6d734140d55b3785d19e86d67710ac837d92b5de2f55187f9c2e8060d4192730"} 14:36:00 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:36:00 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:36:00 INFO - Contents: 14:36:00 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7dca74a86d53ebf3e9d4924586151a0748c4a03ae7c9234e0aa1a87c3e9d80dcb40e9695a466d19b9c7514d0191b7535401d1708b4734bc0c5050b4e1a036edf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/bbe54443277e1cbca99295d8117cb975344044f589776b8777512ebf09fa584a6d734140d55b3785d19e86d67710ac837d92b5de2f55187f9c2e8060d4192730"} 14:36:00 INFO - Running post-run listener: copy_logs_to_upload_dir 14:36:00 INFO - Copying logs to upload dir... 14:36:00 INFO - mkdir: /builds/slave/test/build/upload/logs 14:36:00 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.284088 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-05-11 14:36:00.491420) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-11 14:36:00.495250) ========= 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=1f5564757af27664ca02d71f000001b0-1463001323.518521-1744516563 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7dca74a86d53ebf3e9d4924586151a0748c4a03ae7c9234e0aa1a87c3e9d80dcb40e9695a466d19b9c7514d0191b7535401d1708b4734bc0c5050b4e1a036edf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/bbe54443277e1cbca99295d8117cb975344044f589776b8777512ebf09fa584a6d734140d55b3785d19e86d67710ac837d92b5de2f55187f9c2e8060d4192730"} build_url:https://queue.taskcluster.net/v1/task/e1dwY0yBRbGlnhapsTkjpg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.005467 build_url: 'https://queue.taskcluster.net/v1/task/e1dwY0yBRbGlnhapsTkjpg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7dca74a86d53ebf3e9d4924586151a0748c4a03ae7c9234e0aa1a87c3e9d80dcb40e9695a466d19b9c7514d0191b7535401d1708b4734bc0c5050b4e1a036edf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/bbe54443277e1cbca99295d8117cb975344044f589776b8777512ebf09fa584a6d734140d55b3785d19e86d67710ac837d92b5de2f55187f9c2e8060d4192730"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-11 14:36:00.509015) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 14:36:00.509318) ========= 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=1f5564757af27664ca02d71f000001b0-1463001323.518521-1744516563 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.002095 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 14:36:00.591548) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-11 14:36:00.591909) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-11 14:36:00.592223) ========= ========= Total master_lag: 0.86 =========