builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-018 starttime: 1461477273.38 results: success (0) buildid: 20160423222844 builduid: 51f228ff267a4947b06c230953386aaf revision: f47b31f50a9a82984640ff6e17a86239808c8e15 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-23 22:54:33.384691) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-23 22:54:33.385838) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-23 22:54:33.386143) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-23 22:54:33.402309) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-23 22:54:33.402585) ========= 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=62c568580acbfdaac3eec7be000001dc-1461477200.728732-1341828549 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-23 22:54:33-- 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% 43.1M=0s 2016-04-23 22:54:34 (43.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.143926 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-23 22:54:33.559100) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-23 22:54:33.559378) ========= 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=62c568580acbfdaac3eec7be000001dc-1461477200.728732-1341828549 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016457 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-23 22:54:33.608655) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-23 22:54:33.609011) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev f47b31f50a9a82984640ff6e17a86239808c8e15 --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 f47b31f50a9a82984640ff6e17a86239808c8e15 --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=62c568580acbfdaac3eec7be000001dc-1461477200.728732-1341828549 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-23 22:54:34,135 truncating revision to first 12 chars 2016-04-23 22:54:34,135 Setting DEBUG logging. 2016-04-23 22:54:34,135 attempt 1/10 2016-04-23 22:54:34,135 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/f47b31f50a9a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-23 22:54:34,391 unpacking tar archive at: fx-team-f47b31f50a9a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.520286 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-23 22:54:34.141742) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-23 22:54:34.142052) ========= script_repo_revision: f47b31f50a9a82984640ff6e17a86239808c8e15 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-23 22:54:34.142422) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-23 22:54:34.142679) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-23 22:54:34.151092) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-04-23 22:54:34.151353) ========= /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=62c568580acbfdaac3eec7be000001dc-1461477200.728732-1341828549 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:54:34 INFO - MultiFileLogger online at 20160423 22:54:34 in /builds/slave/test 22:54:34 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 22:54:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:54:34 INFO - {'append_to_log': False, 22:54:34 INFO - 'base_work_dir': '/builds/slave/test', 22:54:34 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 22:54:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:54:34 INFO - 'branch': 'Fx-Team-Non-PGO', 22:54:34 INFO - 'buildbot_json_path': 'buildprops.json', 22:54:34 INFO - 'config_files': ('talos/linux_config.py',), 22:54:34 INFO - 'default_actions': ('clobber', 22:54:34 INFO - 'read-buildbot-config', 22:54:34 INFO - 'download-and-extract', 22:54:34 INFO - 'populate-webroot', 22:54:34 INFO - 'create-virtualenv', 22:54:34 INFO - 'install', 22:54:34 INFO - 'run-tests'), 22:54:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:54:34 INFO - 'download_minidump_stackwalk': True, 22:54:34 INFO - 'download_symbols': 'ondemand', 22:54:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:54:34 INFO - 'tooltool.py': '/tools/tooltool.py', 22:54:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:54:34 INFO - '/tools/misc-python/virtualenv.py')}, 22:54:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:54:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:54:34 INFO - 'installer_path': 'installer.exe', 22:54:34 INFO - 'log_level': 'info', 22:54:34 INFO - 'log_name': 'talos', 22:54:34 INFO - 'log_to_console': True, 22:54:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:54:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:54:34 INFO - 'opt_config_files': (), 22:54:34 INFO - 'pip_index': False, 22:54:34 INFO - 'sps_profile': False, 22:54:34 INFO - 'sps_profile_interval': 0, 22:54:34 INFO - 'suite': 'dromaeojs', 22:54:34 INFO - 'system_bits': '32', 22:54:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:54:34 INFO - 'title': 'talos-linux64-ix-018', 22:54:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:54:34 INFO - 'use_talos_json': True, 22:54:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:54:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:54:34 INFO - 'work_dir': 'build'} 22:54:34 INFO - ##### 22:54:34 INFO - ##### Running clobber step. 22:54:34 INFO - ##### 22:54:34 INFO - Running pre-action listener: _resource_record_pre_action 22:54:34 INFO - Running main action method: clobber 22:54:34 INFO - rmtree: /builds/slave/test/build 22:54:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:54:35 INFO - Running post-action listener: _resource_record_post_action 22:54:35 INFO - ##### 22:54:35 INFO - ##### Running read-buildbot-config step. 22:54:35 INFO - ##### 22:54:35 INFO - Running pre-action listener: _resource_record_pre_action 22:54:35 INFO - Running main action method: read_buildbot_config 22:54:35 INFO - Using buildbot properties: 22:54:35 INFO - { 22:54:35 INFO - "project": "", 22:54:35 INFO - "product": "firefox", 22:54:35 INFO - "script_repo_revision": "production", 22:54:35 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 22:54:35 INFO - "repository": "", 22:54:35 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 22:54:35 INFO - "buildid": "20160423222844", 22:54:35 INFO - "pgo_build": "False", 22:54:35 INFO - "basedir": "/builds/slave/test", 22:54:35 INFO - "buildnumber": 1593, 22:54:35 INFO - "slavename": "talos-linux64-ix-018", 22:54:35 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 22:54:35 INFO - "platform": "ubuntu64_hw", 22:54:35 INFO - "scheduler": "tests-fx-team-linux64-talos", 22:54:35 INFO - "branch": "fx-team", 22:54:35 INFO - "repo_path": "integration/fx-team", 22:54:35 INFO - "revision": "f47b31f50a9a82984640ff6e17a86239808c8e15", 22:54:35 INFO - "stage_platform": "linux64", 22:54:35 INFO - "builduid": "51f228ff267a4947b06c230953386aaf", 22:54:35 INFO - "slavebuilddir": "test" 22:54:35 INFO - } 22:54:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/f6WITnP9SIGtvgkwW8lo3g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 22:54:35 INFO - Running post-action listener: _resource_record_post_action 22:54:35 INFO - ##### 22:54:35 INFO - ##### Running download-and-extract step. 22:54:35 INFO - ##### 22:54:35 INFO - Running pre-action listener: _resource_record_pre_action 22:54:35 INFO - Running main action method: download_and_extract 22:54:35 INFO - mkdir: /builds/slave/test/build/tests 22:54: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')]} 22:54:35 INFO - https://queue.taskcluster.net/v1/task/f6WITnP9SIGtvgkwW8lo3g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 22:54:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f6WITnP9SIGtvgkwW8lo3g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 22:54:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f6WITnP9SIGtvgkwW8lo3g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 22:54:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f6WITnP9SIGtvgkwW8lo3g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 22:54:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f6WITnP9SIGtvgkwW8lo3g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 22:54:35 INFO - Downloaded 1361 bytes. 22:54:35 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 22:54:35 INFO - Using the following test package requirements: 22:54:35 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 22:54:35 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:54:35 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 22:54:35 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:54:35 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 22:54:35 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:54:35 INFO - u'jsshell-linux-x86_64.zip'], 22:54:35 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:54:35 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 22:54:35 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 22:54:35 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:54:35 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 22:54:35 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:54:35 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 22:54:35 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:54:35 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 22:54:35 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:54:35 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 22:54:35 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:54: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')]} 22:54:35 INFO - https://queue.taskcluster.net/v1/task/f6WITnP9SIGtvgkwW8lo3g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:54:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f6WITnP9SIGtvgkwW8lo3g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 22:54:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f6WITnP9SIGtvgkwW8lo3g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 22:54:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f6WITnP9SIGtvgkwW8lo3g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 22:54:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f6WITnP9SIGtvgkwW8lo3g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:54:36 INFO - Downloaded 22286071 bytes. 22:54:36 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 22:54:36 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 22:54:38 INFO - Return code: 0 22:54:38 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 22:54:38 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')]} 22:54:38 INFO - https://queue.taskcluster.net/v1/task/f6WITnP9SIGtvgkwW8lo3g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:54:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f6WITnP9SIGtvgkwW8lo3g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 22:54:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f6WITnP9SIGtvgkwW8lo3g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 22:54:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f6WITnP9SIGtvgkwW8lo3g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 22:54:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f6WITnP9SIGtvgkwW8lo3g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:54:39 INFO - Downloaded 22286071 bytes. 22:54:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 22:54:39 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 22:54:40 INFO - Return code: 0 22:54: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')]} 22:54:40 INFO - https://queue.taskcluster.net/v1/task/f6WITnP9SIGtvgkwW8lo3g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 22:54:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f6WITnP9SIGtvgkwW8lo3g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 22:54:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f6WITnP9SIGtvgkwW8lo3g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 22:54:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f6WITnP9SIGtvgkwW8lo3g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 22:54:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f6WITnP9SIGtvgkwW8lo3g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 22:54:42 INFO - Downloaded 10840145 bytes. 22:54:42 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 22:54:42 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 22:54:42 INFO - Return code: 0 22:54: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')]} 22:54:42 INFO - https://queue.taskcluster.net/v1/task/f6WITnP9SIGtvgkwW8lo3g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 22:54:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f6WITnP9SIGtvgkwW8lo3g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 22:54:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f6WITnP9SIGtvgkwW8lo3g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 22:54:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f6WITnP9SIGtvgkwW8lo3g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 22:54:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f6WITnP9SIGtvgkwW8lo3g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 22:54:45 INFO - Downloaded 54741451 bytes. 22:54:45 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/f6WITnP9SIGtvgkwW8lo3g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 22:54:45 INFO - mkdir: /builds/slave/test/properties 22:54:45 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:54:45 INFO - Writing to file /builds/slave/test/properties/build_url 22:54:45 INFO - Contents: 22:54:45 INFO - build_url:https://queue.taskcluster.net/v1/task/f6WITnP9SIGtvgkwW8lo3g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 22:54:46 INFO - Running post-action listener: _resource_record_post_action 22:54:46 INFO - Running post-action listener: set_extra_try_arguments 22:54:46 INFO - ##### 22:54:46 INFO - ##### Running populate-webroot step. 22:54:46 INFO - ##### 22:54:46 INFO - Running pre-action listener: _resource_record_pre_action 22:54:46 INFO - Running main action method: populate_webroot 22:54:46 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:54:46 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:54:46 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:54:46 INFO - '--tppagecycles', 22:54:46 INFO - '7'], 22:54:46 INFO - 'tests': ['tsvgm']}}, 22:54:46 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 22:54:46 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:54:46 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 22:54:46 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 22:54:46 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:54:46 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 22:54:46 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:54:46 INFO - 'talos_options': ['--disable-e10s'], 22:54:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:54:46 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:54:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:54:46 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:54:46 INFO - 'talos_options': ['--disable-e10s'], 22:54:46 INFO - 'tests': ['damp', 'tps']}, 22:54:46 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:54:46 INFO - 'tests': ['damp', 'tps']}, 22:54:46 INFO - 'g3': {'talos_options': ['--disable-e10s'], 22:54:46 INFO - 'tests': ['dromaeo_dom']}, 22:54:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:54:46 INFO - 'other': {'talos_options': ['--disable-e10s'], 22:54:46 INFO - 'tests': ['a11yr', 22:54:46 INFO - 'ts_paint', 22:54:46 INFO - 'tpaint', 22:54:46 INFO - 'sessionrestore', 22:54:46 INFO - 'sessionrestore_no_auto_restore', 22:54:46 INFO - 'tabpaint']}, 22:54:46 INFO - 'other-e10s': {'tests': ['a11yr', 22:54:46 INFO - 'ts_paint', 22:54:46 INFO - 'tpaint', 22:54:46 INFO - 'sessionrestore', 22:54:46 INFO - 'sessionrestore_no_auto_restore', 22:54:46 INFO - 'tabpaint']}, 22:54:46 INFO - 'other-e10s_l64': {'tests': ['a11yr', 22:54:46 INFO - 'ts_paint', 22:54:46 INFO - 'tpaint', 22:54:46 INFO - 'sessionrestore', 22:54:46 INFO - 'sessionrestore_no_auto_restore', 22:54:46 INFO - 'tabpaint']}, 22:54:46 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 22:54:46 INFO - 'ts_paint', 22:54:46 INFO - 'tpaint', 22:54:46 INFO - 'sessionrestore', 22:54:46 INFO - 'sessionrestore_no_auto_restore', 22:54:46 INFO - 'tabpaint']}, 22:54:46 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 22:54:46 INFO - 'tests': ['a11yr', 22:54:46 INFO - 'ts_paint', 22:54:46 INFO - 'tpaint', 22:54:46 INFO - 'sessionrestore', 22:54:46 INFO - 'sessionrestore_no_auto_restore', 22:54:46 INFO - 'tabpaint']}, 22:54:46 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 22:54:46 INFO - 'tests': ['a11yr', 22:54:46 INFO - 'ts_paint', 22:54:46 INFO - 'tpaint', 22:54:46 INFO - 'sessionrestore', 22:54:46 INFO - 'sessionrestore_no_auto_restore', 22:54:46 INFO - 'tabpaint']}, 22:54:46 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 22:54:46 INFO - 'tests': ['tsvgx', 22:54:46 INFO - 'tsvgr_opacity', 22:54:46 INFO - 'tart', 22:54:46 INFO - 'tscrollx', 22:54:46 INFO - 'cart']}, 22:54:46 INFO - 'svgr-e10s': {'tests': ['tsvgx', 22:54:46 INFO - 'tsvgr_opacity', 22:54:46 INFO - 'tart', 22:54:46 INFO - 'tscrollx', 22:54:46 INFO - 'cart']}, 22:54:46 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:54:46 INFO - 'talos_options': ['--disable-e10s'], 22:54:46 INFO - 'tests': ['tp5o']}, 22:54:46 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:54:46 INFO - 'tests': ['tp5o']}, 22:54:46 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:54:46 INFO - 'talos_options': ['--disable-e10s', 22:54:46 INFO - '--xperf_path', 22:54:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:54:46 INFO - 'tests': ['tp5n']}, 22:54:46 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:54:46 INFO - 'talos_options': ['--xperf_path', 22:54:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:54:46 INFO - 'tests': ['tp5n']}}, 22:54:46 INFO - 'talos.zip': {'path': '', 22:54:46 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:54:46 INFO - Running post-action listener: _resource_record_post_action 22:54:46 INFO - ##### 22:54:46 INFO - ##### Running create-virtualenv step. 22:54:46 INFO - ##### 22:54:46 INFO - Running pre-action listener: _resource_record_pre_action 22:54:46 INFO - Running main action method: create_virtualenv 22:54:46 INFO - Creating virtualenv /builds/slave/test/build/venv 22:54:46 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 22:54:46 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:54:46 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:54:46 INFO - Using real prefix '/usr' 22:54:46 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:54:46 INFO - Installing distribute.............................................................................................................................................................................................done. 22:54:48 INFO - Installing pip.................done. 22:54:48 INFO - Return code: 0 22:54:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:54: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')]} 22:54:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:54:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:54: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')]} 22:54:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:54:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:54:48 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 0x7f0cc58a4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12748a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x133f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13ce410>, '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 0x13cf310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13cf7a0>, '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': '62c568580acbfdaac3eec7be000001dc-1461477200.728732-1341828549', '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 22:54:48 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 22:54:48 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 22:54:48 INFO - Using env: {'DISPLAY': ':0', 22:54:48 INFO - 'HOME': '/home/cltbld', 22:54:48 INFO - 'LANG': 'en_US.UTF-8', 22:54:48 INFO - 'LANGUAGE': 'en_US:en', 22:54:48 INFO - 'LOGNAME': 'cltbld', 22:54:48 INFO - 'MAIL': '/var/mail/cltbld', 22:54:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:54:48 INFO - 'MOZ_NO_REMOTE': '1', 22:54:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:54:48 INFO - 'NO_EM_RESTART': '1', 22:54:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:54:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:54:48 INFO - 'PWD': '/builds/slave/test', 22:54:48 INFO - 'SHELL': '/bin/bash', 22:54:48 INFO - 'SHLVL': '1', 22:54:48 INFO - 'TERM': 'linux', 22:54:48 INFO - 'TMOUT': '86400', 22:54:48 INFO - 'USER': 'cltbld', 22:54:48 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1461477200.728732-1341828549', 22:54:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:54:48 INFO - '_': '/tools/buildbot/bin/python'} 22:54:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:54:49 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 22:54:49 INFO - Cleaning up... 22:54:49 INFO - Return code: 0 22:54:49 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 22:54:49 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')]} 22:54:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:54:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:54:49 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')]} 22:54:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:54:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:54:49 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 0x7f0cc58a4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12748a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x133f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13ce410>, '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 0x13cf310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13cf7a0>, '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': '62c568580acbfdaac3eec7be000001dc-1461477200.728732-1341828549', '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 22:54:49 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 22:54:49 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 22:54:49 INFO - Using env: {'DISPLAY': ':0', 22:54:49 INFO - 'HOME': '/home/cltbld', 22:54:49 INFO - 'LANG': 'en_US.UTF-8', 22:54:49 INFO - 'LANGUAGE': 'en_US:en', 22:54:49 INFO - 'LOGNAME': 'cltbld', 22:54:49 INFO - 'MAIL': '/var/mail/cltbld', 22:54:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:54:49 INFO - 'MOZ_NO_REMOTE': '1', 22:54:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:54:49 INFO - 'NO_EM_RESTART': '1', 22:54:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:54:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:54:49 INFO - 'PWD': '/builds/slave/test', 22:54:49 INFO - 'SHELL': '/bin/bash', 22:54:49 INFO - 'SHLVL': '1', 22:54:49 INFO - 'TERM': 'linux', 22:54:49 INFO - 'TMOUT': '86400', 22:54:49 INFO - 'USER': 'cltbld', 22:54:49 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1461477200.728732-1341828549', 22:54:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:54:49 INFO - '_': '/tools/buildbot/bin/python'} 22:54:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:54:49 INFO - Downloading/unpacking psutil>=0.7.1 22:54:49 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 22:54:49 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 22:54:49 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 22:54:49 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 22:54:49 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 22:54:49 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 22:54:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:54:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:54:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:54:51 INFO - Installing collected packages: psutil 22:54:51 INFO - Running setup.py install for psutil 22:54:51 INFO - building 'psutil._psutil_linux' extension 22:54:51 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 22:54:51 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 22:54:51 INFO - building 'psutil._psutil_posix' extension 22:54:51 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 22:54:51 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 22:54:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:54:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:54:51 INFO - Successfully installed psutil 22:54:51 INFO - Cleaning up... 22:54:51 INFO - Return code: 0 22:54:51 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 22:54: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')]} 22:54:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:54:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:54: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')]} 22:54:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:54:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:54:51 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 0x7f0cc58a4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12748a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x133f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13ce410>, '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 0x13cf310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13cf7a0>, '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': '62c568580acbfdaac3eec7be000001dc-1461477200.728732-1341828549', '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 22:54:51 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 22:54:51 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 22:54:51 INFO - Using env: {'DISPLAY': ':0', 22:54:51 INFO - 'HOME': '/home/cltbld', 22:54:51 INFO - 'LANG': 'en_US.UTF-8', 22:54:51 INFO - 'LANGUAGE': 'en_US:en', 22:54:51 INFO - 'LOGNAME': 'cltbld', 22:54:51 INFO - 'MAIL': '/var/mail/cltbld', 22:54:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:54:51 INFO - 'MOZ_NO_REMOTE': '1', 22:54:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:54:51 INFO - 'NO_EM_RESTART': '1', 22:54:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:54:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:54:51 INFO - 'PWD': '/builds/slave/test', 22:54:51 INFO - 'SHELL': '/bin/bash', 22:54:51 INFO - 'SHLVL': '1', 22:54:51 INFO - 'TERM': 'linux', 22:54:51 INFO - 'TMOUT': '86400', 22:54:51 INFO - 'USER': 'cltbld', 22:54:51 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1461477200.728732-1341828549', 22:54:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:54:51 INFO - '_': '/tools/buildbot/bin/python'} 22:54:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:54:52 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 22:54: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 22:54: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 22:54: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 22:54: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 22:54: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 22:54: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 22:54:53 INFO - Downloading mozsystemmonitor-0.0.tar.gz 22:54:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:54:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 22:54:54 INFO - Installing collected packages: mozsystemmonitor 22:54:54 INFO - Running setup.py install for mozsystemmonitor 22:54:54 INFO - Successfully installed mozsystemmonitor 22:54:54 INFO - Cleaning up... 22:54:54 INFO - Return code: 0 22:54:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:54: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')]} 22:54:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:54:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:54: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')]} 22:54:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:54:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:54: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', '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 0x7f0cc58a4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12748a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x133f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13ce410>, '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 0x13cf310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13cf7a0>, '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': '62c568580acbfdaac3eec7be000001dc-1461477200.728732-1341828549', '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 22:54: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 22:54: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 blobuploader==1.2.4 22:54:54 INFO - Using env: {'DISPLAY': ':0', 22:54:54 INFO - 'HOME': '/home/cltbld', 22:54:54 INFO - 'LANG': 'en_US.UTF-8', 22:54:54 INFO - 'LANGUAGE': 'en_US:en', 22:54:54 INFO - 'LOGNAME': 'cltbld', 22:54:54 INFO - 'MAIL': '/var/mail/cltbld', 22:54:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:54:54 INFO - 'MOZ_NO_REMOTE': '1', 22:54:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:54:54 INFO - 'NO_EM_RESTART': '1', 22:54:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:54:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:54:54 INFO - 'PWD': '/builds/slave/test', 22:54:54 INFO - 'SHELL': '/bin/bash', 22:54:54 INFO - 'SHLVL': '1', 22:54:54 INFO - 'TERM': 'linux', 22:54:54 INFO - 'TMOUT': '86400', 22:54:54 INFO - 'USER': 'cltbld', 22:54:54 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1461477200.728732-1341828549', 22:54:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:54:54 INFO - '_': '/tools/buildbot/bin/python'} 22:54:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:54:54 INFO - Downloading/unpacking blobuploader==1.2.4 22:54: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 22:54: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 22:54: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 22:54: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 22:54: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 22:54: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 22:54:56 INFO - Downloading blobuploader-1.2.4.tar.gz 22:54:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:54:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:54: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 22:54: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 22:54: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 22:54: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 22:54: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 22:54: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 22:54:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:54:56 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:54: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 22:54: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 22:54: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 22:54: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 22:54: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 22:54: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 22:54:56 INFO - Downloading docopt-0.6.1.tar.gz 22:54:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:54:56 INFO - Installing collected packages: blobuploader, requests, docopt 22:54:56 INFO - Running setup.py install for blobuploader 22:54:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:54:57 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:54:57 INFO - Running setup.py install for requests 22:54:57 INFO - Running setup.py install for docopt 22:54:57 INFO - Successfully installed blobuploader requests docopt 22:54:57 INFO - Cleaning up... 22:54:57 INFO - Return code: 0 22:54:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:54: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')]} 22:54:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:54:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:54: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')]} 22:54:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:54:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:54:57 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 0x7f0cc58a4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12748a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x133f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13ce410>, '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 0x13cf310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13cf7a0>, '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': '62c568580acbfdaac3eec7be000001dc-1461477200.728732-1341828549', '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 22:54:57 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 22:54:57 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 22:54:57 INFO - Using env: {'DISPLAY': ':0', 22:54:57 INFO - 'HOME': '/home/cltbld', 22:54:57 INFO - 'LANG': 'en_US.UTF-8', 22:54:57 INFO - 'LANGUAGE': 'en_US:en', 22:54:57 INFO - 'LOGNAME': 'cltbld', 22:54:57 INFO - 'MAIL': '/var/mail/cltbld', 22:54:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:54:57 INFO - 'MOZ_NO_REMOTE': '1', 22:54:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:54:57 INFO - 'NO_EM_RESTART': '1', 22:54:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:54:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:54:57 INFO - 'PWD': '/builds/slave/test', 22:54:57 INFO - 'SHELL': '/bin/bash', 22:54:57 INFO - 'SHLVL': '1', 22:54:57 INFO - 'TERM': 'linux', 22:54:57 INFO - 'TMOUT': '86400', 22:54:57 INFO - 'USER': 'cltbld', 22:54:57 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1461477200.728732-1341828549', 22:54:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:54:57 INFO - '_': '/tools/buildbot/bin/python'} 22:54:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:54:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:54:57 INFO - Running setup.py (path:/tmp/pip-On0ozi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:54:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:54:57 INFO - Running setup.py (path:/tmp/pip-xyBNwm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:54:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:54:57 INFO - Running setup.py (path:/tmp/pip-mNPG4p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:54:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:54:58 INFO - Running setup.py (path:/tmp/pip-eOFcdS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:54:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:54:58 INFO - Running setup.py (path:/tmp/pip-ZYyWxM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:54:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:54:58 INFO - Running setup.py (path:/tmp/pip-oLNyIk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:54:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:54:58 INFO - Running setup.py (path:/tmp/pip-M3JNC9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:54:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:54:58 INFO - Running setup.py (path:/tmp/pip-719Keg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:54:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:54:58 INFO - Running setup.py (path:/tmp/pip-OI5uEC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:54:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:54:58 INFO - Running setup.py (path:/tmp/pip-Hazf9_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:54:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:54:58 INFO - Running setup.py (path:/tmp/pip-Q_RjMg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:54:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:54:58 INFO - Running setup.py (path:/tmp/pip-NGh0cs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:54:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:54:58 INFO - Running setup.py (path:/tmp/pip-FVacZm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:54:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:54:58 INFO - Running setup.py (path:/tmp/pip-MnQ8j_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:54:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:54:58 INFO - Running setup.py (path:/tmp/pip-fmZFS2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:54:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:54:58 INFO - Running setup.py (path:/tmp/pip-1K27aP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:54:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:54:58 INFO - Running setup.py (path:/tmp/pip-vM8N7z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:54:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:54:58 INFO - Running setup.py install for manifestparser 22:54:59 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:54:59 INFO - Running setup.py install for mozcrash 22:54:59 INFO - Running setup.py install for mozdebug 22:54:59 INFO - Running setup.py install for mozdevice 22:54:59 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 22:54:59 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:54:59 INFO - Running setup.py install for mozfile 22:54:59 INFO - Running setup.py install for mozhttpd 22:54:59 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:54:59 INFO - Running setup.py install for mozinfo 22:54:59 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:54:59 INFO - Running setup.py install for mozInstall 22:54:59 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:54:59 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:54:59 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:54:59 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:54:59 INFO - Running setup.py install for mozleak 22:54:59 INFO - Running setup.py install for mozlog 22:54:59 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:55:00 INFO - Running setup.py install for moznetwork 22:55:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:55:00 INFO - Running setup.py install for mozprocess 22:55:00 INFO - Running setup.py install for mozprofile 22:55:00 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:55:00 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:55:00 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:55:00 INFO - Running setup.py install for mozrunner 22:55:00 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:55:00 INFO - Running setup.py install for mozscreenshot 22:55:00 INFO - Running setup.py install for moztest 22:55:00 INFO - Running setup.py install for mozversion 22:55:00 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:55:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:55:00 INFO - Cleaning up... 22:55:00 INFO - Return code: 0 22:55:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:55:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:55:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:55:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:55:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:55:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:55:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:55:00 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 0x7f0cc58a4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12748a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x133f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13ce410>, '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 0x13cf310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13cf7a0>, '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': '62c568580acbfdaac3eec7be000001dc-1461477200.728732-1341828549', '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 22:55:00 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 22:55:00 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 22:55:00 INFO - Using env: {'DISPLAY': ':0', 22:55:00 INFO - 'HOME': '/home/cltbld', 22:55:00 INFO - 'LANG': 'en_US.UTF-8', 22:55:00 INFO - 'LANGUAGE': 'en_US:en', 22:55:00 INFO - 'LOGNAME': 'cltbld', 22:55:00 INFO - 'MAIL': '/var/mail/cltbld', 22:55:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:55:00 INFO - 'MOZ_NO_REMOTE': '1', 22:55:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:55:00 INFO - 'NO_EM_RESTART': '1', 22:55:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:55:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:55:00 INFO - 'PWD': '/builds/slave/test', 22:55:00 INFO - 'SHELL': '/bin/bash', 22:55:00 INFO - 'SHLVL': '1', 22:55:00 INFO - 'TERM': 'linux', 22:55:00 INFO - 'TMOUT': '86400', 22:55:00 INFO - 'USER': 'cltbld', 22:55:00 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1461477200.728732-1341828549', 22:55:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:55:00 INFO - '_': '/tools/buildbot/bin/python'} 22:55:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:55:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:55:00 INFO - Running setup.py (path:/tmp/pip-l5LCbg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:55:01 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)) 22:55:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:55:01 INFO - Running setup.py (path:/tmp/pip-ZwoZ2j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:55:01 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)) 22:55:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:55:01 INFO - Running setup.py (path:/tmp/pip-J07Ubx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:55:01 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)) 22:55:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:55:01 INFO - Running setup.py (path:/tmp/pip-zcWaFX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:55:01 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)) 22:55:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:55:01 INFO - Running setup.py (path:/tmp/pip-JhKt9m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:55:01 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)) 22:55:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:55:01 INFO - Running setup.py (path:/tmp/pip-d3pZ3e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:55:01 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)) 22:55:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:55:01 INFO - Running setup.py (path:/tmp/pip-t_RJh4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:55:01 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)) 22:55:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:55:01 INFO - Running setup.py (path:/tmp/pip-IC6bkQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:55:01 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)) 22:55:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:55:01 INFO - Running setup.py (path:/tmp/pip-BH0duN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:55:01 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)) 22:55:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:55:01 INFO - Running setup.py (path:/tmp/pip-HFaJUq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:55:01 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)) 22:55:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:55:01 INFO - Running setup.py (path:/tmp/pip-tWxGQl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:55:01 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)) 22:55:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:55:01 INFO - Running setup.py (path:/tmp/pip-gi1G2_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:55:01 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)) 22:55:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:55:01 INFO - Running setup.py (path:/tmp/pip-0r8ggL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:55:01 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)) 22:55:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:55:01 INFO - Running setup.py (path:/tmp/pip-VPHa90-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:55:02 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)) 22:55:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:55:02 INFO - Running setup.py (path:/tmp/pip-EhBxOv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:55:02 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)) 22:55:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:55:02 INFO - Running setup.py (path:/tmp/pip-b1GrAK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:55:02 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)) 22:55:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:55:02 INFO - Running setup.py (path:/tmp/pip-qfajJc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:55:02 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)) 22:55:02 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)) 22:55:02 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)) 22:55:02 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)) 22:55:02 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)) 22:55:02 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)) 22:55:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:55:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:55:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:55:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:55:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:55:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:55:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:55:04 INFO - Downloading blessings-1.6.tar.gz 22:55:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:55:04 INFO - Installing collected packages: blessings 22:55:04 INFO - Running setup.py install for blessings 22:55:04 INFO - Successfully installed blessings 22:55:04 INFO - Cleaning up... 22:55:04 INFO - Return code: 0 22:55:04 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:55:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:55:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:55:04 INFO - Reading from file tmpfile_stdout 22:55:04 INFO - Current package versions: 22:55:04 INFO - argparse == 1.2.1 22:55:04 INFO - blessings == 1.6 22:55:04 INFO - blobuploader == 1.2.4 22:55:04 INFO - docopt == 0.6.1 22:55:04 INFO - manifestparser == 1.1 22:55:04 INFO - mozInstall == 1.12 22:55:04 INFO - mozcrash == 0.17 22:55:04 INFO - mozdebug == 0.1 22:55:04 INFO - mozdevice == 0.48 22:55:04 INFO - mozfile == 1.2 22:55:04 INFO - mozhttpd == 0.7 22:55:04 INFO - mozinfo == 0.9 22:55:04 INFO - mozleak == 0.1 22:55:04 INFO - mozlog == 3.1 22:55:04 INFO - moznetwork == 0.27 22:55:04 INFO - mozprocess == 0.22 22:55:04 INFO - mozprofile == 0.28 22:55:04 INFO - mozrunner == 6.11 22:55:04 INFO - mozscreenshot == 0.1 22:55:04 INFO - mozsystemmonitor == 0.0 22:55:04 INFO - moztest == 0.7 22:55:04 INFO - mozversion == 1.4 22:55:04 INFO - psutil == 3.1.1 22:55:04 INFO - requests == 1.2.3 22:55:04 INFO - wsgiref == 0.1.2 22:55:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:55:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:55:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:55:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:55:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:55:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:55:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:55:04 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 0x7f0cc58a4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12748a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x133f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13ce410>, '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 0x13cf310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13cf7a0>, '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': '62c568580acbfdaac3eec7be000001dc-1461477200.728732-1341828549', '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 22:55:04 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 22:55:04 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 22:55:04 INFO - Using env: {'DISPLAY': ':0', 22:55:04 INFO - 'HOME': '/home/cltbld', 22:55:04 INFO - 'LANG': 'en_US.UTF-8', 22:55:04 INFO - 'LANGUAGE': 'en_US:en', 22:55:04 INFO - 'LOGNAME': 'cltbld', 22:55:04 INFO - 'MAIL': '/var/mail/cltbld', 22:55:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:55:04 INFO - 'MOZ_NO_REMOTE': '1', 22:55:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:55:04 INFO - 'NO_EM_RESTART': '1', 22:55:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:55:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:55:04 INFO - 'PWD': '/builds/slave/test', 22:55:04 INFO - 'SHELL': '/bin/bash', 22:55:04 INFO - 'SHLVL': '1', 22:55:04 INFO - 'TERM': 'linux', 22:55:04 INFO - 'TMOUT': '86400', 22:55:04 INFO - 'USER': 'cltbld', 22:55:04 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1461477200.728732-1341828549', 22:55:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:55:04 INFO - '_': '/tools/buildbot/bin/python'} 22:55:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:55:04 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)) 22:55:04 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)) 22:55:04 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)) 22:55:04 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)) 22:55:04 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)) 22:55:04 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)) 22:55:04 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)) 22:55:04 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)) 22:55:04 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)) 22:55:04 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)) 22:55:04 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)) 22:55:04 INFO - Cleaning up... 22:55:04 INFO - Return code: 0 22:55:04 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 22:55:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:55:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:55:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:55:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:55:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:55:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:55:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0cc58a4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12748a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x133f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13ce410>, '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 0x13cf310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13cf7a0>, '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': '62c568580acbfdaac3eec7be000001dc-1461477200.728732-1341828549', '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 22:55:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 22:55:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 22:55:04 INFO - Using env: {'DISPLAY': ':0', 22:55:04 INFO - 'HOME': '/home/cltbld', 22:55:04 INFO - 'LANG': 'en_US.UTF-8', 22:55:04 INFO - 'LANGUAGE': 'en_US:en', 22:55:04 INFO - 'LOGNAME': 'cltbld', 22:55:04 INFO - 'MAIL': '/var/mail/cltbld', 22:55:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:55:04 INFO - 'MOZ_NO_REMOTE': '1', 22:55:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:55:04 INFO - 'NO_EM_RESTART': '1', 22:55:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:55:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:55:04 INFO - 'PWD': '/builds/slave/test', 22:55:04 INFO - 'SHELL': '/bin/bash', 22:55:04 INFO - 'SHLVL': '1', 22:55:04 INFO - 'TERM': 'linux', 22:55:04 INFO - 'TMOUT': '86400', 22:55:04 INFO - 'USER': 'cltbld', 22:55:04 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1461477200.728732-1341828549', 22:55:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:55:04 INFO - '_': '/tools/buildbot/bin/python'} 22:55:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:55:04 INFO - Downloading/unpacking jsonschema 22:55:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:55:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:55:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:55:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:55:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:55:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:55:06 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:55:06 INFO - Downloading/unpacking functools32 (from jsonschema) 22:55:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:55:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:55:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:55:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:55:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:55:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:55:07 INFO - Downloading functools32-3.2.3-2.tar.gz 22:55:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 22:55:07 INFO - warning: no files found matching '*.txt' 22:55:07 INFO - no previously-included directories found matching 'build' 22:55:07 INFO - no previously-included directories found matching 'dist' 22:55:07 INFO - no previously-included directories found matching '.git*' 22:55:07 INFO - Installing collected packages: jsonschema, functools32 22:55:07 INFO - Running setup.py install for functools32 22:55:07 INFO - warning: no files found matching '*.txt' 22:55:07 INFO - no previously-included directories found matching 'build' 22:55:07 INFO - no previously-included directories found matching 'dist' 22:55:07 INFO - no previously-included directories found matching '.git*' 22:55:07 INFO - Successfully installed jsonschema functools32 22:55:07 INFO - Cleaning up... 22:55:07 INFO - Return code: 0 22:55:07 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 22:55:07 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')]} 22:55:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:55:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:55:07 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')]} 22:55:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:55:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:55:07 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 0x7f0cc58a4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12748a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x133f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13ce410>, '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 0x13cf310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13cf7a0>, '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': '62c568580acbfdaac3eec7be000001dc-1461477200.728732-1341828549', '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 22:55:07 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 22:55:07 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 22:55:07 INFO - Using env: {'DISPLAY': ':0', 22:55:07 INFO - 'HOME': '/home/cltbld', 22:55:07 INFO - 'LANG': 'en_US.UTF-8', 22:55:07 INFO - 'LANGUAGE': 'en_US:en', 22:55:07 INFO - 'LOGNAME': 'cltbld', 22:55:07 INFO - 'MAIL': '/var/mail/cltbld', 22:55:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:55:07 INFO - 'MOZ_NO_REMOTE': '1', 22:55:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:55:07 INFO - 'NO_EM_RESTART': '1', 22:55:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:55:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:55:07 INFO - 'PWD': '/builds/slave/test', 22:55:07 INFO - 'SHELL': '/bin/bash', 22:55:07 INFO - 'SHLVL': '1', 22:55:07 INFO - 'TERM': 'linux', 22:55:07 INFO - 'TMOUT': '86400', 22:55:07 INFO - 'USER': 'cltbld', 22:55:07 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1461477200.728732-1341828549', 22:55:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:55:07 INFO - '_': '/tools/buildbot/bin/python'} 22:55:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:55:07 INFO - Downloading/unpacking flake8 22:55:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:55:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:55:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:55:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:55:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:55:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:55:09 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 22:55:09 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 22:55:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:55:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:55:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:55:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:55:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:55:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:55:09 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 22:55:09 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 22:55:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:55:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:55:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:55:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:55:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:55:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:55:09 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 22:55:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:55:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:55:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:55:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:55:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:55:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:55:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 22:55:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:55:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:55:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:55:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:55:10 INFO - no previously-included directories found matching 'docs/_build' 22:55:10 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 22:55:10 INFO - Running setup.py install for pep8 22:55:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:55:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:55:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:55:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:55:10 INFO - no previously-included directories found matching 'docs/_build' 22:55:10 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 22:55:10 INFO - Successfully installed flake8 mccabe pyflakes pep8 22:55:10 INFO - Cleaning up... 22:55:10 INFO - Return code: 0 22:55:10 INFO - Running post-action listener: _resource_record_post_action 22:55:10 INFO - Running post-action listener: _start_resource_monitoring 22:55:10 INFO - Starting resource monitoring. 22:55:10 INFO - ##### 22:55:10 INFO - ##### Running install step. 22:55:10 INFO - ##### 22:55:10 INFO - Running pre-action listener: _resource_record_pre_action 22:55:10 INFO - Running main action method: install 22:55:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:55:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:55:10 INFO - Reading from file tmpfile_stdout 22:55:10 INFO - Detecting whether we're running mozinstall >=1.0... 22:55:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:55:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:55:10 INFO - Reading from file tmpfile_stdout 22:55:10 INFO - Output received: 22:55:10 INFO - Usage: mozinstall [options] installer 22:55:10 INFO - Options: 22:55:10 INFO - -h, --help show this help message and exit 22:55:10 INFO - -d DEST, --destination=DEST 22:55:10 INFO - Directory to install application into. [default: 22:55:10 INFO - "/builds/slave/test"] 22:55:10 INFO - --app=APP Application being installed. [default: firefox] 22:55:10 INFO - mkdir: /builds/slave/test/build/application 22:55:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 22:55:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 22:55:26 INFO - Reading from file tmpfile_stdout 22:55:26 INFO - Output received: 22:55:26 INFO - /builds/slave/test/build/application/firefox/firefox 22:55:26 INFO - Running post-action listener: _resource_record_post_action 22:55:26 INFO - ##### 22:55:26 INFO - ##### Running run-tests step. 22:55:26 INFO - ##### 22:55:26 INFO - Running pre-action listener: _resource_record_pre_action 22:55:26 INFO - Running main action method: run_tests 22:55:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:55:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:55:26 INFO - Python 2.7.3 22:55:26 INFO - Return code: 0 22:55:26 INFO - grabbing minidump binary from tooltool 22:55:26 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')]} 22:55:26 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13ce410>, '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 0x13cf310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13cf7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:55:26 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 22:55:26 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 22:55:26 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:55:26 INFO - Return code: 0 22:55:26 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 22:55:26 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:55:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:55:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 22:55:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:55:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 22:55:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 22:55:27 INFO - Return code: 0 22:55:27 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/f6WITnP9SIGtvgkwW8lo3g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--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 22:55:27 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/f6WITnP9SIGtvgkwW8lo3g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-018 --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 22:55:27 INFO - Using env: {'DISPLAY': ':0', 22:55:27 INFO - 'HOME': '/home/cltbld', 22:55:27 INFO - 'LANG': 'en_US.UTF-8', 22:55:27 INFO - 'LANGUAGE': 'en_US:en', 22:55:27 INFO - 'LOGNAME': 'cltbld', 22:55:27 INFO - 'MAIL': '/var/mail/cltbld', 22:55:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:55:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 22:55:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:55:27 INFO - 'MOZ_NO_REMOTE': '1', 22:55:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:55:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:55:27 INFO - 'NO_EM_RESTART': '1', 22:55:27 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:55:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:55:27 INFO - 'PWD': '/builds/slave/test', 22:55:27 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:55:27 INFO - 'SHELL': '/bin/bash', 22:55:27 INFO - 'SHLVL': '1', 22:55:27 INFO - 'TERM': 'linux', 22:55:27 INFO - 'TMOUT': '86400', 22:55:27 INFO - 'USER': 'cltbld', 22:55:27 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1461477200.728732-1341828549', 22:55:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:55:27 INFO - '_': '/tools/buildbot/bin/python'} 22:55:27 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/f6WITnP9SIGtvgkwW8lo3g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--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 22:55:27 INFO - mozversion application_buildid: 20160423222844 22:55:27 INFO - mozversion application_changeset: f47b31f50a9a82984640ff6e17a86239808c8e15 22:55:27 INFO - mozversion application_display_name: Nightly 22:55:27 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:55:27 INFO - mozversion application_name: Firefox 22:55:27 INFO - mozversion application_remotingname: firefox 22:55:27 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 22:55:27 INFO - mozversion application_vendor: Mozilla 22:55:27 INFO - mozversion application_version: 48.0a1 22:55:27 INFO - mozversion platform_buildid: 20160423222844 22:55:27 INFO - mozversion platform_changeset: f47b31f50a9a82984640ff6e17a86239808c8e15 22:55:27 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 22:55:27 INFO - mozversion platform_version: 48.0a1 22:55:27 INFO - using testdate: 1461477327 22:55:27 INFO - actual date: 1461477327 22:55:27 INFO - starting webserver on 'localhost:36967' 22:55:27 INFO - SUITE-START | Running 2 tests 22:55:27 INFO - TEST-START | dromaeo_css 22:55:27 INFO - operating with platform_type : linux_ 22:55:27 INFO - Initialising browser for dromaeo_css test... 22:55:27 INFO - TEST-INFO | started process 8367 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcyoWjl/profile http://localhost:36967/getInfo.html) 22:55:31 INFO - PROCESS | 8367 | __metrics Screen width/height:1600/1200 22:55:31 INFO - PROCESS | 8367 | colorDepth:24 22:55:31 INFO - PROCESS | 8367 | Browser inner width/height: 1024/697 22:55:31 INFO - PROCESS | 8367 | __metrics 22:55:32 ERROR - PROCESS | 8367 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 22:55:33 INFO - TEST-INFO | 8367: exit 0 22:55:33 INFO - Browser initialized. 22:55:33 INFO - Running cycle 1/1 for dromaeo_css test... 22:55:33 INFO - TEST-INFO | started process 8450 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcyoWjl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:55:45 INFO - PROCESS | 8450 | RSS: Main: 155955200 22:55:45 INFO - PROCESS | 8450 | 22:56:36 INFO - PROCESS | 8450 | 1461477396253 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] 22:58:48 INFO - PROCESS | 8450 | Cycle 1(1): loaded http://localhost:36967/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36967/tests/dromaeo/cssquery-ext.html) 22:58:49 INFO - PROCESS | 8450 | RSS: Main: 235659264 22:58:49 INFO - PROCESS | 8450 | 23:01:52 INFO - PROCESS | 8450 | Cycle 1(1): loaded http://localhost:36967/tests/dromaeo/cssquery-ext.html (next: http://localhost:36967/tests/dromaeo/cssquery-jquery.html) 23:01:52 INFO - PROCESS | 8450 | RSS: Main: 238731264 23:01:52 INFO - PROCESS | 8450 | 23:04:54 INFO - PROCESS | 8450 | Cycle 1(1): loaded http://localhost:36967/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36967/tests/dromaeo/cssquery-mootools.html) 23:04:55 INFO - PROCESS | 8450 | RSS: Main: 240435200 23:04:55 INFO - PROCESS | 8450 | 23:07:57 INFO - PROCESS | 8450 | Cycle 1(1): loaded http://localhost:36967/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36967/tests/dromaeo/cssquery-prototype.html) 23:07:58 INFO - PROCESS | 8450 | RSS: Main: 236195840 23:07:58 INFO - PROCESS | 8450 | 23:11:01 INFO - PROCESS | 8450 | Cycle 1(1): loaded http://localhost:36967/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36967/tests/dromaeo/cssquery-yui.html) 23:11:01 INFO - PROCESS | 8450 | RSS: Main: 214929408 23:11:01 INFO - PROCESS | 8450 | 23:14:04 INFO - PROCESS | 8450 | Cycle 1(1): loaded http://localhost:36967/tests/dromaeo/cssquery-yui.html (next: http://localhost:36967/tests/dromaeo/cssquery-dojo.html) 23:14:05 INFO - PROCESS | 8450 | RSS: Main: 267231232 23:14:05 INFO - PROCESS | 8450 | 23:14:05 INFO - PROCESS | 8450 | __start_tp_report 23:14:05 INFO - PROCESS | 8450 | _x_x_mozilla_page_load 23:14:05 INFO - PROCESS | 8450 | _x_x_mozilla_page_load_details 23:14:05 INFO - PROCESS | 8450 | |i|pagename|runs| 23:14:05 INFO - PROCESS | 8450 | |0;dojo.html;2584.651072105266;2673.1846786730052;2675.879585418656;2687.234138270593;2701.8378897266166;4555.840545580905;4595;4596.28757542581;4599.908001839965;4620.191466493363;4592.081583683268;4617.722936623805;4662.603678687307;4746.430428348603;4749;4215.199112168693;4235.322348424253;4245.193413251488;4248;4268.253055715253;4300.827966881321;4354.629856462205;4367.192069467143;4389.4513185851765;4389.517153113155;4108.876733697994;4186.706930514865;4191.434156388879;4300.376445415397;4336.436263285768;4158.584141585848;4234.724742891703;4273.017206042597;4277.508086570053;4280.250956082673;4227.513835908879;4265.0830071534765;4270.4234928284595;4293.914121717579;4361.149575832714;4524.524924882873;4598.678092533524;4603.240465323218;4606;4652.69757465767;4780.689255198436;4974.925376119361;5022.59819214462;5041.546260836542;5049.419316778581;4982.825601103944;4988.87527811804;4989.65072444929;5008.749562521859;5029.899402011939;4656.95343046572;4680.438347398334;4705.623550115983;4707.29390591414;4748.074125545486;4985.925211121836;5085.542301192911;5131;5157.020166168416;5166.689998600096;4880.487548807395;4888.071266459361;4935.087008903364;4940.382452193476;4976.900461990812;4989.401271847401;5014.974925125351;5015.598752099823;5016.5485106339875;5029.673071250357;4821.807127714922;4845.345878306383;4934.679245849008;4942.233953737176;5013.1227035268685;4866.416030076342;4879.585235255043;4881.707097574086;4908.705477671351;4939.259111133287;4224.894377640522;4226.450561426995;4237.597428244312;4262.722923009995;4279.935800962988;3590.56913170416;3686.594474607791;3705.5923848376656;3736.4208547675153;3813.3136035513876;4289.485261768546;4293.97853010733;4294.312909934395;4323.0705398339505;4332.241857674894;5016.172331565251;5021.372328458942;5021.72380519075;5028.270900719448;5066.594672426197;4196.475440569929;4295.570442955742;4298.484181898192;4365.694401391936;4369.191699535532;4496.865094047183;4518.728876267434;4525.773711314421;4531.274996000624;4568.6116680081905;4736.976315118402;4739.170645137018;4745.359376484131;4747.074320507468;4779.617630589544;4873.951260487492;4978.029284289673;4987.177115775857;5094.821681241138;5113.923291150561;4709.670323077352;4731.361266229015;4736.313234580897;4745.430548334084;4776.23580227162;4951.702897826142;4958.330625365529;4958.528939750718;4970.279309500174;5021.271915572149;4833.492483289345;4874.561289483963;4930.383702037246;4932.161532539549;4935.383077115361;4785.712857228577;4806.711597304173;4846.660733748604;4893.779779909842;4917.164082105979;4812.590929771009;4820.156472617348;4820.204666230033;4820.373351464287;4859.319695242598;4666.486686464554;4727.763611819464;4753.215719406259;4754.4770075291;4789.042191561632;4893.755312234445;4931.161702510653;4936.185529387611;4979.029089327546;4981.726005069756;4822.42130944289;4848.3454733611925;4850.53919877611;4852.587530059985;4896.92654610174 23:14:05 INFO - PROCESS | 8450 | |1;ext.html;578.0895090232884;598.1954271504826;607.887540804951;618.2457401969596;638.4573112854072;30564.235894102658;33664;34590;34686.826565867166;34771.82614086932;40987.59012409875;41541;41730.58269417305;41877.79061104698;41939;7191.280871912793;7760.689572417111;7951.443398962075;7952.204779522031;9509.762255943622;9674.08096230857;9839.45882976436;9852.359596626196;9854.753631159207;9854.852177217348;9782.168515676176;9881.95059024704;9885.654002109928;9899;9900.801983960317;7367.631618419111;9763;9838.999999999964;9906.108450239513;10340.689779306633;9708.271879608987;9859.704208873745;9870.703878883573;9873.703788886345;9874.60501579936;33251.33497330064;33934.660653393395;33979.15052123692;34055.489167662505;34068.48897266543;3174.254050298201;3183.602049743782;3267.607887053569;3375.729941604666;3402.4385976314124;28770.424591508054;29075;29385.265368365963;29581.70418295811;30314.54528182079;3491.6682915123024;3502.7898326100517;3518.9472157917653;3573.76770509916;3619.69232615228;244477.22091116334;245309.0549114302;246142;246297;247065;51668.48331516637;52464;52498.21252681213;52565.7371713139;52616.21075683868;58561;60396;60494.395056049754;60660.696696516236;60717;13935;14160.858391415954;14193.148411095368;14195.85804141966;14217.644558885904;9342.626294948263;10490.895091048991;10651.573937042587;10928.890711092947;10943.890561094287;17748.733768993476;17810.821891781176;17851.910740446474;17853.642927141384;17896.642067158584;6833.384995350442;6833.863322733518;6888.346796768739;6973.860522789516;7078.150621925299;920.7099763574453;1010.9536629588341;1036.5542816588788;1053.115383078218;1060.3319908457777;27373;27855.721442785718;28335.29161770972;28449.57325640117;28561.28596785097;986.6152200641756;998.0767789794556;1002.6791426743372;1079.2391364088298;1085.0234788690243;14778;14789.778153327708;15060.171690557125;15084.849151508564;15293.617659558378;362543;368716;370873;371687;372184;48066.27900581494;48932;48979.75510122427;48982.755086224344;48989;1034.5551412892378;1200.6278053803348;1238.4365113873346;1245.3337464456472;1364.969448066723;24048.639270410607;27509.44981100407;29190.70809291965;29396.41207175802;29911.252218694706;43396.783016084715;44103.77948110239;44298;44307.33538996853;44321;340689;344631;346814;347096;348412;32830.40374347546;41087.38368924528;42045;42081.78959105185;42304;39603.405948910215;39842.60157398389;39961.80019099886;40056.3991540133;40322.1935561293;33385.332293354484;34091;34479.13802154966;34566.48150277697;34815.12962175966;33271.33457330888;33458.83270583729;34059.318813624086;34193;34497;33530;33908.321833563685;34442.13894652654;34676.306473869874;34704;30068.849655751583;30411.2397190072;30685.53971690382;30750.231244219074;31060;23589.764102358757;23938.52122957566;23969.64045539353;24068.51862962766;24377.756222437547 23:14:05 INFO - PROCESS | 8450 | |2;jquery.html;358.3156171712032;361.766660503975;369.83727160049574;374.4215187535258;374.94750734897104;15555.144467054308;16173.676526469479;16505.422310219146;16538.255778489965;16582.91708541457;15558.222088895567;16665.75012373329;16828.32686692531;17359.305627774873;17369.218385172666;4825.541573550507;5029.346184995946;5077.517635824609;5079.4412614612365;5085.364329458817;3614.475900994354;3815.0271680721517;5050.166722490784;5599.832005039855;5934.1098835174635;5866.237389139406;5868.2371291732225;5885.087811389241;5894.941050589504;5902.911456328158;5749.453801888814;5770.913436298459;5801.361850196497;5953.613015154001;5961.314448838396;3357.194273374397;4921.7785199666105;5211.609129315317;5213.635045546814;5219.373675158968;19375.612487750306;19640.607187856163;19682.70475942862;20766;20916.686249706265;1877.5869308752053;1942.5823447958758;1942.951426214356;1998.6202621501868;2138.721966144407;13242.933785331012;13267.336633168303;13277.933610331887;13343.266120363376;13474.258915759629;1756.7277072053853;1781.118346418518;1836.0819590204896;1840.8527317814676;1859.739636450898;63584.68207658979;63587;63707.681461592394;64599.677001615164;65024.674876625315;9051.637934482547;9069.77325566853;9264.212541934012;9381.202597779265;9475.715728528156;12412.81380779271;12438.81341779874;12533.874661253452;12600.117991740673;12711.30087845159;6892.379685828299;6924.23833378328;6987.510874238857;6991;7072.186698529632;6523.934760652332;6565.343465653492;6655.401013908771;6661.034150048215;6694.631795251211;5941.881162376815;6021.57848950578;6057.454829065406;6072.635641861502;6087.360827113178;1620.2465853378;1637.4187163556767;1654.6525229701656;1664.8285017042554;1736.4096207289583;803.3773825285334;903.1465265324206;931.2643012020563;940.741296143566;1012.1851909213007;17267.65464690699;18449.81550184481;18905.432837014912;18915.3379631715;19157.61684766297;876.2289185516831;886.2526168876432;923.2014307623857;926.420986883198;927.7170463008712;9845.45849978258;10482.318649287772;10497;10537.051665350155;10630.627928022483;376677;381753;388709.3387198389;389878;391159;69008.6549567249;72593.27406725865;73222.63388683023;80011.19988800155;81235.59382203169;988.6737376665683;995.7809281957958;1016.2632091733582;1054.4200689620832;1055.2244100586063;11938.940305298418;15124.39502419891;15663;15926.522204333889;16189.514314570111;32291.677083228868;33698.66301337053;37066.0347172231;37393.2521349566;37624.62375376211;43892.56107438885;46749.29876051794;48950.75524622354;51173;51634.48365516297;7982.401319900914;7998.360131189374;8051.154628763896;8119.228673276029;8326.084130745734;11200.831987520356;12028.578999734968;12132.939335303266;12199.634010979686;12500.874991249972;10631.627893023708;10731.356118632906;10888.45557722095;10921.126309895031;11069.280496767684;9858.457784821903;10263.178945684476;10342.741431464274;10368.222383321432;10967.616133435291;10664.680059598224;10915.945420272848;11095.833562496407;11135.276207046516;11163.72090697739;7772.805679858049;8006.679732810622;8198.016238051472;8228.50628962264;8229.423940324119;8289.83420331602;9575.377600455948;11139.16456265767;11161.665150045512;11186.32882027081 23:14:05 INFO - PROCESS | 8450 | |3;mootools.html;1276.0493432392868;1405.5221224783575;1445.147363055797;1467.515719812462;1574.8346423625512;6741.629210393427;7406.777796666095;7552.697892084324;7557.546547207171;7571.356434703057;7307.1231452225675;7435.962820185905;7451.366633836117;7457.291557302061;7463.3283004529585;1900.2304066852946;1963.8232559069681;2119.5337025854287;2202.7797220278003;2237.966430503544;2208.4147700859203;2223.8776867272295;2228.699125618045;2233.7431195412573;2234.452559123009;2125.9893700531475;2144.2066435418915;2147.6563749800034;2147.7207962964794;2149.8710077395326;1836.228783910754;2081.427607407975;2106.115431518766;2157.7518585362727;2159.017646970625;2133.3173384516963;2133.7332833395826;2146.0879126371387;2150.537634408594;2151.1825506307505;7627;7747.38020958322;7751.65117569705;7756.379489640872;7761.534307941542;4628.652851036186;4782.402199725035;4793.185158523024;4799.18413869643;4799.616030717534;2994.191568276553;3004.9248768780735;3047.6952304769566;3049.603551538308;3081.6302043754895;985.3792110970114;986.0977205856633;994.1053052252958;1006.2302338710892;1012.9189664826796;10765.97723216301;10766.730831729192;10783.245172837904;10792.082672972807;10816.351018938889;4326.286162783168;4337.6963612546815;4477.70894891831;4523.592876641118;4527.071950250191;9082.31882608807;9138.954305228432;9145.131212534798;9159.175674189355;9171.633134674672;4840.201366774513;4842.394700662418;4858.80564777412;4864.440589332201;4872.244802055687;3828.693704503633;4203.47456567929;4338.934915976263;4347.304431290978;4360.825566977349;3631.5279013728573;3675.9081022974638;3737.3085979093953;3756.342640038037;3808.5239345081864;1220.5789002794022;1234.3149551998727;1241.2862604002735;1248.5442813373236;1251.4305990774176;786.811165320319;802.7350974178507;806.9072056713553;810.9959450202712;837.3719710217337;5233.371995360505;5322.760475778599;5423.397258359897;5438.347398312228;5512.614117011851;894.4812009034745;911.3893691226893;912.1927094521396;930.0838673906197;943.2501161576563;3661.0664280608275;3727.1800203955086;3740.60723624021;3788.734788564829;3809.466674665549;9500.477473738873;9868.555914983843;9883.406995580288;9892.703218903445;9979.501024948724;9776.120149186607;9790.755231119136;9798.65704700332;9800.36297640651;9807.460589667637;6874.209465911485;7268.055152830204;7271;7304.342609165201;7317.926820731831;5461.5357694596405;5750.591105179258;5817.127430885401;5891.263592050994;5915.438033386821;8548.829023419621;8800.075992020746;8866.33502487329;8881.067487913935;8959.462432254086;8488.61801218959;8926.68756593516;8931.553422328727;8944.508052056939;9041.547922603975;6260.467860231931;6477.902831457438;6527.543071985106;6677.065210870385;6776.762813301708;7474.551526908403;7478.102627684495;7539.32146106853;7548.660310285941;7567.848643027219;6514.54398192122;6726.293739157318;6758.932410676027;6827.283135270924;6856.6228857413325;6722.932770672231;6724.092247546714;6732.057511948429;6752.561083529555;6912.205096413775;6226.40849119333;6491.642959637265;6548.345165483413;6562.606243625398;6566.376194261537;4542.931856022228;4680.94678697304;4759.6430267729365;4780.11567859947;4801.327814106098;4759.762011899322;4836.830710925101;4863.197572400514;4897.216445368724;4904.558589726942 23:14:05 INFO - PROCESS | 8450 | |4;prototype.html;311.7287959475256;312.0840333620823;314.5737525652739;315.3110453658756;319.11763972615705;5116.232565115234;5186.844394668156;5193.766280517376;5207.192885102815;5219.71291578963;5116.820911268106;5121.897562048757;5135.3067335909645;5143.81996630118;5159.948400515994;3780.5085338905974;3916.373380259159;3919.1377896862646;4055.128147448298;4058.0666446717273;4006.9198616027807;4040.2929487339743;4041.616046475595;4046.9595304047025;4050.574689657588;3773.52830896138;4012.1373904610505;4038.3942408638645;4045.3729671900755;4051.2910240707906;3839.1973859082887;3963.742356746802;3976;3983.661388781957;3987.963129586314;3498.1079824644553;3505.929881402383;3516.6659167379057;3517.8065206413635;3522.6750344772327;4863.27050942358;4872.902541949141;4873.926891096637;4878.585320247783;4928.088303663833;4306.5478124796755;4568.743595511228;4579.175748365293;4592.1045396147765;4607.327749905047;5389.849815641973;5397.46025397461;5402.297701298845;5404.378496472917;5418.647787893814;3776.772548921584;3783.148791521913;3785.5835858055593;3790.33669107905;3795.4876091727538;5581.6371935824045;5618.381977982419;5619.157126431027;5701.429857014306;5738.139279108125;3890.5525864525944;3917.8236979335998;3922.2939870823525;3924;3927.1149848073087;3968.6825053995613;3981.3828856527284;3984.940225896614;3987.4616926715103;3996.7402118862183;4412.492563355191;4514.841980530666;4585.587297143206;4587.509059555591;4591.609713174417;5424.891502169935;5429;5442.679965221212;5448.855740294583;5459.771551400903;1356.525216174331;1372.2658377768046;1374.587623712882;1375.3535838156051;1376.6833628265556;870.9956450217709;887.2901678657048;909.686158275394;913.830941275866;927.0729270729271;4636.211843986531;4645.233536466445;4668.346431499593;4676.742779147179;4679.204535229019;5535.7785688572;5541.667499950016;5543.390227075019;5548.9722551386985;5563.805266815642;4570.360149579062;4634.397528321297;4655.837045703384;4692.601128904082;4693.601043911238;2918.4892643787252;2927.5315949447986;2957.46765582193;2958.689337619562;2970.6435227772804;5185.248139019821;5186.81846135391;5193.7403129844115;5196.298499702568;5224.634275600672;5449.972750136303;5634.887302253932;5650.050732497282;5664;5689.886202275931;5159.974200128975;5179.19722443022;5182.97408512955;5191.351081114785;5198.2202669599865;5362.774448603942;5510.118381059011;5515.503604675438;5521.972390138184;5536.252605898152;5397.9460205397445;5430.592705547021;5435.239066530768;5439.5104440600535;5441.319835020622;5150.218881803784;5155.587552995677;5163.09645811989;5191.870203244949;5199.48005199477;3771.4719939207985;3838.481804956295;3848.1726428817938;3857.286402015636;3866.613338666111;5487.725613719218;5515.4760297771645;5526.41972592888;5535.418781027934;5537.833864984057;5301.575873930154;5326.254324394666;5361.142217245222;5366.114591092426;5371.570274377962;5182.24857395683;5341.786328546815;5346.117890548016;5347.331583552056;5348.384935732285;5002;5197;5263.289455923555;5275.366955965155;5278.577713782965;5296.199292240657;5466.453354664502;5472.945270547243;5484.61607687458;5494.2582751328055;5344.552763467619;5355.651882627617;5359.544438722596;5367.677939323653;5390.541803946551 23:14:05 INFO - PROCESS | 8450 | |5;yui.html;737.7233537423466;754.0611938137021;764.9770506884788;766.5170942306349;775.6044417347154;13859.930700346496;14384.856151438482;14438.350274237659;14440.783388249185;14483.493077742281;13971.091879027856;13995.580132596038;13999.160050396958;14149.646258843533;14184.787228191586;648.935106489352;806.4395245304515;819.4878201124312;830.9459885107478;832.2135581875131;836.5733475927291;839.4501601451029;839.6095815445816;839.7606682095604;839.8740188971673;851.1531026628513;854.6495936665968;858.0818524179131;858.8497013022727;859.4886042804521;681.6659836679991;839.95380254086;859.4070091636751;863.2791618998144;866.9349798765055;630.1870586942838;630.2972186012609;630.6783540394385;631.9778807741753;632.7943418389042;13051.412686429134;13082.803757943639;13088.41102150396;13108.672283192902;13114.540991065362;11931.642050738492;11938.403079845973;12298.385080745928;12523.56167534132;12532.686682832911;9885.555150018194;9926.702198934043;9926.751831204278;9950.203983681287;10013.449260290681;3303.3888730584918;3321.70104690579;3368.4778859276853;3394.2532642818787;3429.4855771634207;44811.551884481065;44983.77508112471;45146.645600632364;45500.3174952376;45600;9509.191718703849;9719.854202186973;9729.79414305722;9768.072033156981;9795.755106122404;16731.07979061139;16908.239129239213;16925;16946.915265423595;16969.321227150776;6755.22314933779;6792.864142717118;6866.210385805596;6878.415334696607;7016.543924644881;3866.4973553438435;3912.941305880414;3925.116848709075;3969.960300397017;4007.699422543321;2893.2911436698146;2950.439416510856;2952.025831475608;2963.6295463067117;2964.2589352661835;449.3394709776623;503.33308366414644;512.1523877981946;518.245952139636;519.1045446604652;548.314606741573;550.4385526762679;626.8902941985134;649.4285029174391;666.5434177588368;7839.412044096715;8222.917770822216;8466.830663386698;8552.144785521523;8632.525211113449;581.7062383496392;584.590786449487;586.524914818998;586.9501092407107;625.6308777821107;4007.499062617173;4019.3569028955226;4066;4104.774237416971;4172.082141928831;46116.7694161527;47721.76139119282;54521.18218226651;54616.45383546193;54980.72509637506;39953.60046399557;41029;41893.58106418958;42380.788096059936;42790.358144627855;36662.29236626358;37087.62912370896;37352;38526.6147338523;39018.41472377917;8125.8374832504205;8328.500289982621;8544;8554.828903422022;8636.568171591522;26827.73172268252;27204.047858324862;27710.44579108447;28261.01086461964;28292.86828526836;34694.13264668303;37027.25945481129;37078;37502.249955001294;37582.43626345662;10725.249232553646;10882.238243322892;10897.618583349546;10994.890051099386;11039.834402483808;11466.31202127875;11577.710557236136;11669.35818529989;11875.821862671894;12019.278843269432;11364.31814091124;11914.463849126636;11941.64175074749;11961.820572691591;11964;11105.555777768799;11155.49800258974;11882.108841836724;11952.402379881145;11957.581484648343;11114.555417783198;11153.776924461303;11728.061755059403;11744.647660570197;11795.056395488169;9572.56923438433;9832.754181145528;9862.063104005108;9931.404115753077;10097;9589.938163294924;9726.173275271682;9790.265730070416;9856;9926.553305101432 23:14:05 INFO - PROCESS | 8450 | __end_tp_report 23:14:05 INFO - PROCESS | 8450 | __start_cc_report 23:14:05 INFO - PROCESS | 8450 | _x_x_mozilla_cycle_collect,848 23:14:05 INFO - PROCESS | 8450 | __end_cc_report 23:14:05 INFO - PROCESS | 8450 | __startTimestamp1461478445124__endTimestamp 23:14:05 INFO - PROCESS | 8450 | 23:14:05 INFO - PROCESS | 8450 | ------- Summary: start ------- 23:14:05 INFO - PROCESS | 8450 | Number of tests: 6 23:14:05 INFO - PROCESS | 8450 | 23:14:05 INFO - PROCESS | 8450 | [#0] dojo.html Cycles:165 Average:4609.59 Median:4747.07 stddev:476.21 (10.0%) stddev-sans-first:450.40 23:14:05 INFO - PROCESS | 8450 | Values: 2584.7 2673.2 2675.9 2687.2 2701.8 4555.8 4595.0 4596.3 4599.9 4620.2 4592.1 4617.7 4662.6 4746.4 4749.0 4215.2 4235.3 4245.2 4248.0 4268.3 4300.8 4354.6 4367.2 4389.5 4389.5 4108.9 4186.7 4191.4 4300.4 4336.4 4158.6 4234.7 4273.0 4277.5 4280.3 4227.5 4265.1 4270.4 4293.9 4361.1 4524.5 4598.7 4603.2 4606.0 4652.7 4780.7 4974.9 5022.6 5041.5 5049.4 4982.8 4988.9 4989.7 5008.7 5029.9 4657.0 4680.4 4705.6 4707.3 4748.1 4985.9 5085.5 5131.0 5157.0 5166.7 4880.5 4888.1 4935.1 4940.4 4976.9 4989.4 5015.0 5015.6 5016.5 5029.7 4821.8 4845.3 4934.7 4942.2 5013.1 4866.4 4879.6 4881.7 4908.7 4939.3 4224.9 4226.5 4237.6 4262.7 4279.9 3590.6 3686.6 3705.6 3736.4 3813.3 4289.5 4294.0 4294.3 4323.1 4332.2 5016.2 5021.4 5021.7 5028.3 5066.6 4196.5 4295.6 4298.5 4365.7 4369.2 4496.9 4518.7 4525.8 4531.3 4568.6 4737.0 4739.2 4745.4 4747.1 4779.6 4874.0 4978.0 4987.2 5094.8 5113.9 4709.7 4731.4 4736.3 4745.4 4776.2 4951.7 4958.3 4958.5 4970.3 5021.3 4833.5 4874.6 4930.4 4932.2 4935.4 4785.7 4806.7 4846.7 4893.8 4917.2 4812.6 4820.2 4820.2 4820.4 4859.3 4666.5 4727.8 4753.2 4754.5 4789.0 4893.8 4931.2 4936.2 4979.0 4981.7 4822.4 4848.3 4850.5 4852.6 4896.9 23:14:05 INFO - PROCESS | 8450 | 23:14:05 INFO - PROCESS | 8450 | [#1] ext.html Cycles:180 Average:47772.14 Median:190745.15 stddev:85344.00 (44.7%) stddev-sans-first:85509.86 23:14:05 INFO - PROCESS | 8450 | Values: 578.1 598.2 607.9 618.2 638.5 30564.2 33664.0 34590.0 34686.8 34771.8 40987.6 41541.0 41730.6 41877.8 41939.0 7191.3 7760.7 7951.4 7952.2 9509.8 9674.1 9839.5 9852.4 9854.8 9854.9 9782.2 9882.0 9885.7 9899.0 9900.8 7367.6 9763.0 9839.0 9906.1 10340.7 9708.3 9859.7 9870.7 9873.7 9874.6 33251.3 33934.7 33979.2 34055.5 34068.5 3174.3 3183.6 3267.6 3375.7 3402.4 28770.4 29075.0 29385.3 29581.7 30314.5 3491.7 3502.8 3518.9 3573.8 3619.7 244477.2 245309.1 246142.0 246297.0 247065.0 51668.5 52464.0 52498.2 52565.7 52616.2 58561.0 60396.0 60494.4 60660.7 60717.0 13935.0 14160.9 14193.1 14195.9 14217.6 9342.6 10490.9 10651.6 10928.9 10943.9 17748.7 17810.8 17851.9 17853.6 17896.6 6833.4 6833.9 6888.3 6973.9 7078.2 920.7 1011.0 1036.6 1053.1 1060.3 27373.0 27855.7 28335.3 28449.6 28561.3 986.6 998.1 1002.7 1079.2 1085.0 14778.0 14789.8 15060.2 15084.8 15293.6 362543.0 368716.0 370873.0 371687.0 372184.0 48066.3 48932.0 48979.8 48982.8 48989.0 1034.6 1200.6 1238.4 1245.3 1365.0 24048.6 27509.4 29190.7 29396.4 29911.3 43396.8 44103.8 44298.0 44307.3 44321.0 340689.0 344631.0 346814.0 347096.0 348412.0 32830.4 41087.4 42045.0 42081.8 42304.0 39603.4 39842.6 39961.8 40056.4 40322.2 33385.3 34091.0 34479.1 34566.5 34815.1 33271.3 33458.8 34059.3 34193.0 34497.0 33530.0 33908.3 34442.1 34676.3 34704.0 30068.8 30411.2 30685.5 30750.2 31060.0 23589.8 23938.5 23969.6 24068.5 24377.8 23:14:05 INFO - PROCESS | 8450 | 23:14:05 INFO - PROCESS | 8450 | [#2] jquery.html Cycles:180 Average:24068.73 Median:18999.79 stddev:63503.51 (334.2%) stddev-sans-first:63656.70 23:14:05 INFO - PROCESS | 8450 | Values: 358.3 361.8 369.8 374.4 374.9 15555.1 16173.7 16505.4 16538.3 16582.9 15558.2 16665.8 16828.3 17359.3 17369.2 4825.5 5029.3 5077.5 5079.4 5085.4 3614.5 3815.0 5050.2 5599.8 5934.1 5866.2 5868.2 5885.1 5894.9 5902.9 5749.5 5770.9 5801.4 5953.6 5961.3 3357.2 4921.8 5211.6 5213.6 5219.4 19375.6 19640.6 19682.7 20766.0 20916.7 1877.6 1942.6 1943.0 1998.6 2138.7 13242.9 13267.3 13277.9 13343.3 13474.3 1756.7 1781.1 1836.1 1840.9 1859.7 63584.7 63587.0 63707.7 64599.7 65024.7 9051.6 9069.8 9264.2 9381.2 9475.7 12412.8 12438.8 12533.9 12600.1 12711.3 6892.4 6924.2 6987.5 6991.0 7072.2 6523.9 6565.3 6655.4 6661.0 6694.6 5941.9 6021.6 6057.5 6072.6 6087.4 1620.2 1637.4 1654.7 1664.8 1736.4 803.4 903.1 931.3 940.7 1012.2 17267.7 18449.8 18905.4 18915.3 19157.6 876.2 886.3 923.2 926.4 927.7 9845.5 10482.3 10497.0 10537.1 10630.6 376677.0 381753.0 388709.3 389878.0 391159.0 69008.7 72593.3 73222.6 80011.2 81235.6 988.7 995.8 1016.3 1054.4 1055.2 11938.9 15124.4 15663.0 15926.5 16189.5 32291.7 33698.7 37066.0 37393.3 37624.6 43892.6 46749.3 48950.8 51173.0 51634.5 7982.4 7998.4 8051.2 8119.2 8326.1 11200.8 12028.6 12132.9 12199.6 12500.9 10631.6 10731.4 10888.5 10921.1 11069.3 9858.5 10263.2 10342.7 10368.2 10967.6 10664.7 10915.9 11095.8 11135.3 11163.7 7772.8 8006.7 8198.0 8228.5 8229.4 8289.8 9575.4 11139.2 11161.7 11186.3 23:14:05 INFO - PROCESS | 8450 | 23:14:05 INFO - PROCESS | 8450 | [#3] mootools.html Cycles:180 Average:5181.97 Median:5449.94 stddev:2863.74 (52.5%) stddev-sans-first:2856.73 23:14:05 INFO - PROCESS | 8450 | Values: 1276.0 1405.5 1445.1 1467.5 1574.8 6741.6 7406.8 7552.7 7557.5 7571.4 7307.1 7436.0 7451.4 7457.3 7463.3 1900.2 1963.8 2119.5 2202.8 2238.0 2208.4 2223.9 2228.7 2233.7 2234.5 2126.0 2144.2 2147.7 2147.7 2149.9 1836.2 2081.4 2106.1 2157.8 2159.0 2133.3 2133.7 2146.1 2150.5 2151.2 7627.0 7747.4 7751.7 7756.4 7761.5 4628.7 4782.4 4793.2 4799.2 4799.6 2994.2 3004.9 3047.7 3049.6 3081.6 985.4 986.1 994.1 1006.2 1012.9 10766.0 10766.7 10783.2 10792.1 10816.4 4326.3 4337.7 4477.7 4523.6 4527.1 9082.3 9139.0 9145.1 9159.2 9171.6 4840.2 4842.4 4858.8 4864.4 4872.2 3828.7 4203.5 4338.9 4347.3 4360.8 3631.5 3675.9 3737.3 3756.3 3808.5 1220.6 1234.3 1241.3 1248.5 1251.4 786.8 802.7 806.9 811.0 837.4 5233.4 5322.8 5423.4 5438.3 5512.6 894.5 911.4 912.2 930.1 943.3 3661.1 3727.2 3740.6 3788.7 3809.5 9500.5 9868.6 9883.4 9892.7 9979.5 9776.1 9790.8 9798.7 9800.4 9807.5 6874.2 7268.1 7271.0 7304.3 7317.9 5461.5 5750.6 5817.1 5891.3 5915.4 8548.8 8800.1 8866.3 8881.1 8959.5 8488.6 8926.7 8931.6 8944.5 9041.5 6260.5 6477.9 6527.5 6677.1 6776.8 7474.6 7478.1 7539.3 7548.7 7567.8 6514.5 6726.3 6758.9 6827.3 6856.6 6722.9 6724.1 6732.1 6752.6 6912.2 6226.4 6491.6 6548.3 6562.6 6566.4 4542.9 4680.9 4759.6 4780.1 4801.3 4759.8 4836.8 4863.2 4897.2 4904.6 23:14:05 INFO - PROCESS | 8450 | 23:14:05 INFO - PROCESS | 8450 | [#4] prototype.html Cycles:180 Average:4455.23 Median:5147.02 stddev:1300.41 (25.3%) stddev-sans-first:1266.33 23:14:05 INFO - PROCESS | 8450 | Values: 311.7 312.1 314.6 315.3 319.1 5116.2 5186.8 5193.8 5207.2 5219.7 5116.8 5121.9 5135.3 5143.8 5159.9 3780.5 3916.4 3919.1 4055.1 4058.1 4006.9 4040.3 4041.6 4047.0 4050.6 3773.5 4012.1 4038.4 4045.4 4051.3 3839.2 3963.7 3976.0 3983.7 3988.0 3498.1 3505.9 3516.7 3517.8 3522.7 4863.3 4872.9 4873.9 4878.6 4928.1 4306.5 4568.7 4579.2 4592.1 4607.3 5389.8 5397.5 5402.3 5404.4 5418.6 3776.8 3783.1 3785.6 3790.3 3795.5 5581.6 5618.4 5619.2 5701.4 5738.1 3890.6 3917.8 3922.3 3924.0 3927.1 3968.7 3981.4 3984.9 3987.5 3996.7 4412.5 4514.8 4585.6 4587.5 4591.6 5424.9 5429.0 5442.7 5448.9 5459.8 1356.5 1372.3 1374.6 1375.4 1376.7 871.0 887.3 909.7 913.8 927.1 4636.2 4645.2 4668.3 4676.7 4679.2 5535.8 5541.7 5543.4 5549.0 5563.8 4570.4 4634.4 4655.8 4692.6 4693.6 2918.5 2927.5 2957.5 2958.7 2970.6 5185.2 5186.8 5193.7 5196.3 5224.6 5450.0 5634.9 5650.1 5664.0 5689.9 5160.0 5179.2 5183.0 5191.4 5198.2 5362.8 5510.1 5515.5 5522.0 5536.3 5397.9 5430.6 5435.2 5439.5 5441.3 5150.2 5155.6 5163.1 5191.9 5199.5 3771.5 3838.5 3848.2 3857.3 3866.6 5487.7 5515.5 5526.4 5535.4 5537.8 5301.6 5326.3 5361.1 5366.1 5371.6 5182.2 5341.8 5346.1 5347.3 5348.4 5002.0 5197.0 5263.3 5275.4 5278.6 5296.2 5466.5 5472.9 5484.6 5494.3 5344.6 5355.7 5359.5 5367.7 5390.5 23:14:05 INFO - PROCESS | 8450 | 23:14:05 INFO - PROCESS | 8450 | [#5] yui.html Cycles:180 Average:12566.79 Median:42585.57 stddev:13593.31 (31.9%) stddev-sans-first:13602.41 23:14:05 INFO - PROCESS | 8450 | Values: 737.7 754.1 765.0 766.5 775.6 13859.9 14384.9 14438.4 14440.8 14483.5 13971.1 13995.6 13999.2 14149.6 14184.8 648.9 806.4 819.5 830.9 832.2 836.6 839.5 839.6 839.8 839.9 851.2 854.6 858.1 858.8 859.5 681.7 840.0 859.4 863.3 866.9 630.2 630.3 630.7 632.0 632.8 13051.4 13082.8 13088.4 13108.7 13114.5 11931.6 11938.4 12298.4 12523.6 12532.7 9885.6 9926.7 9926.8 9950.2 10013.4 3303.4 3321.7 3368.5 3394.3 3429.5 44811.6 44983.8 45146.6 45500.3 45600.0 9509.2 9719.9 9729.8 9768.1 9795.8 16731.1 16908.2 16925.0 16946.9 16969.3 6755.2 6792.9 6866.2 6878.4 7016.5 3866.5 3912.9 3925.1 3970.0 4007.7 2893.3 2950.4 2952.0 2963.6 2964.3 449.3 503.3 512.2 518.2 519.1 548.3 550.4 626.9 649.4 666.5 7839.4 8222.9 8466.8 8552.1 8632.5 581.7 584.6 586.5 587.0 625.6 4007.5 4019.4 4066.0 4104.8 4172.1 46116.8 47721.8 54521.2 54616.5 54980.7 39953.6 41029.0 41893.6 42380.8 42790.4 36662.3 37087.6 37352.0 38526.6 39018.4 8125.8 8328.5 8544.0 8554.8 8636.6 26827.7 27204.0 27710.4 28261.0 28292.9 34694.1 37027.3 37078.0 37502.2 37582.4 10725.2 10882.2 10897.6 10994.9 11039.8 11466.3 11577.7 11669.4 11875.8 12019.3 11364.3 11914.5 11941.6 11961.8 11964.0 11105.6 11155.5 11882.1 11952.4 11957.6 11114.6 11153.8 11728.1 11744.6 11795.1 9572.6 9832.8 9862.1 9931.4 10097.0 9589.9 9726.2 9790.3 9856.0 9926.6 23:14:05 INFO - PROCESS | 8450 | -------- Summary: end -------- 23:14:05 INFO - PROCESS | 8450 | 23:14:05 INFO - TEST-INFO | 8450: exit 0 23:14:05 INFO - TEST-OK | dromaeo_css | took 1118300ms 23:14:05 INFO - TEST-START | kraken 23:14:05 INFO - operating with platform_type : linux_ 23:14:05 INFO - Initialising browser for kraken test... 23:14:05 INFO - TEST-INFO | started process 8625 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSQSqhJ/profile http://localhost:36967/getInfo.html) 23:14:09 INFO - PROCESS | 8625 | __metrics Screen width/height:1600/1200 23:14:09 INFO - PROCESS | 8625 | colorDepth:24 23:14:09 INFO - PROCESS | 8625 | Browser inner width/height: 1024/697 23:14:09 INFO - PROCESS | 8625 | __metrics 23:14:10 ERROR - PROCESS | 8625 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 23:14:11 INFO - TEST-INFO | 8625: exit 0 23:14:11 INFO - Browser initialized. 23:14:11 INFO - Running cycle 1/1 for kraken test... 23:14:11 INFO - TEST-INFO | started process 8704 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSQSqhJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:14:23 INFO - PROCESS | 8704 | RSS: Main: 156160000 23:14:23 INFO - PROCESS | 8704 | 23:14:26 INFO - PROCESS | 8704 | Cycle 1(1): loaded http://localhost:36967/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36967/tests/kraken/driver.html?testName=audio-beat-detection) 23:14:27 INFO - PROCESS | 8704 | RSS: Main: 210894848 23:14:27 INFO - PROCESS | 8704 | 23:14:29 INFO - PROCESS | 8704 | Cycle 1(1): loaded http://localhost:36967/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36967/tests/kraken/driver.html?testName=audio-dft) 23:14:30 INFO - PROCESS | 8704 | RSS: Main: 198672384 23:14:30 INFO - PROCESS | 8704 | 23:14:33 INFO - PROCESS | 8704 | Cycle 1(1): loaded http://localhost:36967/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36967/tests/kraken/driver.html?testName=audio-fft) 23:14:34 INFO - PROCESS | 8704 | RSS: Main: 267046912 23:14:34 INFO - PROCESS | 8704 | 23:14:36 INFO - PROCESS | 8704 | Cycle 1(1): loaded http://localhost:36967/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36967/tests/kraken/driver.html?testName=audio-oscillator) 23:14:37 INFO - PROCESS | 8704 | RSS: Main: 175685632 23:14:37 INFO - PROCESS | 8704 | 23:14:39 INFO - PROCESS | 8704 | Cycle 1(1): loaded http://localhost:36967/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36967/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:14:39 INFO - PROCESS | 8704 | RSS: Main: 179965952 23:14:39 INFO - PROCESS | 8704 | 23:14:43 INFO - PROCESS | 8704 | Cycle 1(1): loaded http://localhost:36967/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36967/tests/kraken/driver.html?testName=imaging-darkroom) 23:14:43 INFO - PROCESS | 8704 | RSS: Main: 215871488 23:14:43 INFO - PROCESS | 8704 | 23:14:47 INFO - PROCESS | 8704 | Cycle 1(1): loaded http://localhost:36967/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36967/tests/kraken/driver.html?testName=imaging-desaturate) 23:14:47 INFO - PROCESS | 8704 | RSS: Main: 215973888 23:14:47 INFO - PROCESS | 8704 | 23:14:50 INFO - PROCESS | 8704 | Cycle 1(1): loaded http://localhost:36967/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36967/tests/kraken/driver.html?testName=json-parse-financial) 23:14:51 INFO - PROCESS | 8704 | RSS: Main: 216174592 23:14:51 INFO - PROCESS | 8704 | 23:14:52 INFO - PROCESS | 8704 | Cycle 1(1): loaded http://localhost:36967/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36967/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:14:53 INFO - PROCESS | 8704 | RSS: Main: 202145792 23:14:53 INFO - PROCESS | 8704 | 23:14:55 INFO - PROCESS | 8704 | Cycle 1(1): loaded http://localhost:36967/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36967/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:14:56 INFO - PROCESS | 8704 | RSS: Main: 205938688 23:14:56 INFO - PROCESS | 8704 | 23:14:58 INFO - PROCESS | 8704 | Cycle 1(1): loaded http://localhost:36967/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36967/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:14:58 INFO - PROCESS | 8704 | RSS: Main: 217903104 23:14:58 INFO - PROCESS | 8704 | 23:15:01 INFO - PROCESS | 8704 | Cycle 1(1): loaded http://localhost:36967/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36967/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:15:02 INFO - PROCESS | 8704 | RSS: Main: 225976320 23:15:02 INFO - PROCESS | 8704 | 23:15:05 INFO - PROCESS | 8704 | Cycle 1(1): loaded http://localhost:36967/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36967/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:15:05 INFO - PROCESS | 8704 | RSS: Main: 221859840 23:15:05 INFO - PROCESS | 8704 | 23:15:07 INFO - PROCESS | 8704 | Cycle 1(1): loaded http://localhost:36967/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36967/tests/kraken/driver.html?testName=ai-astar) 23:15:07 INFO - PROCESS | 8704 | RSS: Main: 285319168 23:15:07 INFO - PROCESS | 8704 | 23:15:07 INFO - PROCESS | 8704 | __start_tp_report 23:15:07 INFO - PROCESS | 8704 | _x_x_mozilla_page_load 23:15:07 INFO - PROCESS | 8704 | _x_x_mozilla_page_load_details 23:15:07 INFO - PROCESS | 8704 | |i|pagename|runs| 23:15:07 INFO - PROCESS | 8704 | |0;ai-astar;111;113;108;113;114;113;105;114;113;115 23:15:07 INFO - PROCESS | 8704 | |1;audio-beat-detection;168;132;157;193;134;161;158;132;195;133 23:15:07 INFO - PROCESS | 8704 | |2;audio-dft;162;161;161;162;162;162;162;161;161;161 23:15:07 INFO - PROCESS | 8704 | |3;audio-fft;73;74;107;114;76;76;73;121;102;74 23:15:07 INFO - PROCESS | 8704 | |4;audio-oscillator;94;93;141;94;95;95;137;93;94;144 23:15:07 INFO - PROCESS | 8704 | |5;imaging-gaussian-blur;117;117;116;116;117;117;119;117;117;117 23:15:07 INFO - PROCESS | 8704 | |6;imaging-darkroom;148;146;146;145;145;146;145;145;145;145 23:15:07 INFO - PROCESS | 8704 | |7;imaging-desaturate;94;94;94;95;94;94;95;95;95;94 23:15:07 INFO - PROCESS | 8704 | |8;json-parse-financial;66;66;66;67;66;65;67;89;64;66 23:15:07 INFO - PROCESS | 8704 | |9;json-stringify-tinderbox;65;64;63;65;65;64;64;64;65;64 23:15:07 INFO - PROCESS | 8704 | |10;stanford-crypto-aes;78;78;78;77;80;87;81;89;80;79 23:15:07 INFO - PROCESS | 8704 | |11;stanford-crypto-ccm;133;136;143;132;131;129;130;137;178;132 23:15:07 INFO - PROCESS | 8704 | |12;stanford-crypto-pbkdf2;177;177;172;177;170;169;188;168;171;183 23:15:07 INFO - PROCESS | 8704 | |13;stanford-crypto-sha256-iterative;73;72;71;72;72;73;72;73;72;71 23:15:07 INFO - PROCESS | 8704 | __end_tp_report 23:15:07 INFO - PROCESS | 8704 | __start_cc_report 23:15:07 INFO - PROCESS | 8704 | _x_x_mozilla_cycle_collect,1933 23:15:07 INFO - PROCESS | 8704 | __end_cc_report 23:15:07 INFO - PROCESS | 8704 | __startTimestamp1461478507881__endTimestamp 23:15:07 INFO - PROCESS | 8704 | 23:15:07 INFO - PROCESS | 8704 | ------- Summary: start ------- 23:15:07 INFO - PROCESS | 8704 | Number of tests: 14 23:15:07 INFO - PROCESS | 8704 | 23:15:07 INFO - PROCESS | 8704 | [#0] ai-astar Cycles:10 Average:111.90 Median:113.00 stddev:3.11 (2.7%) stddev-sans-first:3.28 23:15:07 INFO - PROCESS | 8704 | Values: 111.0 113.0 108.0 113.0 114.0 113.0 105.0 114.0 113.0 115.0 23:15:07 INFO - PROCESS | 8704 | 23:15:07 INFO - PROCESS | 8704 | [#1] audio-beat-detection Cycles:10 Average:156.30 Median:159.50 stddev:24.10 (15.1%) stddev-sans-first:25.19 23:15:07 INFO - PROCESS | 8704 | Values: 168.0 132.0 157.0 193.0 134.0 161.0 158.0 132.0 195.0 133.0 23:15:07 INFO - PROCESS | 8704 | 23:15:07 INFO - PROCESS | 8704 | [#2] audio-dft Cycles:10 Average:161.50 Median:162.00 stddev:0.53 (0.3%) stddev-sans-first:0.53 23:15:07 INFO - PROCESS | 8704 | Values: 162.0 161.0 161.0 162.0 162.0 162.0 162.0 161.0 161.0 161.0 23:15:07 INFO - PROCESS | 8704 | 23:15:07 INFO - PROCESS | 8704 | [#3] audio-fft Cycles:10 Average:89.00 Median:73.50 stddev:19.56 (26.6%) stddev-sans-first:19.87 23:15:07 INFO - PROCESS | 8704 | Values: 73.0 74.0 107.0 114.0 76.0 76.0 73.0 121.0 102.0 74.0 23:15:07 INFO - PROCESS | 8704 | 23:15:07 INFO - PROCESS | 8704 | [#4] audio-oscillator Cycles:10 Average:108.00 Median:94.00 stddev:22.61 (24.1%) stddev-sans-first:23.41 23:15:07 INFO - PROCESS | 8704 | Values: 94.0 93.0 141.0 94.0 95.0 95.0 137.0 93.0 94.0 144.0 23:15:07 INFO - PROCESS | 8704 | 23:15:07 INFO - PROCESS | 8704 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.82 (0.7%) stddev-sans-first:0.87 23:15:07 INFO - PROCESS | 8704 | Values: 117.0 117.0 116.0 116.0 117.0 117.0 119.0 117.0 117.0 117.0 23:15:07 INFO - PROCESS | 8704 | 23:15:07 INFO - PROCESS | 8704 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:145.50 stddev:0.97 (0.7%) stddev-sans-first:0.50 23:15:07 INFO - PROCESS | 8704 | Values: 148.0 146.0 146.0 145.0 145.0 146.0 145.0 145.0 145.0 145.0 23:15:07 INFO - PROCESS | 8704 | 23:15:07 INFO - PROCESS | 8704 | [#7] imaging-desaturate Cycles:10 Average:94.40 Median:94.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 23:15:07 INFO - PROCESS | 8704 | Values: 94.0 94.0 94.0 95.0 94.0 94.0 95.0 95.0 95.0 94.0 23:15:07 INFO - PROCESS | 8704 | 23:15:07 INFO - PROCESS | 8704 | [#8] json-parse-financial Cycles:10 Average:68.20 Median:66.00 stddev:7.36 (11.2%) stddev-sans-first:7.76 23:15:07 INFO - PROCESS | 8704 | Values: 66.0 66.0 66.0 67.0 66.0 65.0 67.0 89.0 64.0 66.0 23:15:07 INFO - PROCESS | 8704 | 23:15:07 INFO - PROCESS | 8704 | [#9] json-stringify-tinderbox Cycles:10 Average:64.30 Median:64.50 stddev:0.67 (1.0%) stddev-sans-first:0.67 23:15:07 INFO - PROCESS | 8704 | Values: 65.0 64.0 63.0 65.0 65.0 64.0 64.0 64.0 65.0 64.0 23:15:07 INFO - PROCESS | 8704 | 23:15:07 INFO - PROCESS | 8704 | [#10] stanford-crypto-aes Cycles:10 Average:80.70 Median:80.00 stddev:4.06 (5.1%) stddev-sans-first:4.18 23:15:07 INFO - PROCESS | 8704 | Values: 78.0 78.0 78.0 77.0 80.0 87.0 81.0 89.0 80.0 79.0 23:15:07 INFO - PROCESS | 8704 | 23:15:07 INFO - PROCESS | 8704 | [#11] stanford-crypto-ccm Cycles:10 Average:138.10 Median:134.50 stddev:14.61 (10.9%) stddev-sans-first:15.38 23:15:07 INFO - PROCESS | 8704 | Values: 133.0 136.0 143.0 132.0 131.0 129.0 130.0 137.0 178.0 132.0 23:15:07 INFO - PROCESS | 8704 | 23:15:07 INFO - PROCESS | 8704 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.20 Median:177.00 stddev:6.49 (3.7%) stddev-sans-first:6.86 23:15:07 INFO - PROCESS | 8704 | Values: 177.0 177.0 172.0 177.0 170.0 169.0 188.0 168.0 171.0 183.0 23:15:07 INFO - PROCESS | 8704 | 23:15:07 INFO - PROCESS | 8704 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.10 Median:72.00 stddev:0.74 (1.0%) stddev-sans-first:0.71 23:15:07 INFO - PROCESS | 8704 | Values: 73.0 72.0 71.0 72.0 72.0 73.0 72.0 73.0 72.0 71.0 23:15:07 INFO - PROCESS | 8704 | -------- Summary: end -------- 23:15:07 INFO - PROCESS | 8704 | 23:15:08 INFO - TEST-INFO | 8704: exit 0 23:15:08 INFO - TEST-OK | kraken | took 63080ms 23:15:08 INFO - SUITE-END | took 1181s 23:15:09 INFO - Completed test suite (00:19:41) 23:15:09 INFO - javascript benchmark 23:15:09 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2584.651072105266, 2673.1846786730052, 2675.879585418656, 2687.234138270593, 2701.8378897266166, 4555.840545580905, 4595.0, 4596.28757542581, 4599.908001839965, 4620.191466493363, 4592.081583683268, 4617.722936623805, 4662.603678687307, 4746.430428348603, 4749.0, 4215.199112168693, 4235.322348424253, 4245.193413251488, 4248.0, 4268.253055715253, 4300.827966881321, 4354.629856462205, 4367.192069467143, 4389.4513185851765, 4389.517153113155, 4108.876733697994, 4186.706930514865, 4191.434156388879, 4300.376445415397, 4336.436263285768, 4158.584141585848, 4234.724742891703, 4273.017206042597, 4277.508086570053, 4280.250956082673, 4227.513835908879, 4265.0830071534765, 4270.4234928284595, 4293.914121717579, 4361.149575832714, 4524.524924882873, 4598.678092533524, 4603.240465323218, 4606.0, 4652.69757465767, 4780.689255198436, 4974.925376119361, 5022.59819214462, 5041.546260836542, 5049.419316778581, 4982.825601103944, 4988.87527811804, 4989.65072444929, 5008.749562521859, 5029.899402011939, 4656.95343046572, 4680.438347398334, 4705.623550115983, 4707.29390591414, 4748.074125545486, 4985.925211121836, 5085.542301192911, 5131.0, 5157.020166168416, 5166.689998600096, 4880.487548807395, 4888.071266459361, 4935.087008903364, 4940.382452193476, 4976.900461990812, 4989.401271847401, 5014.974925125351, 5015.598752099823, 5016.5485106339875, 5029.673071250357, 4821.807127714922, 4845.345878306383, 4934.679245849008, 4942.233953737176, 5013.1227035268685, 4866.416030076342, 4879.585235255043, 4881.707097574086, 4908.705477671351, 4939.259111133287, 4224.894377640522, 4226.450561426995, 4237.597428244312, 4262.722923009995, 4279.935800962988, 3590.56913170416, 3686.594474607791, 3705.5923848376656, 3736.4208547675153, 3813.3136035513876, 4289.485261768546, 4293.97853010733, 4294.312909934395, 4323.0705398339505, 4332.241857674894, 5016.172331565251, 5021.372328458942, 5021.72380519075, 5028.270900719448, 5066.594672426197, 4196.475440569929, 4295.570442955742, 4298.484181898192, 4365.694401391936, 4369.191699535532, 4496.865094047183, 4518.728876267434, 4525.773711314421, 4531.274996000624, 4568.6116680081905, 4736.976315118402, 4739.170645137018, 4745.359376484131, 4747.074320507468, 4779.617630589544, 4873.951260487492, 4978.029284289673, 4987.177115775857, 5094.821681241138, 5113.923291150561, 4709.670323077352, 4731.361266229015, 4736.313234580897, 4745.430548334084, 4776.23580227162, 4951.702897826142, 4958.330625365529, 4958.528939750718, 4970.279309500174, 5021.271915572149, 4833.492483289345, 4874.561289483963, 4930.383702037246, 4932.161532539549, 4935.383077115361, 4785.712857228577, 4806.711597304173, 4846.660733748604, 4893.779779909842, 4917.164082105979, 4812.590929771009, 4820.156472617348, 4820.204666230033, 4820.373351464287, 4859.319695242598, 4666.486686464554, 4727.763611819464, 4753.215719406259, 4754.4770075291, 4789.042191561632, 4893.755312234445, 4931.161702510653, 4936.185529387611, 4979.029089327546, 4981.726005069756, 4822.42130944289, 4848.3454733611925, 4850.53919877611, 4852.587530059985, 4896.92654610174], "value": 4580.020736959231, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [578.0895090232884, 598.1954271504826, 607.887540804951, 618.2457401969596, 638.4573112854072, 30564.235894102658, 33664.0, 34590.0, 34686.826565867166, 34771.82614086932, 40987.59012409875, 41541.0, 41730.58269417305, 41877.79061104698, 41939.0, 7191.280871912793, 7760.689572417111, 7951.443398962075, 7952.204779522031, 9509.762255943622, 9674.08096230857, 9839.45882976436, 9852.359596626196, 9854.753631159207, 9854.852177217348, 9782.168515676176, 9881.95059024704, 9885.654002109928, 9899.0, 9900.801983960317, 7367.631618419111, 9763.0, 9838.999999999964, 9906.108450239513, 10340.689779306633, 9708.271879608987, 9859.704208873745, 9870.703878883573, 9873.703788886345, 9874.60501579936, 33251.33497330064, 33934.660653393395, 33979.15052123692, 34055.489167662505, 34068.48897266543, 3174.254050298201, 3183.602049743782, 3267.607887053569, 3375.729941604666, 3402.4385976314124, 28770.424591508054, 29075.0, 29385.265368365963, 29581.70418295811, 30314.54528182079, 3491.6682915123024, 3502.7898326100517, 3518.9472157917653, 3573.76770509916, 3619.69232615228, 244477.22091116334, 245309.0549114302, 246142.0, 246297.0, 247065.0, 51668.48331516637, 52464.0, 52498.21252681213, 52565.7371713139, 52616.21075683868, 58561.0, 60396.0, 60494.395056049754, 60660.696696516236, 60717.0, 13935.0, 14160.858391415954, 14193.148411095368, 14195.85804141966, 14217.644558885904, 9342.626294948263, 10490.895091048991, 10651.573937042587, 10928.890711092947, 10943.890561094287, 17748.733768993476, 17810.821891781176, 17851.910740446474, 17853.642927141384, 17896.642067158584, 6833.384995350442, 6833.863322733518, 6888.346796768739, 6973.860522789516, 7078.150621925299, 920.7099763574453, 1010.9536629588341, 1036.5542816588788, 1053.115383078218, 1060.3319908457777, 27373.0, 27855.721442785718, 28335.29161770972, 28449.57325640117, 28561.28596785097, 986.6152200641756, 998.0767789794556, 1002.6791426743372, 1079.2391364088298, 1085.0234788690243, 14778.0, 14789.778153327708, 15060.171690557125, 15084.849151508564, 15293.617659558378, 362543.0, 368716.0, 370873.0, 371687.0, 372184.0, 48066.27900581494, 48932.0, 48979.75510122427, 48982.755086224344, 48989.0, 1034.5551412892378, 1200.6278053803348, 1238.4365113873346, 1245.3337464456472, 1364.969448066723, 24048.639270410607, 27509.44981100407, 29190.70809291965, 29396.41207175802, 29911.252218694706, 43396.783016084715, 44103.77948110239, 44298.0, 44307.33538996853, 44321.0, 340689.0, 344631.0, 346814.0, 347096.0, 348412.0, 32830.40374347546, 41087.38368924528, 42045.0, 42081.78959105185, 42304.0, 39603.405948910215, 39842.60157398389, 39961.80019099886, 40056.3991540133, 40322.1935561293, 33385.332293354484, 34091.0, 34479.13802154966, 34566.48150277697, 34815.12962175966, 33271.33457330888, 33458.83270583729, 34059.318813624086, 34193.0, 34497.0, 33530.0, 33908.321833563685, 34442.13894652654, 34676.306473869874, 34704.0, 30068.849655751583, 30411.2397190072, 30685.53971690382, 30750.231244219074, 31060.0, 23589.764102358757, 23938.52122957566, 23969.64045539353, 24068.51862962766, 24377.756222437547], "value": 18120.098630630946, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [358.3156171712032, 361.766660503975, 369.83727160049574, 374.4215187535258, 374.94750734897104, 15555.144467054308, 16173.676526469479, 16505.422310219146, 16538.255778489965, 16582.91708541457, 15558.222088895567, 16665.75012373329, 16828.32686692531, 17359.305627774873, 17369.218385172666, 4825.541573550507, 5029.346184995946, 5077.517635824609, 5079.4412614612365, 5085.364329458817, 3614.475900994354, 3815.0271680721517, 5050.166722490784, 5599.832005039855, 5934.1098835174635, 5866.237389139406, 5868.2371291732225, 5885.087811389241, 5894.941050589504, 5902.911456328158, 5749.453801888814, 5770.913436298459, 5801.361850196497, 5953.613015154001, 5961.314448838396, 3357.194273374397, 4921.7785199666105, 5211.609129315317, 5213.635045546814, 5219.373675158968, 19375.612487750306, 19640.607187856163, 19682.70475942862, 20766.0, 20916.686249706265, 1877.5869308752053, 1942.5823447958758, 1942.951426214356, 1998.6202621501868, 2138.721966144407, 13242.933785331012, 13267.336633168303, 13277.933610331887, 13343.266120363376, 13474.258915759629, 1756.7277072053853, 1781.118346418518, 1836.0819590204896, 1840.8527317814676, 1859.739636450898, 63584.68207658979, 63587.0, 63707.681461592394, 64599.677001615164, 65024.674876625315, 9051.637934482547, 9069.77325566853, 9264.212541934012, 9381.202597779265, 9475.715728528156, 12412.81380779271, 12438.81341779874, 12533.874661253452, 12600.117991740673, 12711.30087845159, 6892.379685828299, 6924.23833378328, 6987.510874238857, 6991.0, 7072.186698529632, 6523.934760652332, 6565.343465653492, 6655.401013908771, 6661.034150048215, 6694.631795251211, 5941.881162376815, 6021.57848950578, 6057.454829065406, 6072.635641861502, 6087.360827113178, 1620.2465853378, 1637.4187163556767, 1654.6525229701656, 1664.8285017042554, 1736.4096207289583, 803.3773825285334, 903.1465265324206, 931.2643012020563, 940.741296143566, 1012.1851909213007, 17267.65464690699, 18449.81550184481, 18905.432837014912, 18915.3379631715, 19157.61684766297, 876.2289185516831, 886.2526168876432, 923.2014307623857, 926.420986883198, 927.7170463008712, 9845.45849978258, 10482.318649287772, 10497.0, 10537.051665350155, 10630.627928022483, 376677.0, 381753.0, 388709.3387198389, 389878.0, 391159.0, 69008.6549567249, 72593.27406725865, 73222.63388683023, 80011.19988800155, 81235.59382203169, 988.6737376665683, 995.7809281957958, 1016.2632091733582, 1054.4200689620832, 1055.2244100586063, 11938.940305298418, 15124.39502419891, 15663.0, 15926.522204333889, 16189.514314570111, 32291.677083228868, 33698.66301337053, 37066.0347172231, 37393.2521349566, 37624.62375376211, 43892.56107438885, 46749.29876051794, 48950.75524622354, 51173.0, 51634.48365516297, 7982.401319900914, 7998.360131189374, 8051.154628763896, 8119.228673276029, 8326.084130745734, 11200.831987520356, 12028.578999734968, 12132.939335303266, 12199.634010979686, 12500.874991249972, 10631.627893023708, 10731.356118632906, 10888.45557722095, 10921.126309895031, 11069.280496767684, 9858.457784821903, 10263.178945684476, 10342.741431464274, 10368.222383321432, 10967.616133435291, 10664.680059598224, 10915.945420272848, 11095.833562496407, 11135.276207046516, 11163.72090697739, 7772.805679858049, 8006.679732810622, 8198.016238051472, 8228.50628962264, 8229.423940324119, 8289.83420331602, 9575.377600455948, 11139.16456265767, 11161.665150045512, 11186.32882027081], "value": 8366.687847042649, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1276.0493432392868, 1405.5221224783575, 1445.147363055797, 1467.515719812462, 1574.8346423625512, 6741.629210393427, 7406.777796666095, 7552.697892084324, 7557.546547207171, 7571.356434703057, 7307.1231452225675, 7435.962820185905, 7451.366633836117, 7457.291557302061, 7463.3283004529585, 1900.2304066852946, 1963.8232559069681, 2119.5337025854287, 2202.7797220278003, 2237.966430503544, 2208.4147700859203, 2223.8776867272295, 2228.699125618045, 2233.7431195412573, 2234.452559123009, 2125.9893700531475, 2144.2066435418915, 2147.6563749800034, 2147.7207962964794, 2149.8710077395326, 1836.228783910754, 2081.427607407975, 2106.115431518766, 2157.7518585362727, 2159.017646970625, 2133.3173384516963, 2133.7332833395826, 2146.0879126371387, 2150.537634408594, 2151.1825506307505, 7627.0, 7747.38020958322, 7751.65117569705, 7756.379489640872, 7761.534307941542, 4628.652851036186, 4782.402199725035, 4793.185158523024, 4799.18413869643, 4799.616030717534, 2994.191568276553, 3004.9248768780735, 3047.6952304769566, 3049.603551538308, 3081.6302043754895, 985.3792110970114, 986.0977205856633, 994.1053052252958, 1006.2302338710892, 1012.9189664826796, 10765.97723216301, 10766.730831729192, 10783.245172837904, 10792.082672972807, 10816.351018938889, 4326.286162783168, 4337.6963612546815, 4477.70894891831, 4523.592876641118, 4527.071950250191, 9082.31882608807, 9138.954305228432, 9145.131212534798, 9159.175674189355, 9171.633134674672, 4840.201366774513, 4842.394700662418, 4858.80564777412, 4864.440589332201, 4872.244802055687, 3828.693704503633, 4203.47456567929, 4338.934915976263, 4347.304431290978, 4360.825566977349, 3631.5279013728573, 3675.9081022974638, 3737.3085979093953, 3756.342640038037, 3808.5239345081864, 1220.5789002794022, 1234.3149551998727, 1241.2862604002735, 1248.5442813373236, 1251.4305990774176, 786.811165320319, 802.7350974178507, 806.9072056713553, 810.9959450202712, 837.3719710217337, 5233.371995360505, 5322.760475778599, 5423.397258359897, 5438.347398312228, 5512.614117011851, 894.4812009034745, 911.3893691226893, 912.1927094521396, 930.0838673906197, 943.2501161576563, 3661.0664280608275, 3727.1800203955086, 3740.60723624021, 3788.734788564829, 3809.466674665549, 9500.477473738873, 9868.555914983843, 9883.406995580288, 9892.703218903445, 9979.501024948724, 9776.120149186607, 9790.755231119136, 9798.65704700332, 9800.36297640651, 9807.460589667637, 6874.209465911485, 7268.055152830204, 7271.0, 7304.342609165201, 7317.926820731831, 5461.5357694596405, 5750.591105179258, 5817.127430885401, 5891.263592050994, 5915.438033386821, 8548.829023419621, 8800.075992020746, 8866.33502487329, 8881.067487913935, 8959.462432254086, 8488.61801218959, 8926.68756593516, 8931.553422328727, 8944.508052056939, 9041.547922603975, 6260.467860231931, 6477.902831457438, 6527.543071985106, 6677.065210870385, 6776.762813301708, 7474.551526908403, 7478.102627684495, 7539.32146106853, 7548.660310285941, 7567.848643027219, 6514.54398192122, 6726.293739157318, 6758.932410676027, 6827.283135270924, 6856.6228857413325, 6722.932770672231, 6724.092247546714, 6732.057511948429, 6752.561083529555, 6912.205096413775, 6226.40849119333, 6491.642959637265, 6548.345165483413, 6562.606243625398, 6566.376194261537, 4542.931856022228, 4680.94678697304, 4759.6430267729365, 4780.11567859947, 4801.327814106098, 4759.762011899322, 4836.830710925101, 4863.197572400514, 4897.216445368724, 4904.558589726942], "value": 4188.714507726648, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [311.7287959475256, 312.0840333620823, 314.5737525652739, 315.3110453658756, 319.11763972615705, 5116.232565115234, 5186.844394668156, 5193.766280517376, 5207.192885102815, 5219.71291578963, 5116.820911268106, 5121.897562048757, 5135.3067335909645, 5143.81996630118, 5159.948400515994, 3780.5085338905974, 3916.373380259159, 3919.1377896862646, 4055.128147448298, 4058.0666446717273, 4006.9198616027807, 4040.2929487339743, 4041.616046475595, 4046.9595304047025, 4050.574689657588, 3773.52830896138, 4012.1373904610505, 4038.3942408638645, 4045.3729671900755, 4051.2910240707906, 3839.1973859082887, 3963.742356746802, 3976.0, 3983.661388781957, 3987.963129586314, 3498.1079824644553, 3505.929881402383, 3516.6659167379057, 3517.8065206413635, 3522.6750344772327, 4863.27050942358, 4872.902541949141, 4873.926891096637, 4878.585320247783, 4928.088303663833, 4306.5478124796755, 4568.743595511228, 4579.175748365293, 4592.1045396147765, 4607.327749905047, 5389.849815641973, 5397.46025397461, 5402.297701298845, 5404.378496472917, 5418.647787893814, 3776.772548921584, 3783.148791521913, 3785.5835858055593, 3790.33669107905, 3795.4876091727538, 5581.6371935824045, 5618.381977982419, 5619.157126431027, 5701.429857014306, 5738.139279108125, 3890.5525864525944, 3917.8236979335998, 3922.2939870823525, 3924.0, 3927.1149848073087, 3968.6825053995613, 3981.3828856527284, 3984.940225896614, 3987.4616926715103, 3996.7402118862183, 4412.492563355191, 4514.841980530666, 4585.587297143206, 4587.509059555591, 4591.609713174417, 5424.891502169935, 5429.0, 5442.679965221212, 5448.855740294583, 5459.771551400903, 1356.525216174331, 1372.2658377768046, 1374.587623712882, 1375.3535838156051, 1376.6833628265556, 870.9956450217709, 887.2901678657048, 909.686158275394, 913.830941275866, 927.0729270729271, 4636.211843986531, 4645.233536466445, 4668.346431499593, 4676.742779147179, 4679.204535229019, 5535.7785688572, 5541.667499950016, 5543.390227075019, 5548.9722551386985, 5563.805266815642, 4570.360149579062, 4634.397528321297, 4655.837045703384, 4692.601128904082, 4693.601043911238, 2918.4892643787252, 2927.5315949447986, 2957.46765582193, 2958.689337619562, 2970.6435227772804, 5185.248139019821, 5186.81846135391, 5193.7403129844115, 5196.298499702568, 5224.634275600672, 5449.972750136303, 5634.887302253932, 5650.050732497282, 5664.0, 5689.886202275931, 5159.974200128975, 5179.19722443022, 5182.97408512955, 5191.351081114785, 5198.2202669599865, 5362.774448603942, 5510.118381059011, 5515.503604675438, 5521.972390138184, 5536.252605898152, 5397.9460205397445, 5430.592705547021, 5435.239066530768, 5439.5104440600535, 5441.319835020622, 5150.218881803784, 5155.587552995677, 5163.09645811989, 5191.870203244949, 5199.48005199477, 3771.4719939207985, 3838.481804956295, 3848.1726428817938, 3857.286402015636, 3866.613338666111, 5487.725613719218, 5515.4760297771645, 5526.41972592888, 5535.418781027934, 5537.833864984057, 5301.575873930154, 5326.254324394666, 5361.142217245222, 5366.114591092426, 5371.570274377962, 5182.24857395683, 5341.786328546815, 5346.117890548016, 5347.331583552056, 5348.384935732285, 5002.0, 5197.0, 5263.289455923555, 5275.366955965155, 5278.577713782965, 5296.199292240657, 5466.453354664502, 5472.945270547243, 5484.61607687458, 5494.2582751328055, 5344.552763467619, 5355.651882627617, 5359.544438722596, 5367.677939323653, 5390.541803946551], "value": 4040.789205716986, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [737.7233537423466, 754.0611938137021, 764.9770506884788, 766.5170942306349, 775.6044417347154, 13859.930700346496, 14384.856151438482, 14438.350274237659, 14440.783388249185, 14483.493077742281, 13971.091879027856, 13995.580132596038, 13999.160050396958, 14149.646258843533, 14184.787228191586, 648.935106489352, 806.4395245304515, 819.4878201124312, 830.9459885107478, 832.2135581875131, 836.5733475927291, 839.4501601451029, 839.6095815445816, 839.7606682095604, 839.8740188971673, 851.1531026628513, 854.6495936665968, 858.0818524179131, 858.8497013022727, 859.4886042804521, 681.6659836679991, 839.95380254086, 859.4070091636751, 863.2791618998144, 866.9349798765055, 630.1870586942838, 630.2972186012609, 630.6783540394385, 631.9778807741753, 632.7943418389042, 13051.412686429134, 13082.803757943639, 13088.41102150396, 13108.672283192902, 13114.540991065362, 11931.642050738492, 11938.403079845973, 12298.385080745928, 12523.56167534132, 12532.686682832911, 9885.555150018194, 9926.702198934043, 9926.751831204278, 9950.203983681287, 10013.449260290681, 3303.3888730584918, 3321.70104690579, 3368.4778859276853, 3394.2532642818787, 3429.4855771634207, 44811.551884481065, 44983.77508112471, 45146.645600632364, 45500.3174952376, 45600.0, 9509.191718703849, 9719.854202186973, 9729.79414305722, 9768.072033156981, 9795.755106122404, 16731.07979061139, 16908.239129239213, 16925.0, 16946.915265423595, 16969.321227150776, 6755.22314933779, 6792.864142717118, 6866.210385805596, 6878.415334696607, 7016.543924644881, 3866.4973553438435, 3912.941305880414, 3925.116848709075, 3969.960300397017, 4007.699422543321, 2893.2911436698146, 2950.439416510856, 2952.025831475608, 2963.6295463067117, 2964.2589352661835, 449.3394709776623, 503.33308366414644, 512.1523877981946, 518.245952139636, 519.1045446604652, 548.314606741573, 550.4385526762679, 626.8902941985134, 649.4285029174391, 666.5434177588368, 7839.412044096715, 8222.917770822216, 8466.830663386698, 8552.144785521523, 8632.525211113449, 581.7062383496392, 584.590786449487, 586.524914818998, 586.9501092407107, 625.6308777821107, 4007.499062617173, 4019.3569028955226, 4066.0, 4104.774237416971, 4172.082141928831, 46116.7694161527, 47721.76139119282, 54521.18218226651, 54616.45383546193, 54980.72509637506, 39953.60046399557, 41029.0, 41893.58106418958, 42380.788096059936, 42790.358144627855, 36662.29236626358, 37087.62912370896, 37352.0, 38526.6147338523, 39018.41472377917, 8125.8374832504205, 8328.500289982621, 8544.0, 8554.828903422022, 8636.568171591522, 26827.73172268252, 27204.047858324862, 27710.44579108447, 28261.01086461964, 28292.86828526836, 34694.13264668303, 37027.25945481129, 37078.0, 37502.249955001294, 37582.43626345662, 10725.249232553646, 10882.238243322892, 10897.618583349546, 10994.890051099386, 11039.834402483808, 11466.31202127875, 11577.710557236136, 11669.35818529989, 11875.821862671894, 12019.278843269432, 11364.31814091124, 11914.463849126636, 11941.64175074749, 11961.820572691591, 11964.0, 11105.555777768799, 11155.49800258974, 11882.108841836724, 11952.402379881145, 11957.581484648343, 11114.555417783198, 11153.776924461303, 11728.061755059403, 11744.647660570197, 11795.056395488169, 9572.56923438433, 9832.754181145528, 9862.063104005108, 9931.404115753077, 10097.0, 9589.938163294924, 9726.173275271682, 9790.265730070416, 9856.0, 9926.553305101432], "value": 6024.132031799736, "unit": "score"}], "name": "dromaeo_css", "value": 6431.9891442240005, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 113.0, 108.0, 113.0, 114.0, 113.0, 105.0, 114.0, 113.0, 115.0], "value": 111.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 132.0, 157.0, 193.0, 134.0, 161.0, 158.0, 132.0, 195.0, 133.0], "value": 156.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 161.0, 162.0, 162.0, 162.0, 162.0, 161.0, 161.0, 161.0], "value": 161.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 74.0, 107.0, 114.0, 76.0, 76.0, 73.0, 121.0, 102.0, 74.0], "value": 89.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 93.0, 141.0, 94.0, 95.0, 95.0, 137.0, 93.0, 94.0, 144.0], "value": 108.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 116.0, 117.0, 117.0, 119.0, 117.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 146.0, 146.0, 145.0, 145.0, 146.0, 145.0, 145.0, 145.0, 145.0], "value": 145.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 95.0, 94.0, 94.0, 95.0, 95.0, 95.0, 94.0], "value": 94.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 66.0, 67.0, 66.0, 65.0, 67.0, 89.0, 64.0, 66.0], "value": 68.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 63.0, 65.0, 65.0, 64.0, 64.0, 64.0, 65.0, 64.0], "value": 64.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 78.0, 78.0, 77.0, 80.0, 87.0, 81.0, 89.0, 80.0, 79.0], "value": 80.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 136.0, 143.0, 132.0, 131.0, 129.0, 130.0, 137.0, 178.0, 132.0], "value": 138.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 177.0, 172.0, 177.0, 170.0, 169.0, 188.0, 168.0, 171.0, 183.0], "value": 175.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 72.0, 71.0, 72.0, 72.0, 73.0, 72.0, 73.0, 72.0, 71.0], "value": 72.1, "unit": "score"}], "name": "kraken", "value": 1582.3, "alertThreshold": 2.0}]} 23:15:09 INFO - Return code: 0 23:15:09 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 23:15:09 ERROR - # TBPL SUCCESS # 23:15:09 INFO - Running post-action listener: _resource_record_post_action 23:15:09 INFO - Running post-run listener: _resource_record_post_run 23:15:10 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 0; Write bytes: 527323136; Read time: 0; Write time: 671840 23:15:10 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 244654080; Read time: 0; Write time: 406796 23:15:10 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 0; Write bytes: 282607616; Read time: 0; Write time: 265044 23:15:10 INFO - Running post-run listener: _upload_blobber_files 23:15:10 INFO - Blob upload gear active. 23:15:10 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 23:15:10 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 23:15:10 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'] 23:15:10 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 23:15:10 INFO - (blobuploader) - INFO - Open directory for files ... 23:15:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 23:15:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:15:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:15:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 23:15:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:15:11 INFO - (blobuploader) - INFO - Done attempting. 23:15:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 23:15:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:15:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:15:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 23:15:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:15:12 INFO - (blobuploader) - INFO - Done attempting. 23:15:12 INFO - (blobuploader) - INFO - Iteration through files over. 23:15:12 INFO - Return code: 0 23:15:12 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 23:15:12 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 23:15:12 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d506968ed0f5467d958e4521bec5388198d857d2fce65a285a7a402fd096facbe10373dc47aec185f73c5cca42f0d4b3141cb16c4946d5762d769fb7afad6a03", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f2997cb8e905ad145c567db79d2a44c940cf6a113609929d5aca6fa761b11aa58311040e7b3d8a4a1c4ff680cd51669c6335b4335bdfba9c75d574bedeb08838"} 23:15:12 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 23:15:12 INFO - Writing to file /builds/slave/test/properties/blobber_files 23:15:12 INFO - Contents: 23:15:12 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d506968ed0f5467d958e4521bec5388198d857d2fce65a285a7a402fd096facbe10373dc47aec185f73c5cca42f0d4b3141cb16c4946d5762d769fb7afad6a03", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f2997cb8e905ad145c567db79d2a44c940cf6a113609929d5aca6fa761b11aa58311040e7b3d8a4a1c4ff680cd51669c6335b4335bdfba9c75d574bedeb08838"} 23:15:12 INFO - Running post-run listener: copy_logs_to_upload_dir 23:15:12 INFO - Copying logs to upload dir... 23:15:12 INFO - mkdir: /builds/slave/test/build/upload/logs 23:15:12 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.941406 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-04-23 23:15:12.110319) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-23 23:15:12.113318) ========= 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=62c568580acbfdaac3eec7be000001dc-1461477200.728732-1341828549 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/d506968ed0f5467d958e4521bec5388198d857d2fce65a285a7a402fd096facbe10373dc47aec185f73c5cca42f0d4b3141cb16c4946d5762d769fb7afad6a03", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f2997cb8e905ad145c567db79d2a44c940cf6a113609929d5aca6fa761b11aa58311040e7b3d8a4a1c4ff680cd51669c6335b4335bdfba9c75d574bedeb08838"} build_url:https://queue.taskcluster.net/v1/task/f6WITnP9SIGtvgkwW8lo3g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011189 build_url: 'https://queue.taskcluster.net/v1/task/f6WITnP9SIGtvgkwW8lo3g/artifacts/public/build/firefox-48.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/d506968ed0f5467d958e4521bec5388198d857d2fce65a285a7a402fd096facbe10373dc47aec185f73c5cca42f0d4b3141cb16c4946d5762d769fb7afad6a03", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f2997cb8e905ad145c567db79d2a44c940cf6a113609929d5aca6fa761b11aa58311040e7b3d8a4a1c4ff680cd51669c6335b4335bdfba9c75d574bedeb08838"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-23 23:15:12.136992) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-23 23:15:12.137266) ========= 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=62c568580acbfdaac3eec7be000001dc-1461477200.728732-1341828549 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004482 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-23 23:15:12.220462) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-23 23:15:12.220749) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-23 23:15:12.221017) ========= ========= Total master_lag: 0.17 =========